"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/11/09 01:29:10 NOTICE: TestFTPProftpd: Starting server 2025/11/09 01:29:11 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.2:21" try 1/100 2025/11/09 01:29:11 DEBUG : TestFTPProftpd: Read 1, error: 2025/11/09 01:29:11 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.2:21" 2025/11/09 01:29:11 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zujaqir9siqu" 2025/11/09 01:29:11 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/11/09 01:29:11 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/09 01:29:11 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:11 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:11 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:11 DEBUG : TestFTPProftpd: detected overridden config - adding "{WExNO}" suffix to name 2025/11/09 01:29:11 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:11 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:11 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: Connecting to FTP server 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:21") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:43952->172.17.0.2:21, err= 2025/11/09 01:29:11 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/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:64369") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:44646->172.17.0.2:64369, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:26865") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:46522->172.17.0.2:26865, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/11/09 01:29:11 INFO : dir/subdir: Making directory 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:46800") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:51506->172.17.0.2:46800, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:31523") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:43912->172.17.0.2:31523, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:11281") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:56444->172.17.0.2:11281, err= 2025/11/09 01:29:11 INFO : dir/subdir: Removing directory 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:57337") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:56702->172.17.0.2:57337, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:30940") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:37696->172.17.0.2:30940, err= 2025/11/09 01:29:11 INFO : dir: Removing directory 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:49837") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:52272->172.17.0.2:49837, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:33330") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:34638->172.17.0.2:33330, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:13730") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:33000->172.17.0.2:13730, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:22540") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:40384->172.17.0.2:22540, err= 2025/11/09 01:29:11 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/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:40507") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:41214->172.17.0.2:40507, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:40296") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:54322->172.17.0.2:40296, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:58014") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:56414->172.17.0.2:58014, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:21482") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:49710->172.17.0.2:21482, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:27477") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:45380->172.17.0.2:27477, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:2188") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:55882->172.17.0.2:2188, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:45992") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:57218->172.17.0.2:45992, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:23140") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:43800->172.17.0.2:23140, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:54186") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:51068->172.17.0.2:54186, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:59553") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:53808->172.17.0.2:59553, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:2272") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:49124->172.17.0.2:2272, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:48258") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:36004->172.17.0.2:48258, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:3950") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:60178->172.17.0.2:3950, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:42712") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:40756->172.17.0.2:42712, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:38476") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:39246->172.17.0.2:38476, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:31941") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:57144->172.17.0.2:31941, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:54678") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:38562->172.17.0.2:54678, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:38239") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:54822->172.17.0.2:38239, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:9698") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:56732->172.17.0.2:9698, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:52493") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:59560->172.17.0.2:52493, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:37073") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:57960->172.17.0.2:37073, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:35540") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:39674->172.17.0.2:35540, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:33758") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:43936->172.17.0.2:33758, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:3061") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:39806->172.17.0.2:3061, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:45797") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:44300->172.17.0.2:45797, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:25561") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:49344->172.17.0.2:25561, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:32978") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:49412->172.17.0.2:32978, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:30099") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:36100->172.17.0.2:30099, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:57867") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:33510->172.17.0.2:57867, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:45684") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:33892->172.17.0.2:45684, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:51616") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:46400->172.17.0.2:51616, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:32840") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:43816->172.17.0.2:32840, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:20445") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:47314->172.17.0.2:20445, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:44095") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:41518->172.17.0.2:44095, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:53298") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:43338->172.17.0.2:53298, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:46898") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:40234->172.17.0.2:46898, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:45260") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:36454->172.17.0.2:45260, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:33755") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:43308->172.17.0.2:33755, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:4504") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:51772->172.17.0.2:4504, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:33911") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:49446->172.17.0.2:33911, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:27774") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:56620->172.17.0.2:27774, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:5752") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:53618->172.17.0.2:5752, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:16635") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:52172->172.17.0.2:16635, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:30700") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:41848->172.17.0.2:30700, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:47440") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:50352->172.17.0.2:47440, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:54087") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:35376->172.17.0.2:54087, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:61618") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:53392->172.17.0.2:61618, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:36584") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:58302->172.17.0.2:36584, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:26791") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:39352->172.17.0.2:26791, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:5781") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:58440->172.17.0.2:5781, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:23542") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:52706->172.17.0.2:23542, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:62841") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:52010->172.17.0.2:62841, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:40298") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:53628->172.17.0.2:40298, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:56277") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:41678->172.17.0.2:56277, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:64879") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:47482->172.17.0.2:64879, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:20560") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:60796->172.17.0.2:20560, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:16303") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:33512->172.17.0.2:16303, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:32322") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:46122->172.17.0.2:32322, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:49636") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:53878->172.17.0.2:49636, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:8636") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:56486->172.17.0.2:8636, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:12471") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:33038->172.17.0.2:12471, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:35717") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:42212->172.17.0.2:35717, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:40452") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:58928->172.17.0.2:40452, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:31893") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:34322->172.17.0.2:31893, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:14278") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:45216->172.17.0.2:14278, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:28216") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:34704->172.17.0.2:28216, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:13256") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:56140->172.17.0.2:13256, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:58514") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:48550->172.17.0.2:58514, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:60948") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:50944->172.17.0.2:60948, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:16737") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:47174->172.17.0.2:16737, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:26891") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:48242->172.17.0.2:26891, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:23187") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:33824->172.17.0.2:23187, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:21466") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:52604->172.17.0.2:21466, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:42502") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:47436->172.17.0.2:42502, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:52863") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:60978->172.17.0.2:52863, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:3371") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:53880->172.17.0.2:3371, err= 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:31054") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:51054->172.17.0.2:31054, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:48947") 2025/11/09 01:29:11 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:42106->172.17.0.2:48947, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: Connecting to FTP server 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:21") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:43984->172.17.0.2:21, err= 2025/11/09 01:29:12 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:59126") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:41718->172.17.0.2:59126, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:25958") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:50494->172.17.0.2:25958, 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/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:52039") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:56906->172.17.0.2:52039, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:58119") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:51574->172.17.0.2:58119, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:7122") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:56566->172.17.0.2:7122, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:22659") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:59538->172.17.0.2:22659, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:64533") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:44088->172.17.0.2:64533, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:37519") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:33558->172.17.0.2:37519, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:21494") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:47410->172.17.0.2:21494, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:63123") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:48050->172.17.0.2:63123, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:25037") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:44432->172.17.0.2:25037, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:51582") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:54402->172.17.0.2:51582, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:2213") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:33206->172.17.0.2:2213, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:55285") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:45006->172.17.0.2:55285, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:18188") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:51878->172.17.0.2:18188, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:16194") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:58108->172.17.0.2:16194, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:26641") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:53344->172.17.0.2:26641, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:16915") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:37860->172.17.0.2:16915, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:13016") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:60566->172.17.0.2:13016, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/11/09 01:29:12 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/11/09 01:29:12 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/09 01:29:12 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:12 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:12 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:12 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:12 DEBUG : TestFTPProftpd: detected overridden config - adding "{WExNO}" suffix to name 2025/11/09 01:29:12 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:12 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:12 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:12 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:43994->172.17.0.2:21, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:60628") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:43200->172.17.0.2:60628, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:1210") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:46402->172.17.0.2:1210, err= 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:5553") 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:33426->172.17.0.2:5553, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/11/09 01:29:12 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:60981") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:40120->172.17.0.2:60981, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:54543") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:57416->172.17.0.2:54543, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:7805") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:42434->172.17.0.2:7805, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:38594") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:37532->172.17.0.2:38594, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:50105") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:36042->172.17.0.2:50105, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:15850") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:54870->172.17.0.2:15850, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:42006") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:58270->172.17.0.2:42006, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:42620") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:57540->172.17.0.2:42620, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:56863") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:46130->172.17.0.2:56863, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:9053") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:54968->172.17.0.2:9053, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:36211") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:43088->172.17.0.2:36211, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:17286") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:53990->172.17.0.2:17286, 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/11/09 01:29:13 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zujaqir9siqu/hello? sausage/êé" 2025/11/09 01:29:13 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/09 01:29:13 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:13 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:13 DEBUG : TestFTPProftpd: detected overridden config - adding "{WExNO}" suffix to name 2025/11/09 01:29:13 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:13 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: Connecting to FTP server 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:44004->172.17.0.2:21, err= 2025/11/09 01:29:13 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-zujaqir9siqu/hello? sausage/êé" to be canonical "TestFTPProftpd{WExNO}:rclone-test-zujaqir9siqu/hello? sausage/êé" 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:61772") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:58370->172.17.0.2:61772, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:8214") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:33210->172.17.0.2:8214, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: Connecting to FTP server 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:44020->172.17.0.2:21, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:22722") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:52718->172.17.0.2:22722, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:2091") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:42654->172.17.0.2:2091, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:41018") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:45562->172.17.0.2:41018, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:30037") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:39870->172.17.0.2:30037, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:10633") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:34116->172.17.0.2:10633, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:21089") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:51554->172.17.0.2:21089, err= 2025/11/09 01:29:13 DEBUG : Waiting for deletions to finish 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:57801") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:60640->172.17.0.2:57801, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:49751") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:33942->172.17.0.2:49751, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:25622") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:45484->172.17.0.2:25622, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:22942") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:38938->172.17.0.2:22942, err= 2025/11/09 01:29:13 INFO : a/b/c/d/e.txt: Deleted 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:35357") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:48980->172.17.0.2:35357, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:55575") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:51386->172.17.0.2:55575, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:14987") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:39746->172.17.0.2:14987, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: dial("tcp","172.17.0.2:32859") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé: > dial: conn=172.17.0.1:54144->172.17.0.2:32859, err= 2025/11/09 01:29:13 DEBUG : removing 1 level 4 directories 2025/11/09 01:29:13 INFO : a/b/c/d: Removing directory 2025/11/09 01:29:13 DEBUG : removing 1 level 3 directories 2025/11/09 01:29:13 INFO : a/b/c: Removing directory 2025/11/09 01:29:13 DEBUG : removing 1 level 2 directories 2025/11/09 01:29:13 INFO : a/b: Removing directory 2025/11/09 01:29:13 DEBUG : removing 1 level 1 directories 2025/11/09 01:29:13 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:60068") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:35612->172.17.0.2:60068, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:28795") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:37866->172.17.0.2:28795, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:23384") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:55172->172.17.0.2:23384, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:17193") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:54068->172.17.0.2:17193, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:27793") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:52274->172.17.0.2:27793, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:59880") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:47236->172.17.0.2:59880, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: Connecting to FTP server 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:21") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:44036->172.17.0.2:21, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:37664") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:34678->172.17.0.2:37664, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:50015") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:50072->172.17.0.2:50015, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:25381") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:37908->172.17.0.2:25381, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:32852") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:47480->172.17.0.2:32852, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:19383") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:55488->172.17.0.2:19383, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:36491") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:39360->172.17.0.2:36491, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:23711") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:39368->172.17.0.2:23711, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:39145") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:48330->172.17.0.2:39145, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:26571") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:35336->172.17.0.2:26571, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:4210") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:54744->172.17.0.2:4210, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:9134") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:37448->172.17.0.2:9134, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:15828") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:54714->172.17.0.2:15828, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:40876") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:38772") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:36472->172.17.0.2:38772, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:40500->172.17.0.2:40876, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:37672") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:54606->172.17.0.2:37672, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:41741") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:47980->172.17.0.2:41741, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:5601") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:37500->172.17.0.2:5601, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/11/09 01:29:13 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-qemamos7vimo" 2025/11/09 01:29:13 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/09 01:29:13 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:13 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:13 DEBUG : TestFTPProftpd: detected overridden config - adding "{WExNO}" suffix to name 2025/11/09 01:29:13 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:13 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: Connecting to FTP server 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: dial("tcp","172.17.0.2:21") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: > dial: conn=172.17.0.1:44042->172.17.0.2:21, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:34752") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:36566->172.17.0.2:34752, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: dial("tcp","172.17.0.2:6376") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: > dial: conn=172.17.0.1:50792->172.17.0.2:6376, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: dial("tcp","172.17.0.2:28894") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: > dial: conn=172.17.0.1:58148->172.17.0.2:28894, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: dial("tcp","172.17.0.2:53959") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: > dial: conn=172.17.0.1:35518->172.17.0.2:53959, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: dial("tcp","172.17.0.2:51686") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: > dial: conn=172.17.0.1:54700->172.17.0.2:51686, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: dial("tcp","172.17.0.2:17107") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: > dial: conn=172.17.0.1:60066->172.17.0.2:17107, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: dial("tcp","172.17.0.2:17412") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: > dial: conn=172.17.0.1:49184->172.17.0.2:17412, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: dial("tcp","172.17.0.2:33943") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: > dial: conn=172.17.0.1:41636->172.17.0.2:33943, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:58788") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:51402->172.17.0.2:58788, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:56767") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:54914->172.17.0.2:56767, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:61532") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:37482->172.17.0.2:61532, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:53734") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:43798->172.17.0.2:53734, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:59190") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:46614->172.17.0.2:59190, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: dial("tcp","172.17.0.2:16557") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: > dial: conn=172.17.0.1:58592->172.17.0.2:16557, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: dial("tcp","172.17.0.2:19297") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: > dial: conn=172.17.0.1:44628->172.17.0.2:19297, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: dial("tcp","172.17.0.2:1262") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: > dial: conn=172.17.0.1:58928->172.17.0.2:1262, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: dial("tcp","172.17.0.2:48907") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: > dial: conn=172.17.0.1:58482->172.17.0.2:48907, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: Purge dir "new_name" 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-qemamos7vimo: 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/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:34938") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:46808->172.17.0.2:34938, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:61297") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:55756->172.17.0.2:61297, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:49181") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:49990->172.17.0.2:49181, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:64621") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:34382->172.17.0.2:64621, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:23946") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:55772->172.17.0.2:23946, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:3703") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:48148->172.17.0.2:3703, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:59043") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:33968->172.17.0.2:59043, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:24849") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:47348->172.17.0.2:24849, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:53397") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:48528->172.17.0.2:53397, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/11/09 01:29:13 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zujaqir9siqu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/11/09 01:29:13 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/09 01:29:13 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:13 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:13 DEBUG : TestFTPProftpd: detected overridden config - adding "{WExNO}" suffix to name 2025/11/09 01:29:13 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:13 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:21") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:44054->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:57510") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:43402->172.17.0.2:57510, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/11/09 01:29:13 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zujaqir9siqu/not found.txt" 2025/11/09 01:29:13 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/09 01:29:13 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:13 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:13 DEBUG : TestFTPProftpd: detected overridden config - adding "{WExNO}" suffix to name 2025/11/09 01:29:13 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:13 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/not found.txt: Connecting to FTP server 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/not found.txt: dial("tcp","172.17.0.2:21") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/not found.txt: > dial: conn=172.17.0.1:44066->172.17.0.2:21, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/not found.txt: dial("tcp","172.17.0.2:65123") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/not found.txt: > dial: conn=172.17.0.1:49762->172.17.0.2:65123, err= 2025/11/09 01:29:13 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-zujaqir9siqu" from "TestFTPProftpd:rclone-test-zujaqir9siqu" 2025/11/09 01:29:13 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/11/09 01:29:13 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/09 01:29:13 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:13 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:13 DEBUG : TestFTPProftpd: detected overridden config - adding "{WExNO}" suffix to name 2025/11/09 01:29:13 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:13 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:44074->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:61594") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50146->172.17.0.2:61594, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:35950") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:40106->172.17.0.2:35950, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:49288") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:59396->172.17.0.2:49288, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:1143") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:56964->172.17.0.2:1143, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:59251") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:46228->172.17.0.2:59251, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:6625") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:53050->172.17.0.2:6625, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:13545") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:34234->172.17.0.2:13545, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:54508") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:58928->172.17.0.2:54508, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:45288") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:34590->172.17.0.2:45288, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:44041") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:40020->172.17.0.2:44041, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:5024") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:39036->172.17.0.2:5024, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:23635") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:36404->172.17.0.2:23635, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:12442") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:54236->172.17.0.2:12442, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:13143") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:33764->172.17.0.2:13143, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:37101") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:37166->172.17.0.2:37101, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:65296") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:36508->172.17.0.2:65296, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:25722") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:51544->172.17.0.2:25722, 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/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:3568") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:53616->172.17.0.2:3568, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:46496") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:36766->172.17.0.2:46496, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:22240") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:58190->172.17.0.2:22240, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:25549") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:60370->172.17.0.2:25549, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:8517") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:49476->172.17.0.2:8517, 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/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:18395") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:48852->172.17.0.2:18395, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:2012") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:57376->172.17.0.2:2012, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/11/09 01:29:13 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-zujaqir9siqu" 2025/11/09 01:29:13 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/09 01:29:13 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:13 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:13 DEBUG : TestFTPProftpd: detected overridden config - adding "{FOtYE}" suffix to name 2025/11/09 01:29:13 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:13 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: Connecting to FTP server 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:21") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:44082->172.17.0.2:21, err= 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:37125") 2025/11/09 01:29:13 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:45324->172.17.0.2:37125, 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/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:63222") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:58804->172.17.0.2:63222, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:50113") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:56532->172.17.0.2:50113, err= 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:16918") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:39312->172.17.0.2:16918, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/11/09 01:29:14 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zujaqir9siqu/deeper/nonexisting/directory" 2025/11/09 01:29:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/09 01:29:14 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:14 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{WExNO}" suffix to name 2025/11/09 01:29:14 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/09 01:29:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/09 01:29:14 DEBUG : Setting pass="2uKpT50rHdXM1KbHFE5IetqOwIQuu8-jILuYYXZcteJyVQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/09 01:29:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/deeper/nonexisting/directory: Connecting to FTP server 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/deeper/nonexisting/directory: dial("tcp","172.17.0.2:21") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:44094->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/11/09 01:29:14 DEBUG : Waiting for deletions to finish 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:9723") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:56670->172.17.0.2:9723, err= 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:48484") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:47024->172.17.0.2:48484, err= 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:6741") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:48594->172.17.0.2:6741, err= 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:38692") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:37000->172.17.0.2:38692, err= 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:20789") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:60062->172.17.0.2:20789, err= 2025/11/09 01:29:14 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:28596") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:35366->172.17.0.2:28596, err= 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:25986") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:42864->172.17.0.2:25986, err= 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:3618") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:55174->172.17.0.2:3618, err= 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:1274") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:51240->172.17.0.2:1274, err= 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:53583") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:38412->172.17.0.2:53583, err= 2025/11/09 01:29:14 DEBUG : removing 1 level 4 directories 2025/11/09 01:29:14 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/11/09 01:29:14 DEBUG : removing 1 level 3 directories 2025/11/09 01:29:14 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/11/09 01:29:14 DEBUG : removing 1 level 2 directories 2025/11/09 01:29:14 INFO : hello? sausage/êé: Removing directory 2025/11/09 01:29:14 DEBUG : removing 1 level 1 directories 2025/11/09 01:29:14 INFO : hello? sausage: Removing directory 2025/11/09 01:29:14 DEBUG : removing 1 level 0 directories 2025/11/09 01:29:14 INFO : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: Removing directory 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:12075") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:35198->172.17.0.2:12075, err= 2025/11/09 01:29:14 ERROR : error listing: directory not found 2025/11/09 01:29:14 DEBUG : Waiting for deletions to finish 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:48560") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:33556->172.17.0.2:48560, err= 2025/11/09 01:29:14 ERROR : error listing: directory not found 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: dial("tcp","172.17.0.2:13150") 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: > dial: conn=172.17.0.1:37010->172.17.0.2:13150, err= 2025/11/09 01:29:14 ERROR : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: Failed to list "": directory not found 2025/11/09 01:29:14 DEBUG : removing 1 level 0 directories 2025/11/09 01:29:14 INFO : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: Removing directory 2025/11/09 01:29:14 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/11/09 01:29:14 DEBUG : ftp://172.17.0.2:21/rclone-test-zujaqir9siqu: closing 2 unused connections 2025/11/09 01:29:14 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (3.89s) --- 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.59s) --- 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.22s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.02s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.25s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- 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.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.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.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.75s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.75s) --- 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.00s) --- 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.905s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 4.858306746s (try 1/5)