"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2026/05/27 02:26:23 NOTICE: TestFTPProftpd: Starting server 2026/05/27 02:26:24 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.4:21" try 1/100 2026/05/27 02:26:24 DEBUG : TestFTPProftpd: Read 1, error: 2026/05/27 02:26:24 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.4:21" 2026/05/27 02:26:24 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-ciwijum6xuso" 2026/05/27 02:26:24 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/05/27 02:26:24 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/27 02:26:24 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:24 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:24 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:24 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:24 DEBUG : TestFTPProftpd: detected overridden config - adding "{PYNYS}" suffix to name 2026/05/27 02:26:24 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:24 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:24 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:24 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:24 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: Connecting to FTP server 2026/05/27 02:26:24 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:21") 2026/05/27 02:26:24 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:51256->172.17.0.4:21, err= 2026/05/27 02:26:25 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 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:51849") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:40434->172.17.0.4:51849, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:49037") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:56430->172.17.0.4:49037, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/05/27 02:26:25 INFO : dir/subdir: Making directory 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:36610") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:35218->172.17.0.4:36610, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:59210") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:58708->172.17.0.4:59210, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:6927") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:41540->172.17.0.4:6927, err= 2026/05/27 02:26:25 INFO : dir/subdir: Removing directory 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:50374") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:39092->172.17.0.4:50374, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:49872") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:47524->172.17.0.4:49872, err= 2026/05/27 02:26:25 INFO : dir: Removing directory 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:47088") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:51132->172.17.0.4:47088, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:5224") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:36126->172.17.0.4:5224, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:63420") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:34602->172.17.0.4:63420, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:19005") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:56650->172.17.0.4:19005, err= 2026/05/27 02:26:25 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 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:34822") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:34068->172.17.0.4:34822, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:708: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:52827") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:39350->172.17.0.4:52827, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:40478") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:60580->172.17.0.4:40478, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:17432") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:50938->172.17.0.4:17432, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:41125") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:34532->172.17.0.4:41125, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:708: testing "．" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:51637") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:59198->172.17.0.4:51637, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:6540") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:51852->172.17.0.4:6540, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:55909") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:58358->172.17.0.4:55909, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:20478") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:45276->172.17.0.4:20478, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:708: testing "．．" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:48281") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:46602->172.17.0.4:48281, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:53898") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:41548->172.17.0.4:53898, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:24662") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:48876->172.17.0.4:24662, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:24879") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:38518->172.17.0.4:24879, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:708: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:9137") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:55712->172.17.0.4:9137, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:1334") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:57300->172.17.0.4:1334, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:50165") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:47116->172.17.0.4:50165, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:32103") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:38160->172.17.0.4:32103, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:708: testing " leading space" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:5559") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:38482->172.17.0.4:5559, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:64060") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:38782->172.17.0.4:64060, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:23533") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:49110->172.17.0.4:23533, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:56385") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:37328->172.17.0.4:56385, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:708: testing "~leading tilde" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:47562") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:49656->172.17.0.4:47562, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:59119") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:45970->172.17.0.4:59119, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:50060") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:57120->172.17.0.4:50060, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:53466") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:55796->172.17.0.4:53466, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:708: testing "␍leading CR" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:43958") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:58076->172.17.0.4:43958, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:34398") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:49658->172.17.0.4:34398, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:35020") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:49776->172.17.0.4:35020, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:48159") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:39414->172.17.0.4:48159, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:708: testing "␊leading LF" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:32283") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:42620->172.17.0.4:32283, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:53001") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:46440->172.17.0.4:53001, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:17447") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:42772->172.17.0.4:17447, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:19576") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:59474->172.17.0.4:19576, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:708: testing "␉leading HT" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:27945") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:58940->172.17.0.4:27945, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:33855") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:49150->172.17.0.4:33855, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:59677") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:57616->172.17.0.4:59677, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:14048") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:57554->172.17.0.4:14048, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:708: testing "␋leading VT" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:39372") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:44830->172.17.0.4:39372, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:50052") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:49614->172.17.0.4:50052, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:33503") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:44634->172.17.0.4:33503, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:22118") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:39976->172.17.0.4:22118, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:708: testing ".leading dot" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:38415") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:42106->172.17.0.4:38415, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:57141") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:56992->172.17.0.4:57141, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:45974") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:55288->172.17.0.4:45974, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:46529") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:42474->172.17.0.4:46529, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:708: testing "trailing space " 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:57452") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:36982->172.17.0.4:57452, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:30604") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:50280->172.17.0.4:30604, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:13098") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:51976->172.17.0.4:13098, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:61988") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:56268->172.17.0.4:61988, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:708: testing "trailing CR␍" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:29130") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:58734->172.17.0.4:29130, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:35607") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:56090->172.17.0.4:35607, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:52838") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:48738->172.17.0.4:52838, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:11158") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:33440->172.17.0.4:11158, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:708: testing "trailing LF␊" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:29192") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:56962->172.17.0.4:29192, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:37364") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:46376->172.17.0.4:37364, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:63601") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:50796->172.17.0.4:63601, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:7616") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:40142->172.17.0.4:7616, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:708: testing "trailing HT␉" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:6227") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:56400->172.17.0.4:6227, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:33086") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:53492->172.17.0.4:33086, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:54751") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:36630->172.17.0.4:54751, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:37487") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:33138->172.17.0.4:37487, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:708: testing "trailing VT␋" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:20553") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:42374->172.17.0.4:20553, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:6663") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:40550->172.17.0.4:6663, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:56039") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:47532->172.17.0.4:56039, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:47475") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:59392->172.17.0.4:47475, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:708: testing "trailing dot." 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:39495") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:55952->172.17.0.4:39495, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:50182") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:54428->172.17.0.4:50182, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:60499") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:53286->172.17.0.4:60499, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:13332") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:46016->172.17.0.4:13332, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:708: testing "invalid utf-8\xfe" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:34700") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:37516->172.17.0.4:34700, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:28467") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:60560->172.17.0.4:28467, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:34426") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:39962->172.17.0.4:34426, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:7580") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:45994->172.17.0.4:7580, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:708: testing "test%46.txt" 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:20074") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:36878->172.17.0.4:20074, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:14866") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:56034->172.17.0.4:14866, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:53085") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:55954->172.17.0.4:53085, err= 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:11991") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:56686->172.17.0.4:11991, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:44446") 2026/05/27 02:26:25 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:49558->172.17.0.4:44446, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: Connecting to FTP server 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:21") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:51270->172.17.0.4:21, err= 2026/05/27 02:26:26 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:61131") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:49992->172.17.0.4:61131, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:3209") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:33432->172.17.0.4:3209, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:787: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:820: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:873: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:56940") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:44784->172.17.0.4:56940, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:54678") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:40950->172.17.0.4:54678, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:50474") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:40270->172.17.0.4:50474, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:34747") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:39736->172.17.0.4:34747, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:14747") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:34900->172.17.0.4:14747, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:24759") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:36298->172.17.0.4:24759, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:10049") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:54836->172.17.0.4:10049, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:65361") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:47136->172.17.0.4:65361, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:10662") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:58708->172.17.0.4:10662, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:39666") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:58494->172.17.0.4:39666, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:57225") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:35814->172.17.0.4:57225, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:60103") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:39126->172.17.0.4:60103, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:11777") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:43578->172.17.0.4:11777, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:37815") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:60806->172.17.0.4:37815, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:64507") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:34452->172.17.0.4:64507, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:50520") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:53870->172.17.0.4:50520, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:63876") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:42588->172.17.0.4:63876, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/05/27 02:26:26 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/05/27 02:26:26 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/27 02:26:26 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:26 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:26 DEBUG : TestFTPProftpd: detected overridden config - adding "{PYNYS}" suffix to name 2026/05/27 02:26:26 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:26 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:51284->172.17.0.4:21, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:18692") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:45144->172.17.0.4:18692, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:39770") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:60816->172.17.0.4:39770, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:17253") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:45730->172.17.0.4:17253, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:27651") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:39800->172.17.0.4:27651, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:37031") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:36886->172.17.0.4:37031, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:63057") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:51726->172.17.0.4:63057, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:54648") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:54224->172.17.0.4:54648, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:27409") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:42736->172.17.0.4:27409, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:60851") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:43272->172.17.0.4:60851, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:5231") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:34492->172.17.0.4:5231, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1126: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:49801") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:48362->172.17.0.4:49801, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:12190") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:47382->172.17.0.4:12190, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:57024") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:52934->172.17.0.4:57024, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:45398") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:53138->172.17.0.4:45398, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:14375") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:48676->172.17.0.4:14375, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1158: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1195: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/05/27 02:26:26 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-ciwijum6xuso/hello? sausage/êé" 2026/05/27 02:26:26 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/27 02:26:26 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:26 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:26 DEBUG : TestFTPProftpd: detected overridden config - adding "{PYNYS}" suffix to name 2026/05/27 02:26:26 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:26 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: Connecting to FTP server 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:51296->172.17.0.4:21, err= 2026/05/27 02:26:26 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-ciwijum6xuso/hello? sausage/êé" to be canonical "TestFTPProftpd{PYNYS}:rclone-test-ciwijum6xuso/hello? sausage/êé" 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:48948") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:54716->172.17.0.4:48948, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:40133") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:46600->172.17.0.4:40133, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: Connecting to FTP server 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:51310->172.17.0.4:21, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:11972") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:56302->172.17.0.4:11972, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:65019") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:39604->172.17.0.4:65019, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:39326") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:60310->172.17.0.4:39326, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:41684") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:39570->172.17.0.4:41684, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:13259") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:58884->172.17.0.4:13259, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:4584") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:34984->172.17.0.4:4584, err= 2026/05/27 02:26:26 DEBUG : Waiting for deletions to finish 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:12630") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:59346->172.17.0.4:12630, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:52468") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:51426->172.17.0.4:52468, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:2807") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:37688->172.17.0.4:2807, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:1898") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:58384->172.17.0.4:1898, err= 2026/05/27 02:26:26 INFO : a/b/c/d/e.txt: Deleted 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:60844") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:54322->172.17.0.4:60844, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:4265") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:59238->172.17.0.4:4265, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:43989") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:42000->172.17.0.4:43989, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: dial("tcp","172.17.0.4:28571") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé: > dial: conn=172.17.0.1:42706->172.17.0.4:28571, err= 2026/05/27 02:26:26 DEBUG : removing 1 level 4 directories 2026/05/27 02:26:26 INFO : a/b/c/d: Removing directory 2026/05/27 02:26:26 DEBUG : removing 1 level 3 directories 2026/05/27 02:26:26 INFO : a/b/c: Removing directory 2026/05/27 02:26:26 DEBUG : removing 1 level 2 directories 2026/05/27 02:26:26 INFO : a/b: Removing directory 2026/05/27 02:26:26 DEBUG : removing 1 level 1 directories 2026/05/27 02:26:26 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1259: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:48430") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:38284->172.17.0.4:48430, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:34541") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:47228->172.17.0.4:34541, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:63825") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:60300->172.17.0.4:63825, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:17642") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:59566->172.17.0.4:17642, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:48264") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:48982->172.17.0.4:48264, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:23049") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:49964->172.17.0.4:23049, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: Connecting to FTP server 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:21") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:51316->172.17.0.4:21, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:26667") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:41006->172.17.0.4:26667, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:14977") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:33868->172.17.0.4:14977, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:48091") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:33668->172.17.0.4:48091, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:62859") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:53070->172.17.0.4:62859, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:32688") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:43570->172.17.0.4:32688, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:24063") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:32996->172.17.0.4:24063, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:65309") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:2230") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:57946->172.17.0.4:2230, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:53038->172.17.0.4:65309, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:47815") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:48618->172.17.0.4:47815, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:39782") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:44834->172.17.0.4:39782, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:12507") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:46174->172.17.0.4:12507, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:27257") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:43104->172.17.0.4:27257, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:11552") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:39394->172.17.0.4:11552, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:4978") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:49092->172.17.0.4:4978, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:49525") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:52788->172.17.0.4:49525, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:12062") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:40556->172.17.0.4:12062, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:31368") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:56412->172.17.0.4:31368, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1407: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/05/27 02:26:26 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-tedayag3koba" 2026/05/27 02:26:26 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/27 02:26:26 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:26 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:26 DEBUG : TestFTPProftpd: detected overridden config - adding "{PYNYS}" suffix to name 2026/05/27 02:26:26 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:26 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: Connecting to FTP server 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: dial("tcp","172.17.0.4:21") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: > dial: conn=172.17.0.1:51324->172.17.0.4:21, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:26229") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:50124->172.17.0.4:26229, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: dial("tcp","172.17.0.4:37135") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: > dial: conn=172.17.0.1:35048->172.17.0.4:37135, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: dial("tcp","172.17.0.4:27248") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: > dial: conn=172.17.0.1:45344->172.17.0.4:27248, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: dial("tcp","172.17.0.4:60980") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: > dial: conn=172.17.0.1:33108->172.17.0.4:60980, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: dial("tcp","172.17.0.4:25337") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: > dial: conn=172.17.0.1:42872->172.17.0.4:25337, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: dial("tcp","172.17.0.4:43741") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: > dial: conn=172.17.0.1:60916->172.17.0.4:43741, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: dial("tcp","172.17.0.4:17070") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: > dial: conn=172.17.0.1:41916->172.17.0.4:17070, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: dial("tcp","172.17.0.4:11982") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: > dial: conn=172.17.0.1:48658->172.17.0.4:11982, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:36266") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:55050->172.17.0.4:36266, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:61048") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:34852->172.17.0.4:61048, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:30852") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:52318->172.17.0.4:30852, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:10404") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:41268->172.17.0.4:10404, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:18622") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:35034->172.17.0.4:18622, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: dial("tcp","172.17.0.4:21057") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: > dial: conn=172.17.0.1:41740->172.17.0.4:21057, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: dial("tcp","172.17.0.4:17204") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: > dial: conn=172.17.0.1:40542->172.17.0.4:17204, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: dial("tcp","172.17.0.4:32138") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: > dial: conn=172.17.0.1:41594->172.17.0.4:32138, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: dial("tcp","172.17.0.4:11718") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: > dial: conn=172.17.0.1:37088->172.17.0.4:11718, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: Purge dir "new_name" 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-tedayag3koba: 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:1601: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1632: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1703: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:64975") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:36570->172.17.0.4:64975, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:12767") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:53202->172.17.0.4:12767, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:37031") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:36900->172.17.0.4:37031, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:51380") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:50516->172.17.0.4:51380, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:36472") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:38500->172.17.0.4:36472, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:60306") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:55536->172.17.0.4:60306, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:62581") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:51512->172.17.0.4:62581, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:20979") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:33434->172.17.0.4:20979, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:15388") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:48744->172.17.0.4:15388, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/05/27 02:26:26 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-ciwijum6xuso/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/05/27 02:26:26 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/27 02:26:26 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:26 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:26 DEBUG : TestFTPProftpd: detected overridden config - adding "{PYNYS}" suffix to name 2026/05/27 02:26:26 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:26 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:51332->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:44279") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:60828->172.17.0.4:44279, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/05/27 02:26:26 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-ciwijum6xuso/not found.txt" 2026/05/27 02:26:26 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/27 02:26:26 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:26 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:26 DEBUG : TestFTPProftpd: detected overridden config - adding "{PYNYS}" suffix to name 2026/05/27 02:26:26 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:26 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/not found.txt: Connecting to FTP server 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/not found.txt: dial("tcp","172.17.0.4:21") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/not found.txt: > dial: conn=172.17.0.1:51336->172.17.0.4:21, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/not found.txt: dial("tcp","172.17.0.4:28939") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/not found.txt: > dial: conn=172.17.0.1:59024->172.17.0.4:28939, err= 2026/05/27 02:26:26 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1920: Opening root remote "TestFTPProftpd:" path "rclone-test-ciwijum6xuso" from "TestFTPProftpd:rclone-test-ciwijum6xuso" 2026/05/27 02:26:26 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/05/27 02:26:26 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/27 02:26:26 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:26 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:26 DEBUG : TestFTPProftpd: detected overridden config - adding "{PYNYS}" suffix to name 2026/05/27 02:26:26 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:26 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:51346->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:57782") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:38984->172.17.0.4:57782, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:55101") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:53956->172.17.0.4:55101, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:13945") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:33118->172.17.0.4:13945, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:12664") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:50876->172.17.0.4:12664, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21828") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:48390->172.17.0.4:21828, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:59267") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56704->172.17.0.4:59267, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1957: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:9520") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:59202->172.17.0.4:9520, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:51882") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:36056->172.17.0.4:51882, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:6585") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:46682->172.17.0.4:6585, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:50746") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34080->172.17.0.4:50746, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:61161") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37466->172.17.0.4:61161, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:12529") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:49678->172.17.0.4:12529, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:27914") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:46298->172.17.0.4:27914, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:47815") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:48630->172.17.0.4:47815, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:3192") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44164->172.17.0.4:3192, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30381") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58636->172.17.0.4:30381, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:47699") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:48802->172.17.0.4:47699, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2016: 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:2121: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2137: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:10289") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:44182->172.17.0.4:10289, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:33585") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:55292->172.17.0.4:33585, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:26144") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:39782->172.17.0.4:26144, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:7483") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:36072->172.17.0.4:7483, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:62857") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:41814->172.17.0.4:62857, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2293: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:5606") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:37566->172.17.0.4:5606, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:11565") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:58402->172.17.0.4:11565, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/05/27 02:26:26 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-ciwijum6xuso" 2026/05/27 02:26:26 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/27 02:26:26 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:26 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:26 DEBUG : TestFTPProftpd: detected overridden config - adding "{oX0M2}" suffix to name 2026/05/27 02:26:26 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:26 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:26 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: Connecting to FTP server 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:21") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:51354->172.17.0.4:21, err= 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:42759") 2026/05/27 02:26:26 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:36374->172.17.0.4:42759, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2376: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2488: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:30351") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:51354->172.17.0.4:30351, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:47124") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:40660->172.17.0.4:47124, err= 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:43596") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:40376->172.17.0.4:43596, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/05/27 02:26:27 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-ciwijum6xuso/deeper/nonexisting/directory" 2026/05/27 02:26:27 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/27 02:26:27 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:27 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:27 DEBUG : TestFTPProftpd: detected overridden config - adding "{PYNYS}" suffix to name 2026/05/27 02:26:27 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/27 02:26:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/27 02:26:27 DEBUG : Setting pass="_UXLESEc9_Ee4TgVgCeAPVuN7kuusQPMKBJuuXgiwV7mcQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/27 02:26:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/deeper/nonexisting/directory: Connecting to FTP server 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso/deeper/nonexisting/directory: > dial: conn=172.17.0.1:51366->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2637: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2680: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2737: FS has no Directory methods and doesn't Wrap 2026/05/27 02:26:27 DEBUG : Waiting for deletions to finish 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:16772") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:42844->172.17.0.4:16772, err= 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:61138") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:35608->172.17.0.4:61138, err= 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:21840") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:57386->172.17.0.4:21840, err= 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:16856") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:37554->172.17.0.4:16856, err= 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:26987") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:56566->172.17.0.4:26987, err= 2026/05/27 02:26:27 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:11044") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:47054->172.17.0.4:11044, err= 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:30123") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:59244->172.17.0.4:30123, err= 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:45088") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:43554->172.17.0.4:45088, err= 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:4735") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:42852->172.17.0.4:4735, err= 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:36128") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:60600->172.17.0.4:36128, err= 2026/05/27 02:26:27 DEBUG : removing 1 level 4 directories 2026/05/27 02:26:27 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/05/27 02:26:27 DEBUG : removing 1 level 3 directories 2026/05/27 02:26:27 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/05/27 02:26:27 DEBUG : removing 1 level 2 directories 2026/05/27 02:26:27 INFO : hello? sausage/êé: Removing directory 2026/05/27 02:26:27 DEBUG : removing 1 level 1 directories 2026/05/27 02:26:27 INFO : hello? sausage: Removing directory 2026/05/27 02:26:27 DEBUG : removing 1 level 0 directories 2026/05/27 02:26:27 INFO : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: Removing directory 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:3582") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:52782->172.17.0.4:3582, err= 2026/05/27 02:26:27 ERROR : error listing: directory not found 2026/05/27 02:26:27 DEBUG : Waiting for deletions to finish 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:60504") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:56028->172.17.0.4:60504, err= 2026/05/27 02:26:27 ERROR : error listing: directory not found 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: dial("tcp","172.17.0.4:58840") 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: > dial: conn=172.17.0.1:48294->172.17.0.4:58840, err= 2026/05/27 02:26:27 ERROR : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: Failed to list "": directory not found 2026/05/27 02:26:27 DEBUG : removing 1 level 0 directories 2026/05/27 02:26:27 INFO : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: Removing directory 2026/05/27 02:26:27 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/05/27 02:26:27 DEBUG : ftp://172.17.0.4:21/rclone-test-ciwijum6xuso: closing 2 unused connections 2026/05/27 02:26:27 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (3.72s) --- 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.43s) --- 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.17s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.18s) --- 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.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.06s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.06s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.04s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.81s) --- 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.729s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 4.755280025s (try 1/5)