"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2026/05/22 01:36:16 NOTICE: TestFTPProftpd: Starting server 2026/05/22 01:36:17 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.4:21" try 1/100 2026/05/22 01:36:17 DEBUG : TestFTPProftpd: Read 1, error: 2026/05/22 01:36:17 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.4:21" 2026/05/22 01:36:17 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hudibad6hiwa" 2026/05/22 01:36:17 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/05/22 01:36:17 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/22 01:36:17 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:17 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:17 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:17 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:17 DEBUG : TestFTPProftpd: detected overridden config - adding "{pVdCF}" suffix to name 2026/05/22 01:36:17 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:17 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:17 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:17 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: Connecting to FTP server 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:21") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:51934->172.17.0.4:21, err= 2026/05/22 01:36:17 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/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:6456") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:40200->172.17.0.4:6456, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:7647") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:59764->172.17.0.4:7647, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/05/22 01:36:17 INFO : dir/subdir: Making directory 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:31310") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:57200->172.17.0.4:31310, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:11110") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:50534->172.17.0.4:11110, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:25330") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:34132->172.17.0.4:25330, err= 2026/05/22 01:36:17 INFO : dir/subdir: Removing directory 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:57128") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:49286->172.17.0.4:57128, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:38523") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:43230->172.17.0.4:38523, err= 2026/05/22 01:36:17 INFO : dir: Removing directory 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:7791") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:45112->172.17.0.4:7791, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:38131") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:33586->172.17.0.4:38131, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:17539") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:33144->172.17.0.4:17539, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:37859") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:54712->172.17.0.4:37859, err= 2026/05/22 01:36:17 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/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:9359") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:52936->172.17.0.4:9359, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:708: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:16428") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:50442->172.17.0.4:16428, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:37358") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:53110->172.17.0.4:37358, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:52156") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:38248->172.17.0.4:52156, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:31801") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:45460->172.17.0.4:31801, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:708: testing "．" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:64798") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:47590->172.17.0.4:64798, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:53691") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:47844->172.17.0.4:53691, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:6681") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:36920->172.17.0.4:6681, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:41419") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:54802->172.17.0.4:41419, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:708: testing "．．" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:13591") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:57090->172.17.0.4:13591, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:53348") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:42234->172.17.0.4:53348, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:64172") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:37302->172.17.0.4:64172, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:38350") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:37500->172.17.0.4:38350, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:708: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:6835") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:37750->172.17.0.4:6835, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:15983") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:37674->172.17.0.4:15983, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:51287") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:49184->172.17.0.4:51287, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:30071") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:54820->172.17.0.4:30071, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:708: testing " leading space" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:15988") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:37790->172.17.0.4:15988, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:64886") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:54832->172.17.0.4:64886, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:23934") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:38740->172.17.0.4:23934, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:21421") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:40680->172.17.0.4:21421, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:708: testing "~leading tilde" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:6998") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:48826->172.17.0.4:6998, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:54220") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:50636->172.17.0.4:54220, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:31507") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:40942->172.17.0.4:31507, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:31304") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:57876->172.17.0.4:31304, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:708: testing "␍leading CR" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:45813") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:55610->172.17.0.4:45813, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:4496") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:48254->172.17.0.4:4496, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:38072") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:35846->172.17.0.4:38072, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:18410") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:35268->172.17.0.4:18410, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:708: testing "␊leading LF" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:21012") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:46840->172.17.0.4:21012, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:10397") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:52076->172.17.0.4:10397, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:26745") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:47750->172.17.0.4:26745, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:36417") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:37764->172.17.0.4:36417, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:708: testing "␉leading HT" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:46731") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:56290->172.17.0.4:46731, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:13367") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:44100->172.17.0.4:13367, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:2683") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:42670->172.17.0.4:2683, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:45995") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:56054->172.17.0.4:45995, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:708: testing "␋leading VT" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:1523") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:54450->172.17.0.4:1523, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:8340") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:42386->172.17.0.4:8340, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:21880") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:40056->172.17.0.4:21880, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:14090") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:43948->172.17.0.4:14090, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:708: testing ".leading dot" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:60665") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:53384->172.17.0.4:60665, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:20517") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:53012->172.17.0.4:20517, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:51417") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:51576->172.17.0.4:51417, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:1965") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:35558->172.17.0.4:1965, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:708: testing "trailing space " 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:35477") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:41666->172.17.0.4:35477, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:37169") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:39756->172.17.0.4:37169, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:31013") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:50018->172.17.0.4:31013, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:50442") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:58452->172.17.0.4:50442, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:708: testing "trailing CR␍" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:36520") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:60668->172.17.0.4:36520, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:53923") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:56998->172.17.0.4:53923, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:6328") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:46876->172.17.0.4:6328, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:42494") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:59742->172.17.0.4:42494, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:708: testing "trailing LF␊" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:42608") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:58110->172.17.0.4:42608, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:36812") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:44824->172.17.0.4:36812, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:8263") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:36494->172.17.0.4:8263, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:22887") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:33742->172.17.0.4:22887, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:708: testing "trailing HT␉" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:40285") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:51604->172.17.0.4:40285, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:45312") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:60458->172.17.0.4:45312, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:40273") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:55996->172.17.0.4:40273, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:60273") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:57508->172.17.0.4:60273, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:708: testing "trailing VT␋" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:54685") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:58630->172.17.0.4:54685, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:1483") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:57918->172.17.0.4:1483, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:31156") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:47680->172.17.0.4:31156, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:35882") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:33020->172.17.0.4:35882, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:708: testing "trailing dot." 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:13827") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:58046->172.17.0.4:13827, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:32815") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:52074->172.17.0.4:32815, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:16343") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:41564->172.17.0.4:16343, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:14326") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:35796->172.17.0.4:14326, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:708: testing "invalid utf-8\xfe" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:40132") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:45818->172.17.0.4:40132, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:37199") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:40292->172.17.0.4:37199, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:27393") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:36890->172.17.0.4:27393, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:35262") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:47874->172.17.0.4:35262, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:708: testing "test%46.txt" 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:56692") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:44092->172.17.0.4:56692, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:13275") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:59316->172.17.0.4:13275, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:36204") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:35902->172.17.0.4:36204, err= 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:26635") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:39478->172.17.0.4:26635, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:49420") 2026/05/22 01:36:17 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:32842->172.17.0.4:49420, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: Connecting to FTP server 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:21") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:51950->172.17.0.4:21, err= 2026/05/22 01:36:18 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:45423") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:57166->172.17.0.4:45423, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:10881") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:45558->172.17.0.4:10881, 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/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:2285") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:57568->172.17.0.4:2285, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:32331") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:54614->172.17.0.4:32331, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:36108") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:60226->172.17.0.4:36108, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:42257") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:37816->172.17.0.4:42257, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:37034") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:41744->172.17.0.4:37034, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:51796") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:52740->172.17.0.4:51796, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:20667") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:44604->172.17.0.4:20667, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:49226") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:42752->172.17.0.4:49226, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:40493") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:57036->172.17.0.4:40493, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:49294") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:37978->172.17.0.4:49294, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:45489") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:57294->172.17.0.4:45489, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:2201") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:47862->172.17.0.4:2201, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:45404") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:54768->172.17.0.4:45404, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:7378") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:32988->172.17.0.4:7378, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:40969") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:58750->172.17.0.4:40969, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:50004") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:33236->172.17.0.4:50004, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:53890") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:48922->172.17.0.4:53890, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/05/22 01:36:18 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/05/22 01:36:18 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/22 01:36:18 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:18 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:18 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:18 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:18 DEBUG : TestFTPProftpd: detected overridden config - adding "{pVdCF}" suffix to name 2026/05/22 01:36:18 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:18 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:18 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:18 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:51952->172.17.0.4:21, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:64462") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:38054->172.17.0.4:64462, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:24525") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:57398->172.17.0.4:24525, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:49774") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:43266->172.17.0.4:49774, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:31371") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:57756->172.17.0.4:31371, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:1665") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:46844->172.17.0.4:1665, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:27216") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:33314->172.17.0.4:27216, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:5428") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:40360->172.17.0.4:5428, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:1841") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:46716->172.17.0.4:1841, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:61473") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:53400->172.17.0.4:61473, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:36171") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:36534->172.17.0.4:36171, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1126: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:29335") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:56968->172.17.0.4:29335, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:3247") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:49728->172.17.0.4:3247, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:35748") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:53078->172.17.0.4:35748, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:9223") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:50940->172.17.0.4:9223, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:13104") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:55088->172.17.0.4:13104, 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/22 01:36:18 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hudibad6hiwa/hello? sausage/êé" 2026/05/22 01:36:18 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/22 01:36:18 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:18 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:18 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:18 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:18 DEBUG : TestFTPProftpd: detected overridden config - adding "{pVdCF}" suffix to name 2026/05/22 01:36:18 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:18 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:18 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:18 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: Connecting to FTP server 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:51962->172.17.0.4:21, err= 2026/05/22 01:36:18 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-hudibad6hiwa/hello? sausage/êé" to be canonical "TestFTPProftpd{pVdCF}:rclone-test-hudibad6hiwa/hello? sausage/êé" 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:32261") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:58886->172.17.0.4:32261, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:24409") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:56072->172.17.0.4:24409, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: Connecting to FTP server 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:46721") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:57260->172.17.0.4:46721, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:51972->172.17.0.4:21, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:7938") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:48738->172.17.0.4:7938, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:20036") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:34314->172.17.0.4:20036, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:48104") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:43202->172.17.0.4:48104, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:5968") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:46766->172.17.0.4:5968, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:14470") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:45982->172.17.0.4:14470, err= 2026/05/22 01:36:18 DEBUG : Waiting for deletions to finish 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:2541") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:35078->172.17.0.4:2541, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:1095") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:33004->172.17.0.4:1095, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:25081") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:59442->172.17.0.4:25081, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:33505") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:60330->172.17.0.4:33505, err= 2026/05/22 01:36:18 INFO : a/b/c/d/e.txt: Deleted 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:11697") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:41766->172.17.0.4:11697, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:48783") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:60454->172.17.0.4:48783, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:20388") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:42872->172.17.0.4:20388, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: dial("tcp","172.17.0.4:43895") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé: > dial: conn=172.17.0.1:44438->172.17.0.4:43895, err= 2026/05/22 01:36:18 DEBUG : removing 1 level 4 directories 2026/05/22 01:36:18 INFO : a/b/c/d: Removing directory 2026/05/22 01:36:18 DEBUG : removing 1 level 3 directories 2026/05/22 01:36:18 INFO : a/b/c: Removing directory 2026/05/22 01:36:18 DEBUG : removing 1 level 2 directories 2026/05/22 01:36:18 INFO : a/b: Removing directory 2026/05/22 01:36:18 DEBUG : removing 1 level 1 directories 2026/05/22 01:36:18 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1259: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:37009") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:42512->172.17.0.4:37009, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:40531") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:60548->172.17.0.4:40531, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:48188") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:47314->172.17.0.4:48188, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:13732") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:46570->172.17.0.4:13732, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:12030") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:34432->172.17.0.4:12030, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:34450") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:52836->172.17.0.4:34450, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: Connecting to FTP server 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:21") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:33375") 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:40988->172.17.0.4:33375, err= 2026/05/22 01:36:18 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:51984->172.17.0.4:21, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:52850") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:55442->172.17.0.4:52850, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:60232") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:59048->172.17.0.4:60232, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:7285") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:58832->172.17.0.4:7285, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:9409") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:50308->172.17.0.4:9409, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:28294") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:51374->172.17.0.4:28294, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:17135") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:58704->172.17.0.4:17135, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:49837") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:60232->172.17.0.4:49837, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:40186") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:42686->172.17.0.4:40186, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:62016") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:36008->172.17.0.4:62016, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:10587") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:59962->172.17.0.4:10587, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:20907") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:48982->172.17.0.4:20907, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:61515") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:48032->172.17.0.4:61515, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:31785") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:48606->172.17.0.4:31785, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:46541") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:60754->172.17.0.4:46541, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:17501") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:46842->172.17.0.4:17501, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:50532") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:40650->172.17.0.4:50532, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1407: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/05/22 01:36:19 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-jetacuk0zeji" 2026/05/22 01:36:19 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/22 01:36:19 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:19 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:19 DEBUG : TestFTPProftpd: detected overridden config - adding "{pVdCF}" suffix to name 2026/05/22 01:36:19 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:19 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: Connecting to FTP server 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: dial("tcp","172.17.0.4:21") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: > dial: conn=172.17.0.1:52000->172.17.0.4:21, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:46996") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:52514->172.17.0.4:46996, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: dial("tcp","172.17.0.4:20476") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: > dial: conn=172.17.0.1:53926->172.17.0.4:20476, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: dial("tcp","172.17.0.4:13245") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: > dial: conn=172.17.0.1:57048->172.17.0.4:13245, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: dial("tcp","172.17.0.4:25196") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: > dial: conn=172.17.0.1:39132->172.17.0.4:25196, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: dial("tcp","172.17.0.4:55945") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: > dial: conn=172.17.0.1:37636->172.17.0.4:55945, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: dial("tcp","172.17.0.4:63446") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: > dial: conn=172.17.0.1:45174->172.17.0.4:63446, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: dial("tcp","172.17.0.4:27370") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: > dial: conn=172.17.0.1:55500->172.17.0.4:27370, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: dial("tcp","172.17.0.4:41101") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: > dial: conn=172.17.0.1:55370->172.17.0.4:41101, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:45984") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:49386->172.17.0.4:45984, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:8828") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:40902->172.17.0.4:8828, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:34896") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:59868->172.17.0.4:34896, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:5754") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:57400->172.17.0.4:5754, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:9523") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:56186->172.17.0.4:9523, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: dial("tcp","172.17.0.4:44321") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: > dial: conn=172.17.0.1:34142->172.17.0.4:44321, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: dial("tcp","172.17.0.4:30936") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: > dial: conn=172.17.0.1:35188->172.17.0.4:30936, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: dial("tcp","172.17.0.4:11142") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: > dial: conn=172.17.0.1:44156->172.17.0.4:11142, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: dial("tcp","172.17.0.4:21905") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: > dial: conn=172.17.0.1:42472->172.17.0.4:21905, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: Purge dir "new_name" 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-jetacuk0zeji: 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/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:36446") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:50340->172.17.0.4:36446, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:39923") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:37584->172.17.0.4:39923, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:6741") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:58000->172.17.0.4:6741, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:30224") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:46080->172.17.0.4:30224, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:55774") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:43040->172.17.0.4:55774, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:65243") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:51938->172.17.0.4:65243, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:10164") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:32794->172.17.0.4:10164, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:56416") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:52106->172.17.0.4:56416, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:5137") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:48128->172.17.0.4:5137, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/05/22 01:36:19 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hudibad6hiwa/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/05/22 01:36:19 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/22 01:36:19 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:19 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:19 DEBUG : TestFTPProftpd: detected overridden config - adding "{pVdCF}" suffix to name 2026/05/22 01:36:19 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:19 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:52010->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:16199") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:36198->172.17.0.4:16199, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/05/22 01:36:19 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hudibad6hiwa/not found.txt" 2026/05/22 01:36:19 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/22 01:36:19 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:19 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:19 DEBUG : TestFTPProftpd: detected overridden config - adding "{pVdCF}" suffix to name 2026/05/22 01:36:19 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:19 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/not found.txt: Connecting to FTP server 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/not found.txt: dial("tcp","172.17.0.4:21") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/not found.txt: > dial: conn=172.17.0.1:52022->172.17.0.4:21, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/not found.txt: dial("tcp","172.17.0.4:12015") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/not found.txt: > dial: conn=172.17.0.1:32796->172.17.0.4:12015, err= 2026/05/22 01:36:19 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1920: Opening root remote "TestFTPProftpd:" path "rclone-test-hudibad6hiwa" from "TestFTPProftpd:rclone-test-hudibad6hiwa" 2026/05/22 01:36:19 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/05/22 01:36:19 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/22 01:36:19 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:19 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:19 DEBUG : TestFTPProftpd: detected overridden config - adding "{pVdCF}" suffix to name 2026/05/22 01:36:19 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:19 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:52036->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:19607") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:55396->172.17.0.4:19607, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:46176") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:35224->172.17.0.4:46176, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:23999") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56336->172.17.0.4:23999, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:10046") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:46618->172.17.0.4:10046, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:15545") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34920->172.17.0.4:15545, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:19612") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:53346->172.17.0.4:19612, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1957: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:59340") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:57482->172.17.0.4:59340, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37896") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:60288->172.17.0.4:37896, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:46404") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58162->172.17.0.4:46404, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:52133") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:35498->172.17.0.4:52133, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37748") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:54940->172.17.0.4:37748, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:62912") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:53640->172.17.0.4:62912, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:2218") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:52112->172.17.0.4:2218, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:52864") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:59844->172.17.0.4:52864, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:23983") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:49442->172.17.0.4:23983, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:14078") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:52876->172.17.0.4:14078, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37722") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:40862->172.17.0.4:37722, 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/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:65328") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:39440->172.17.0.4:65328, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:10982") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:39970->172.17.0.4:10982, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:3726") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:54228->172.17.0.4:3726, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:52354") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:37072->172.17.0.4:52354, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:63659") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:38564->172.17.0.4:63659, 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/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:22835") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:52402->172.17.0.4:22835, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:40284") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:37132->172.17.0.4:40284, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/05/22 01:36:19 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-hudibad6hiwa" 2026/05/22 01:36:19 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/22 01:36:19 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:19 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:19 DEBUG : TestFTPProftpd: detected overridden config - adding "{o7qUS}" suffix to name 2026/05/22 01:36:19 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:19 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: Connecting to FTP server 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:21") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:52040->172.17.0.4:21, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:15127") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:55652->172.17.0.4:15127, 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/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:42177") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:38448->172.17.0.4:42177, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:49269") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:43708->172.17.0.4:49269, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:39293") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:34064->172.17.0.4:39293, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/05/22 01:36:19 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hudibad6hiwa/deeper/nonexisting/directory" 2026/05/22 01:36:19 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/05/22 01:36:19 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:19 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:19 DEBUG : TestFTPProftpd: detected overridden config - adding "{pVdCF}" suffix to name 2026/05/22 01:36:19 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/05/22 01:36:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/05/22 01:36:19 DEBUG : Setting pass="w2JcoKmAZrNuJQsk8BbefAgMIEv6F1vZATVw8Mw4bHXOFg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/05/22 01:36:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/deeper/nonexisting/directory: Connecting to FTP server 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa/deeper/nonexisting/directory: > dial: conn=172.17.0.1:52056->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/22 01:36:19 DEBUG : Waiting for deletions to finish 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:46363") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:44510->172.17.0.4:46363, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:54577") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:44434->172.17.0.4:54577, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:1229") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:38880->172.17.0.4:1229, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:10497") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:46000->172.17.0.4:10497, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:29627") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:58542->172.17.0.4:29627, err= 2026/05/22 01:36:19 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:47493") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:58354->172.17.0.4:47493, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:62018") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:40896->172.17.0.4:62018, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:2147") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:37802->172.17.0.4:2147, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:39470") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:59460->172.17.0.4:39470, err= 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:46483") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:34752->172.17.0.4:46483, err= 2026/05/22 01:36:19 DEBUG : removing 1 level 4 directories 2026/05/22 01:36:19 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/05/22 01:36:19 DEBUG : removing 1 level 3 directories 2026/05/22 01:36:19 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/05/22 01:36:19 DEBUG : removing 1 level 2 directories 2026/05/22 01:36:19 INFO : hello? sausage/êé: Removing directory 2026/05/22 01:36:19 DEBUG : removing 1 level 1 directories 2026/05/22 01:36:19 INFO : hello? sausage: Removing directory 2026/05/22 01:36:19 DEBUG : removing 1 level 0 directories 2026/05/22 01:36:19 INFO : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: Removing directory 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:22489") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:56014->172.17.0.4:22489, err= 2026/05/22 01:36:19 ERROR : error listing: directory not found 2026/05/22 01:36:19 DEBUG : Waiting for deletions to finish 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:26962") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:39430->172.17.0.4:26962, err= 2026/05/22 01:36:19 ERROR : error listing: directory not found 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: dial("tcp","172.17.0.4:49312") 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: > dial: conn=172.17.0.1:52704->172.17.0.4:49312, err= 2026/05/22 01:36:19 ERROR : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: Failed to list "": directory not found 2026/05/22 01:36:19 DEBUG : removing 1 level 0 directories 2026/05/22 01:36:19 INFO : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: Removing directory 2026/05/22 01:36:19 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/05/22 01:36:19 DEBUG : ftp://172.17.0.4:21/rclone-test-hudibad6hiwa: closing 2 unused connections 2026/05/22 01:36:19 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (3.57s) --- 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.29s) --- 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.16s) --- 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.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.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.05s) --- 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.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.03s) --- 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.04s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.69s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.69s) --- 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.585s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 4.39384369s (try 1/5)