"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/09/22 01:38:26 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vogaqoh2zafe" 2025/09/22 01:38:26 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/22 01:38:26 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/22 01:38:26 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:26 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:26 DEBUG : TestFTPProftpd: detected overridden config - adding "{LU-Us}" suffix to name 2025/09/22 01:38:26 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:26 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: Connecting to FTP server 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:21") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:58558->172.17.0.3:21, err= 2025/09/22 01:38:26 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:14855") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:39672->172.17.0.3:14855, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:65315") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:43946->172.17.0.3:65315, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/09/22 01:38:26 INFO : dir/subdir: Making directory 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:13041") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:36064->172.17.0.3:13041, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:44821") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:39454->172.17.0.3:44821, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:46125") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:36024->172.17.0.3:46125, err= 2025/09/22 01:38:26 INFO : dir/subdir: Removing directory 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:43686") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:57776->172.17.0.3:43686, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:57266") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:39644->172.17.0.3:57266, err= 2025/09/22 01:38:26 INFO : dir: Removing directory 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:2830") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:51890->172.17.0.3:2830, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:55430") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:36872->172.17.0.3:55430, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:30973") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:60290->172.17.0.3:30973, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:51574") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:42450->172.17.0.3:51574, err= 2025/09/22 01:38:26 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:37994") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:58984->172.17.0.3:37994, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:7004") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:53458->172.17.0.3:7004, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:43425") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:59552->172.17.0.3:43425, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:25703") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:55026->172.17.0.3:25703, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:30432") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:33072->172.17.0.3:30432, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:62075") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:59878->172.17.0.3:62075, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:56296") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:57376->172.17.0.3:56296, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:52804") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:43312->172.17.0.3:52804, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:47368") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:50504->172.17.0.3:47368, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:31218") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:46660->172.17.0.3:31218, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:30778") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:56836->172.17.0.3:30778, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:36684") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:38682->172.17.0.3:36684, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:48852") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:41182->172.17.0.3:48852, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:45758") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:60940->172.17.0.3:45758, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:61105") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:59996->172.17.0.3:61105, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:11961") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:50668->172.17.0.3:11961, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:48470") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:51048->172.17.0.3:48470, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:15349") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:47796->172.17.0.3:15349, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:24712") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:53504->172.17.0.3:24712, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:53422") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:41918->172.17.0.3:53422, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:29181") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:54590->172.17.0.3:29181, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:24493") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:35354->172.17.0.3:24493, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:65439") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:55656->172.17.0.3:65439, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:8467") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:57090->172.17.0.3:8467, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:5083") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:54368->172.17.0.3:5083, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:43591") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:37346->172.17.0.3:43591, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:64710") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:59512->172.17.0.3:64710, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:6889") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:52284->172.17.0.3:6889, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:33486") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:40382->172.17.0.3:33486, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:30149") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:33660->172.17.0.3:30149, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:57439") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:52044->172.17.0.3:57439, err= 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:5945") 2025/09/22 01:38:26 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:43410->172.17.0.3:5945, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:36129") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:40362->172.17.0.3:36129, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:35329") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:39738->172.17.0.3:35329, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:30624") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:34388->172.17.0.3:30624, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:1026") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:33814->172.17.0.3:1026, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:31870") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:40042->172.17.0.3:31870, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:21386") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:60720->172.17.0.3:21386, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:52807") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:36522->172.17.0.3:52807, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:13703") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:58302->172.17.0.3:13703, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:51580") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:33702->172.17.0.3:51580, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:18050") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:36582->172.17.0.3:18050, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:49364") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:36802->172.17.0.3:49364, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:34897") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:47226->172.17.0.3:34897, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:62784") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:37016->172.17.0.3:62784, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:44934") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:49724->172.17.0.3:44934, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:45834") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:54248->172.17.0.3:45834, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:45720") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:59224->172.17.0.3:45720, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:59260") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:55246->172.17.0.3:59260, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:5012") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:44656->172.17.0.3:5012, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:33607") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:45042->172.17.0.3:33607, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:22906") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:42172->172.17.0.3:22906, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:28481") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:44624->172.17.0.3:28481, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:33511") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:34010->172.17.0.3:33511, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:30350") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:43604->172.17.0.3:30350, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:32540") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:60402->172.17.0.3:32540, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:11567") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:49210->172.17.0.3:11567, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:29526") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:42664->172.17.0.3:29526, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:38405") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:60924->172.17.0.3:38405, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:44030") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:57008->172.17.0.3:44030, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:58651") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:47290->172.17.0.3:58651, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:30310") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:40716->172.17.0.3:30310, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:48951") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:48464->172.17.0.3:48951, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:29245") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:36566->172.17.0.3:29245, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:64616") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:52152->172.17.0.3:64616, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:14040") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:45208->172.17.0.3:14040, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:29247") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:57400->172.17.0.3:29247, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:30951") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:60676->172.17.0.3:30951, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:34403") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:55344->172.17.0.3:34403, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:16519") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:32798->172.17.0.3:16519, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:43631") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:43176->172.17.0.3:43631, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:20448") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:42996->172.17.0.3:20448, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:33545") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:59314->172.17.0.3:33545, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:27460") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:46130->172.17.0.3:27460, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:54322") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:48914->172.17.0.3:54322, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:30795") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:43702->172.17.0.3:30795, err= 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:6860") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:52360->172.17.0.3:6860, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:34622") 2025/09/22 01:38:27 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:40962->172.17.0.3:34622, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: Connecting to FTP server 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:21") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:58568->172.17.0.3:21, err= 2025/09/22 01:38:28 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:5554") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:59884->172.17.0.3:5554, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:18873") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:33936->172.17.0.3:18873, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:41510") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:46028->172.17.0.3:41510, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:52092") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:57776->172.17.0.3:52092, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:21427") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:35322->172.17.0.3:21427, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:51251") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:42830->172.17.0.3:51251, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:22297") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:37398->172.17.0.3:22297, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:43703") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:60792->172.17.0.3:43703, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:30442") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:53972->172.17.0.3:30442, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:7666") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:48590->172.17.0.3:7666, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:63880") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:48848->172.17.0.3:63880, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:5362") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:46904->172.17.0.3:5362, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:37388") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:54330->172.17.0.3:37388, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:39533") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:34376->172.17.0.3:39533, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:50672") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:35202->172.17.0.3:50672, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:22170") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:45974->172.17.0.3:22170, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:39001") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:58122->172.17.0.3:39001, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:57555") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:40554->172.17.0.3:57555, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:39362") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:56286->172.17.0.3:39362, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/09/22 01:38:28 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/09/22 01:38:28 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/22 01:38:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:28 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{LU-Us}" suffix to name 2025/09/22 01:38:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:28 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:58574->172.17.0.3:21, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:30274") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:37266->172.17.0.3:30274, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:35397") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:47332->172.17.0.3:35397, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:40644") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:34138->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/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:23907") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:43620->172.17.0.3:23907, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:47745") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:34342->172.17.0.3:47745, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:25933") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:57136->172.17.0.3:25933, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:31270") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:35958->172.17.0.3:31270, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:8368") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:57954->172.17.0.3:8368, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:51082") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:43834->172.17.0.3:51082, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:52275") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:33220->172.17.0.3:52275, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:39156") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:39088->172.17.0.3:39156, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:26591") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:33834->172.17.0.3:26591, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:13856") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:50404->172.17.0.3:13856, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:43687") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:50560->172.17.0.3:43687, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:44441") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:57316->172.17.0.3:44441, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1153: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1190: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/09/22 01:38:28 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vogaqoh2zafe/hello? sausage/êé" 2025/09/22 01:38:28 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/22 01:38:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:28 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{LU-Us}" suffix to name 2025/09/22 01:38:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:28 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: Connecting to FTP server 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:58578->172.17.0.3:21, err= 2025/09/22 01:38:28 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-vogaqoh2zafe/hello? sausage/êé" to be canonical "TestFTPProftpd{LU-Us}:rclone-test-vogaqoh2zafe/hello? sausage/êé" 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:38177") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:51564->172.17.0.3:38177, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:35538") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:37542->172.17.0.3:35538, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: Connecting to FTP server 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:58584->172.17.0.3:21, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:58350") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:54912->172.17.0.3:58350, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:59535") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:59142->172.17.0.3:59535, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:61570") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:36410->172.17.0.3:61570, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:2236") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:46616->172.17.0.3:2236, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:27896") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:44062->172.17.0.3:27896, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:10199") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:56818->172.17.0.3:10199, err= 2025/09/22 01:38:28 DEBUG : Waiting for deletions to finish 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:30684") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:52484->172.17.0.3:30684, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:52357") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:47034->172.17.0.3:52357, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:34489") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:44542->172.17.0.3:34489, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:50158") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:59576->172.17.0.3:50158, err= 2025/09/22 01:38:28 INFO : a/b/c/d/e.txt: Deleted 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:51967") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:39228->172.17.0.3:51967, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:42355") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:58128->172.17.0.3:42355, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:16102") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:60330->172.17.0.3:16102, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: dial("tcp","172.17.0.3:65180") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé: > dial: conn=172.17.0.1:51500->172.17.0.3:65180, err= 2025/09/22 01:38:28 DEBUG : removing 1 level 4 directories 2025/09/22 01:38:28 INFO : a/b/c/d: Removing directory 2025/09/22 01:38:28 DEBUG : removing 1 level 3 directories 2025/09/22 01:38:28 INFO : a/b/c: Removing directory 2025/09/22 01:38:28 DEBUG : removing 1 level 2 directories 2025/09/22 01:38:28 INFO : a/b: Removing directory 2025/09/22 01:38:28 DEBUG : removing 1 level 1 directories 2025/09/22 01:38:28 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:54342") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:39946->172.17.0.3:54342, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:30244") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:46166->172.17.0.3:30244, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:64844") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:60706->172.17.0.3:64844, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:40058") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:51792->172.17.0.3:40058, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:51517") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:39410->172.17.0.3:51517, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:43013") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:38700->172.17.0.3:43013, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: Connecting to FTP server 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:21") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:58586->172.17.0.3:21, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:4965") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:43610->172.17.0.3:4965, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:25529") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:58254->172.17.0.3:25529, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:58160") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:58466->172.17.0.3:58160, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:30166") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:38406->172.17.0.3:30166, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:41358") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:48102->172.17.0.3:41358, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:32849") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:52152->172.17.0.3:32849, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:9304") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:52244->172.17.0.3:9304, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:1231") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:42072->172.17.0.3:1231, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:30014") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:51316->172.17.0.3:30014, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:40331") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:52872->172.17.0.3:40331, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:15357") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:60284->172.17.0.3:15357, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:1856") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:44812->172.17.0.3:1856, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:58953") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:50335") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:56208->172.17.0.3:58953, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:47246->172.17.0.3:50335, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:7091") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:44814->172.17.0.3:7091, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:51160") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:60602->172.17.0.3:51160, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:32524") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:49268->172.17.0.3:32524, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/09/22 01:38:28 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-fimawuw6buvi" 2025/09/22 01:38:28 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/22 01:38:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:28 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{LU-Us}" suffix to name 2025/09/22 01:38:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:28 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: Connecting to FTP server 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: dial("tcp","172.17.0.3:21") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: > dial: conn=172.17.0.1:58592->172.17.0.3:21, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:53335") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:40880->172.17.0.3:53335, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: dial("tcp","172.17.0.3:29598") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: > dial: conn=172.17.0.1:38172->172.17.0.3:29598, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: dial("tcp","172.17.0.3:46603") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: > dial: conn=172.17.0.1:42766->172.17.0.3:46603, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: dial("tcp","172.17.0.3:56534") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: > dial: conn=172.17.0.1:45780->172.17.0.3:56534, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: dial("tcp","172.17.0.3:48314") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: > dial: conn=172.17.0.1:57656->172.17.0.3:48314, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: dial("tcp","172.17.0.3:11245") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: > dial: conn=172.17.0.1:39772->172.17.0.3:11245, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: dial("tcp","172.17.0.3:27822") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: > dial: conn=172.17.0.1:52260->172.17.0.3:27822, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: dial("tcp","172.17.0.3:30633") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: > dial: conn=172.17.0.1:42162->172.17.0.3:30633, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:33329") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:37134->172.17.0.3:33329, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:50973") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:60214->172.17.0.3:50973, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:45398") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:57506->172.17.0.3:45398, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:24988") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:34036->172.17.0.3:24988, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:32182") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:52162->172.17.0.3:32182, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: dial("tcp","172.17.0.3:60964") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: > dial: conn=172.17.0.1:59698->172.17.0.3:60964, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: dial("tcp","172.17.0.3:27723") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: > dial: conn=172.17.0.1:33994->172.17.0.3:27723, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: dial("tcp","172.17.0.3:58465") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: > dial: conn=172.17.0.1:59208->172.17.0.3:58465, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: dial("tcp","172.17.0.3:65500") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: > dial: conn=172.17.0.1:55880->172.17.0.3:65500, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: Purge dir "new_name" 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-fimawuw6buvi: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:23198") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:46054->172.17.0.3:23198, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:26083") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:59054->172.17.0.3:26083, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:47872") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:33108->172.17.0.3:47872, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:3332") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:56170->172.17.0.3:3332, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:5408") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:38584->172.17.0.3:5408, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:61846") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:52290->172.17.0.3:61846, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:43142") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:40040->172.17.0.3:43142, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:46222") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:38202->172.17.0.3:46222, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:39142") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:44108->172.17.0.3:39142, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/09/22 01:38:28 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vogaqoh2zafe/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/09/22 01:38:28 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/22 01:38:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:28 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{LU-Us}" suffix to name 2025/09/22 01:38:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:28 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:21") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:58594->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:33556") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:47310->172.17.0.3:33556, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/09/22 01:38:28 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vogaqoh2zafe/not found.txt" 2025/09/22 01:38:28 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/22 01:38:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:28 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{LU-Us}" suffix to name 2025/09/22 01:38:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:28 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/not found.txt: Connecting to FTP server 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/not found.txt: dial("tcp","172.17.0.3:21") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/not found.txt: > dial: conn=172.17.0.1:58610->172.17.0.3:21, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/not found.txt: dial("tcp","172.17.0.3:16999") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/not found.txt: > dial: conn=172.17.0.1:43302->172.17.0.3:16999, err= 2025/09/22 01:38:28 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-vogaqoh2zafe" from "TestFTPProftpd:rclone-test-vogaqoh2zafe" 2025/09/22 01:38:28 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/09/22 01:38:28 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/22 01:38:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:28 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{LU-Us}" suffix to name 2025/09/22 01:38:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:28 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:58620->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:34932") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56248->172.17.0.3:34932, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:52986") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:43280->172.17.0.3:52986, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:25098") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:54368->172.17.0.3:25098, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:54547") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:54790->172.17.0.3:54547, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:4507") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:35776->172.17.0.3:4507, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:57299") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:60094->172.17.0.3:57299, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:59795") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:33158->172.17.0.3:59795, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:62462") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:54384->172.17.0.3:62462, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:22455") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:48308->172.17.0.3:22455, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:3220") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:34910->172.17.0.3:3220, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:3633") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:48358->172.17.0.3:3633, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:41002") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:59012->172.17.0.3:41002, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:45778") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:41848->172.17.0.3:45778, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:37891") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:37278->172.17.0.3:37891, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:6498") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:35774->172.17.0.3:6498, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:58007") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:54538->172.17.0.3:58007, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:11850") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:50722->172.17.0.3:11850, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2004: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2109: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:50992") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:48322->172.17.0.3:50992, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:50140") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:49616->172.17.0.3:50140, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:13607") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:34190->172.17.0.3:13607, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:29539") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:47056->172.17.0.3:29539, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:12752") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:48046->172.17.0.3:12752, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2281: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:36540") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:38044->172.17.0.3:36540, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:44282") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:46294->172.17.0.3:44282, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/09/22 01:38:28 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-vogaqoh2zafe" 2025/09/22 01:38:28 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/22 01:38:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:28 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{IP0-W}" suffix to name 2025/09/22 01:38:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:28 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: Connecting to FTP server 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:21") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:58632->172.17.0.3:21, err= 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:46122") 2025/09/22 01:38:28 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:42358->172.17.0.3:46122, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2476: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:64859") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:52414->172.17.0.3:64859, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:50885") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:60560->172.17.0.3:50885, err= 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:18639") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:53892->172.17.0.3:18639, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/09/22 01:38:29 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vogaqoh2zafe/deeper/nonexisting/directory" 2025/09/22 01:38:29 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/22 01:38:29 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:29 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{LU-Us}" suffix to name 2025/09/22 01:38:29 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/22 01:38:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/22 01:38:29 DEBUG : Setting pass="1dVek8ygUsvfC_qFqA9kv54tJSqtgIVqwrAEJRX9RraPKg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/22 01:38:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/deeper/nonexisting/directory: Connecting to FTP server 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/deeper/nonexisting/directory: dial("tcp","172.17.0.3:21") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe/deeper/nonexisting/directory: > dial: conn=172.17.0.1:58648->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/09/22 01:38:29 DEBUG : Waiting for deletions to finish 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:62107") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:58670->172.17.0.3:62107, err= 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:10853") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:48650->172.17.0.3:10853, err= 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:13180") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:49788->172.17.0.3:13180, err= 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:33626") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:37366->172.17.0.3:33626, err= 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:29037") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:40304->172.17.0.3:29037, err= 2025/09/22 01:38:29 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:18136") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:33646->172.17.0.3:18136, err= 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:41013") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:54040->172.17.0.3:41013, err= 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:39017") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:36056->172.17.0.3:39017, err= 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:1988") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:34100->172.17.0.3:1988, err= 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:4026") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:40620->172.17.0.3:4026, err= 2025/09/22 01:38:29 DEBUG : removing 1 level 4 directories 2025/09/22 01:38:29 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/09/22 01:38:29 DEBUG : removing 1 level 3 directories 2025/09/22 01:38:29 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/09/22 01:38:29 DEBUG : removing 1 level 2 directories 2025/09/22 01:38:29 INFO : hello? sausage/êé: Removing directory 2025/09/22 01:38:29 DEBUG : removing 1 level 1 directories 2025/09/22 01:38:29 INFO : hello? sausage: Removing directory 2025/09/22 01:38:29 DEBUG : removing 1 level 0 directories 2025/09/22 01:38:29 INFO : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: Removing directory 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:15624") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:47032->172.17.0.3:15624, err= 2025/09/22 01:38:29 ERROR : error listing: directory not found 2025/09/22 01:38:29 DEBUG : Waiting for deletions to finish 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:58258") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:46858->172.17.0.3:58258, err= 2025/09/22 01:38:29 ERROR : error listing: directory not found 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: dial("tcp","172.17.0.3:24725") 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: > dial: conn=172.17.0.1:42694->172.17.0.3:24725, err= 2025/09/22 01:38:29 ERROR : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: Failed to list "": directory not found 2025/09/22 01:38:29 DEBUG : removing 1 level 0 directories 2025/09/22 01:38:29 INFO : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: Removing directory 2025/09/22 01:38:29 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/09/22 01:38:29 DEBUG : ftp://172.17.0.3:21/rclone-test-vogaqoh2zafe: closing 2 unused connections --- PASS: TestIntegration (2.90s) --- 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.81s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.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.01s) --- 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.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.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.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.89s) --- 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.18s) --- 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.913s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 4.257878934s (try 1/5)