"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/07/01 03:32:04 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-qiqoxez5hewi" 2025/07/01 03:32:04 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/01 03:32:04 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/01 03:32:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:04 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{CScN3}" suffix to name 2025/07/01 03:32:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:04 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: Connecting to FTP server 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:21") 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:39112->172.17.0.3:21, err= 2025/07/01 03:32:04 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/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:29431") 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:52338->172.17.0.3:29431, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:36566") 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:44594->172.17.0.3:36566, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/07/01 03:32:04 INFO : dir/subdir: Making directory 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:11261") 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:57308->172.17.0.3:11261, err= 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:24728") 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:35252->172.17.0.3:24728, err= 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:50256") 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:41206->172.17.0.3:50256, err= 2025/07/01 03:32:04 INFO : dir/subdir: Removing directory 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:8435") 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:44996->172.17.0.3:8435, err= 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:63660") 2025/07/01 03:32:04 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:52132->172.17.0.3:63660, err= 2025/07/01 03:32:05 INFO : dir: Removing directory 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:49392") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:43254->172.17.0.3:49392, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:56264") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:45378->172.17.0.3:56264, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:32117") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:58936->172.17.0.3:32117, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:23165") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:33882->172.17.0.3:23165, err= 2025/07/01 03:32:05 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/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:45905") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:50478->172.17.0.3:45905, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:13162") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:50888->172.17.0.3:13162, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:1691") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:45720->172.17.0.3:1691, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:32934") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:52488->172.17.0.3:32934, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:47440") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:38290->172.17.0.3:47440, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:11615") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:37614->172.17.0.3:11615, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:11371") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:35340->172.17.0.3:11371, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:48672") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:49886->172.17.0.3:48672, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:7125") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:36898->172.17.0.3:7125, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:54019") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:53980->172.17.0.3:54019, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:11357") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:54450->172.17.0.3:11357, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:48917") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:52942->172.17.0.3:48917, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:28943") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:58598->172.17.0.3:28943, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:42031") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:50884->172.17.0.3:42031, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:9288") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:41358->172.17.0.3:9288, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:38987") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:42534->172.17.0.3:38987, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:4049") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:37008->172.17.0.3:4049, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:53385") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:54838->172.17.0.3:53385, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:53498") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:60788->172.17.0.3:53498, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:48864") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:51860->172.17.0.3:48864, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:17282") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:57536->172.17.0.3:17282, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:24530") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:50594->172.17.0.3:24530, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:59101") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:57960->172.17.0.3:59101, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:40986") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:44066->172.17.0.3:40986, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:9252") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:34444->172.17.0.3:9252, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:2001") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:54254->172.17.0.3:2001, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:39112") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:43286->172.17.0.3:39112, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:57620") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:40862->172.17.0.3:57620, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:57242") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:42920->172.17.0.3:57242, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:5695") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:37732->172.17.0.3:5695, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:15250") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:60286->172.17.0.3:15250, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:37612") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:41134->172.17.0.3:37612, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:17833") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:36760->172.17.0.3:17833, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:15917") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:38970->172.17.0.3:15917, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:5012") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:38066->172.17.0.3:5012, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:64250") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:42160->172.17.0.3:64250, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:26509") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:43614->172.17.0.3:26509, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:15359") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:37282->172.17.0.3:15359, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:47388") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:43888->172.17.0.3:47388, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:32610") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:52628->172.17.0.3:32610, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:3844") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:42410->172.17.0.3:3844, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:57722") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:54910->172.17.0.3:57722, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:15993") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:56952->172.17.0.3:15993, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:31763") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:45304->172.17.0.3:31763, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:34218") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:59068->172.17.0.3:34218, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:24257") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:54326->172.17.0.3:24257, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:5216") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:34638->172.17.0.3:5216, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:37244") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:58194->172.17.0.3:37244, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:12108") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:33066->172.17.0.3:12108, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:57691") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:42306->172.17.0.3:57691, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:20573") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:59024->172.17.0.3:20573, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:28366") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:48916->172.17.0.3:28366, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:16686") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:47162->172.17.0.3:16686, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:14140") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:38734->172.17.0.3:14140, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:3818") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:37364->172.17.0.3:3818, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:24914") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:54752->172.17.0.3:24914, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:15117") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:58430->172.17.0.3:15117, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:41906") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:42768->172.17.0.3:41906, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:17000") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:36314->172.17.0.3:17000, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:6825") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:46154->172.17.0.3:6825, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:46578") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:59466->172.17.0.3:46578, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:31226") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:36826->172.17.0.3:31226, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:43413") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:35988->172.17.0.3:43413, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:63387") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:47228->172.17.0.3:63387, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:46120") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:49212->172.17.0.3:46120, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:47402") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:55028->172.17.0.3:47402, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:62103") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:33704->172.17.0.3:62103, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:7094") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:36626->172.17.0.3:7094, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:61738") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:53550->172.17.0.3:61738, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:43956") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:51886->172.17.0.3:43956, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:38681") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:45554->172.17.0.3:38681, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:64559") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:46458->172.17.0.3:64559, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:36143") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:44154->172.17.0.3:36143, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:53650") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:40652->172.17.0.3:53650, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:30788") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:46764->172.17.0.3:30788, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:4827") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:60052->172.17.0.3:4827, err= 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:12373") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:49608->172.17.0.3:12373, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:34980") 2025/07/01 03:32:05 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:53812->172.17.0.3:34980, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: Connecting to FTP server 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:21") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:39118->172.17.0.3:21, err= 2025/07/01 03:32:06 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:46938") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:60118->172.17.0.3:46938, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:27637") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:57156->172.17.0.3:27637, 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/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:35081") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:47402->172.17.0.3:35081, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:45498") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:60356->172.17.0.3:45498, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:53800") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:58344->172.17.0.3:53800, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:9296") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:60692->172.17.0.3:9296, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:54413") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:52262->172.17.0.3:54413, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:11116") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:57044->172.17.0.3:11116, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:50109") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:35964->172.17.0.3:50109, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:2902") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:53798->172.17.0.3:2902, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:60924") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:54942->172.17.0.3:60924, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:44100") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:44934->172.17.0.3:44100, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:33475") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:46388->172.17.0.3:33475, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:31842") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:37174->172.17.0.3:31842, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:63980") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:60674->172.17.0.3:63980, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:26924") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:51696->172.17.0.3:26924, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:42467") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:40716->172.17.0.3:42467, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:40921") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:38616->172.17.0.3:40921, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:30246") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:40998->172.17.0.3:30246, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/07/01 03:32:06 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/07/01 03:32:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/01 03:32:06 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:06 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{CScN3}" suffix to name 2025/07/01 03:32:06 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:06 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:39124->172.17.0.3:21, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:61451") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:43314->172.17.0.3:61451, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:37258") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:56592->172.17.0.3:37258, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:40644") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:55338->172.17.0.3:40644, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:54274") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:59052->172.17.0.3:54274, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:32263") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:33174->172.17.0.3:32263, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:22704") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:57950->172.17.0.3:22704, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:50768") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:39204->172.17.0.3:50768, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:49301") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:54834->172.17.0.3:49301, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:44077") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:47848->172.17.0.3:44077, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:30935") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:53182->172.17.0.3:30935, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:52765") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:58108->172.17.0.3:52765, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:17021") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:51562->172.17.0.3:17021, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:54415") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:40196->172.17.0.3:54415, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:34168") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:40842->172.17.0.3:34168, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:43634") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:50110->172.17.0.3:43634, 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/01 03:32:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-qiqoxez5hewi/hello? sausage/êé" 2025/07/01 03:32:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/01 03:32:06 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:06 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{CScN3}" suffix to name 2025/07/01 03:32:06 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:06 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: Connecting to FTP server 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:39138->172.17.0.3:21, err= 2025/07/01 03:32:06 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-qiqoxez5hewi/hello? sausage/êé" to be canonical "TestFTPProftpd{CScN3}:rclone-test-qiqoxez5hewi/hello? sausage/êé" 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:12311") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:44762->172.17.0.3:12311, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:65481") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:57076->172.17.0.3:65481, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: Connecting to FTP server 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:39154->172.17.0.3:21, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:53228") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:51352->172.17.0.3:53228, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:58743") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:40806->172.17.0.3:58743, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:8563") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:47310->172.17.0.3:8563, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:19009") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:44336->172.17.0.3:19009, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:63524") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:51974->172.17.0.3:63524, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:53183") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:55094->172.17.0.3:53183, err= 2025/07/01 03:32:06 DEBUG : Waiting for deletions to finish 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:7377") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:44100->172.17.0.3:7377, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:29499") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:39196->172.17.0.3:29499, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:40559") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:57616->172.17.0.3:40559, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:30127") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:49820->172.17.0.3:30127, err= 2025/07/01 03:32:06 INFO : a/b/c/d/e.txt: Deleted 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:43042") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:60590->172.17.0.3:43042, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:56713") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:59558->172.17.0.3:56713, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:11787") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:46462->172.17.0.3:11787, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: dial("tcp","172.17.0.3:37138") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé: > dial: conn=172.17.0.1:55204->172.17.0.3:37138, err= 2025/07/01 03:32:06 DEBUG : removing 1 level 4 directories 2025/07/01 03:32:06 INFO : a/b/c/d: Removing directory 2025/07/01 03:32:06 DEBUG : removing 1 level 3 directories 2025/07/01 03:32:06 INFO : a/b/c: Removing directory 2025/07/01 03:32:06 DEBUG : removing 1 level 2 directories 2025/07/01 03:32:06 INFO : a/b: Removing directory 2025/07/01 03:32:06 DEBUG : removing 1 level 1 directories 2025/07/01 03:32:06 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:23961") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:51870->172.17.0.3:23961, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:14131") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:33912->172.17.0.3:14131, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:31899") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:40516->172.17.0.3:31899, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:32234") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:47252->172.17.0.3:32234, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:3010") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:34762->172.17.0.3:3010, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:41992") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:33934->172.17.0.3:41992, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: Connecting to FTP server 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:21") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:39164->172.17.0.3:21, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:16808") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:33128->172.17.0.3:16808, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:17761") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:52020->172.17.0.3:17761, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:4889") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:43508->172.17.0.3:4889, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:32388") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:58690->172.17.0.3:32388, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:37382") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:50038->172.17.0.3:37382, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:30804") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:40894->172.17.0.3:30804, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:59884") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:57208->172.17.0.3:59884, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:4082") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:57512->172.17.0.3:4082, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:37341") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:46350->172.17.0.3:37341, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:32548") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:58124->172.17.0.3:32548, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:3689") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:52272->172.17.0.3:3689, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:5517") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:56676->172.17.0.3:5517, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:9814") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:58144->172.17.0.3:9814, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:58330") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:45034->172.17.0.3:58330, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:63241") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:43984->172.17.0.3:63241, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:35301") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:41672->172.17.0.3:35301, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:45132") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:45796->172.17.0.3:45132, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/07/01 03:32:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-guxomuq9maru" 2025/07/01 03:32:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/01 03:32:06 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:06 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{CScN3}" suffix to name 2025/07/01 03:32:06 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:06 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: Connecting to FTP server 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: dial("tcp","172.17.0.3:21") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: > dial: conn=172.17.0.1:39166->172.17.0.3:21, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:35264") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:53968->172.17.0.3:35264, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: dial("tcp","172.17.0.3:47957") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: > dial: conn=172.17.0.1:42946->172.17.0.3:47957, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: dial("tcp","172.17.0.3:18658") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: > dial: conn=172.17.0.1:46306->172.17.0.3:18658, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: dial("tcp","172.17.0.3:44827") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: > dial: conn=172.17.0.1:44610->172.17.0.3:44827, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: dial("tcp","172.17.0.3:38447") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: > dial: conn=172.17.0.1:56154->172.17.0.3:38447, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: dial("tcp","172.17.0.3:57416") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: > dial: conn=172.17.0.1:45986->172.17.0.3:57416, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: dial("tcp","172.17.0.3:7083") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: > dial: conn=172.17.0.1:38662->172.17.0.3:7083, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: dial("tcp","172.17.0.3:13326") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: > dial: conn=172.17.0.1:43108->172.17.0.3:13326, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:33716") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:33532->172.17.0.3:33716, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:12137") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:37384->172.17.0.3:12137, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:27953") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:48152->172.17.0.3:27953, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:38079") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:52020->172.17.0.3:38079, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:16856") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:46946->172.17.0.3:16856, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: dial("tcp","172.17.0.3:18272") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: > dial: conn=172.17.0.1:48848->172.17.0.3:18272, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: dial("tcp","172.17.0.3:35562") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: > dial: conn=172.17.0.1:49296->172.17.0.3:35562, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: dial("tcp","172.17.0.3:31461") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: > dial: conn=172.17.0.1:52452->172.17.0.3:31461, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: dial("tcp","172.17.0.3:45207") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: > dial: conn=172.17.0.1:54586->172.17.0.3:45207, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: Purge dir "new_name" 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-guxomuq9maru: 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/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:31453") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:38772->172.17.0.3:31453, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:28194") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:44696->172.17.0.3:28194, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:54507") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:33108->172.17.0.3:54507, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:8826") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:50748->172.17.0.3:8826, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:44933") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:56962->172.17.0.3:44933, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:16693") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:44622->172.17.0.3:16693, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:48096") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:49492->172.17.0.3:48096, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:30506") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:38812->172.17.0.3:30506, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:1927") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:42236->172.17.0.3:1927, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/07/01 03:32:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-qiqoxez5hewi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/07/01 03:32:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/01 03:32:06 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:06 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{CScN3}" suffix to name 2025/07/01 03:32:06 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:06 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:21") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:39170->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:2778") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:46376->172.17.0.3:2778, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/07/01 03:32:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-qiqoxez5hewi/not found.txt" 2025/07/01 03:32:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/01 03:32:06 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:06 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{CScN3}" suffix to name 2025/07/01 03:32:06 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:06 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/not found.txt: Connecting to FTP server 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/not found.txt: dial("tcp","172.17.0.3:21") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/not found.txt: > dial: conn=172.17.0.1:39176->172.17.0.3:21, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/not found.txt: dial("tcp","172.17.0.3:27131") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/not found.txt: > dial: conn=172.17.0.1:46728->172.17.0.3:27131, err= 2025/07/01 03:32:06 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-qiqoxez5hewi" from "TestFTPProftpd:rclone-test-qiqoxez5hewi" 2025/07/01 03:32:06 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/07/01 03:32:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/01 03:32:06 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:06 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{CScN3}" suffix to name 2025/07/01 03:32:06 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:06 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:39184->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:19414") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56080->172.17.0.3:19414, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:55602") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:39236->172.17.0.3:55602, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:7846") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:54858->172.17.0.3:7846, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:60047") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:38832->172.17.0.3:60047, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:60060") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56120->172.17.0.3:60060, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:39995") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:38126->172.17.0.3:39995, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:35480") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:33928->172.17.0.3:35480, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:13888") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56168->172.17.0.3:13888, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:25550") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:48342->172.17.0.3:25550, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:27307") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56322->172.17.0.3:27307, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:11791") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:60252->172.17.0.3:11791, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:43466") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:45024->172.17.0.3:43466, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:50977") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:52276->172.17.0.3:50977, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:14562") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:50684->172.17.0.3:14562, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:37419") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:47530->172.17.0.3:37419, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:43094") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:37372->172.17.0.3:43094, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:62155") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:60606->172.17.0.3:62155, 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/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:21696") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:42216->172.17.0.3:21696, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:31863") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:44008->172.17.0.3:31863, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:52060") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:36440->172.17.0.3:52060, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:9048") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:52548->172.17.0.3:9048, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:47386") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:56934->172.17.0.3:47386, 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/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:61544") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:57164->172.17.0.3:61544, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:31838") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:54632->172.17.0.3:31838, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/07/01 03:32:06 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-qiqoxez5hewi" 2025/07/01 03:32:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/01 03:32:06 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:06 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{ceLUz}" suffix to name 2025/07/01 03:32:06 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:06 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: Connecting to FTP server 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:21") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:39192->172.17.0.3:21, err= 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:38099") 2025/07/01 03:32:06 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:49626->172.17.0.3:38099, 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/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:33134") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:39272->172.17.0.3:33134, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:15464") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:41228->172.17.0.3:15464, err= 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:19093") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:60020->172.17.0.3:19093, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/07/01 03:32:07 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-qiqoxez5hewi/deeper/nonexisting/directory" 2025/07/01 03:32:07 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/01 03:32:07 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:07 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:07 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:07 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:07 DEBUG : TestFTPProftpd: detected overridden config - adding "{CScN3}" suffix to name 2025/07/01 03:32:07 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/01 03:32:07 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/01 03:32:07 DEBUG : Setting pass="ks8C1Tt-H5OLNFmBPTRnYnWfn_CTljHHCThVO1iH2QKeRQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/01 03:32:07 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/deeper/nonexisting/directory: Connecting to FTP server 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/deeper/nonexisting/directory: dial("tcp","172.17.0.3:21") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi/deeper/nonexisting/directory: > dial: conn=172.17.0.1:39198->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/07/01 03:32:07 DEBUG : Waiting for deletions to finish 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:51058") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:55054->172.17.0.3:51058, err= 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:25046") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:60084->172.17.0.3:25046, err= 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:7348") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:51298->172.17.0.3:7348, err= 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:20718") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:38534->172.17.0.3:20718, err= 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:3723") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:45284->172.17.0.3:3723, err= 2025/07/01 03:32:07 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:52237") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:47980->172.17.0.3:52237, err= 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:34420") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:59626->172.17.0.3:34420, err= 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:3145") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:49316->172.17.0.3:3145, err= 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:34556") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:33218->172.17.0.3:34556, err= 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:43656") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:44860->172.17.0.3:43656, err= 2025/07/01 03:32:07 DEBUG : removing 1 level 4 directories 2025/07/01 03:32:07 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/07/01 03:32:07 DEBUG : removing 1 level 3 directories 2025/07/01 03:32:07 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/07/01 03:32:07 DEBUG : removing 1 level 2 directories 2025/07/01 03:32:07 INFO : hello? sausage/êé: Removing directory 2025/07/01 03:32:07 DEBUG : removing 1 level 1 directories 2025/07/01 03:32:07 INFO : hello? sausage: Removing directory 2025/07/01 03:32:07 DEBUG : removing 1 level 0 directories 2025/07/01 03:32:07 INFO : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: Removing directory 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:65345") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:38150->172.17.0.3:65345, err= 2025/07/01 03:32:07 ERROR : error listing: directory not found 2025/07/01 03:32:07 DEBUG : Waiting for deletions to finish 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:48058") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:48258->172.17.0.3:48058, err= 2025/07/01 03:32:07 ERROR : error listing: directory not found 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: dial("tcp","172.17.0.3:34021") 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: > dial: conn=172.17.0.1:46514->172.17.0.3:34021, err= 2025/07/01 03:32:07 ERROR : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: Failed to list "": directory not found 2025/07/01 03:32:07 DEBUG : removing 1 level 0 directories 2025/07/01 03:32:07 INFO : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: Removing directory 2025/07/01 03:32:07 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/07/01 03:32:07 DEBUG : ftp://172.17.0.3:21/rclone-test-qiqoxez5hewi: closing 2 unused connections --- PASS: TestIntegration (2.92s) --- 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.85s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.02s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.01s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.27s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.02s) --- 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.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.03s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.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.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.84s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.84s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 2.942s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 3.882736118s (try 1/5)