"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestCommandEncodingNeutralisesCRLF --- PASS: TestCommandEncodingNeutralisesCRLF (0.00s) === RUN TestIntegration fstests.go:464: Using remote "TestFTPProftpd:" 2026/09/10 03:41:25 NOTICE: TestFTPProftpd: Starting server 2026/09/10 03:41:26 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.4:21" try 1/100 2026/09/10 03:41:26 DEBUG : TestFTPProftpd: Read 1, error: 2026/09/10 03:41:26 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.4:21" 2026/09/10 03:41:26 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-mizazaz9mayo" 2026/09/10 03:41:26 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/09/10 03:41:26 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/10 03:41:26 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:26 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:26 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:26 DEBUG : TestFTPProftpd: detected overridden config - adding "{euAi9}" suffix to name 2026/09/10 03:41:26 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:26 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:26 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:26 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: Connecting to FTP server 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:21") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:39246->172.17.0.4:21, err= 2026/09/10 03:41:26 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:505: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:533: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:12940") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:45534->172.17.0.4:12940, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:57100") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:58886->172.17.0.4:57100, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/09/10 03:41:26 INFO : dir/subdir: Making directory 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:3488") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:52954->172.17.0.4:3488, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:10074") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:43028->172.17.0.4:10074, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:22763") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:42504->172.17.0.4:22763, err= 2026/09/10 03:41:26 INFO : dir/subdir: Removing directory 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:56506") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:32890->172.17.0.4:56506, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:21561") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:57728->172.17.0.4:21561, err= 2026/09/10 03:41:26 INFO : dir: Removing directory 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:39246") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:55998->172.17.0.4:39246, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:36913") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:56236->172.17.0.4:36913, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:45470") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:42536->172.17.0.4:45470, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:50884") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:49700->172.17.0.4:50884, err= 2026/09/10 03:41:26 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:29089") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:56292->172.17.0.4:29089, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:734: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:8295") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:48750->172.17.0.4:8295, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:45934") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:52796->172.17.0.4:45934, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:49273") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:58122->172.17.0.4:49273, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:20290") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:41348->172.17.0.4:20290, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:734: testing "．" 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:7832") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:38926->172.17.0.4:7832, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:28697") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:45024->172.17.0.4:28697, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:47669") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:56660->172.17.0.4:47669, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:54290") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:45570->172.17.0.4:54290, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:734: testing "．．" 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:13930") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:43498->172.17.0.4:13930, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:53622") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:36096->172.17.0.4:53622, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:35661") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:50534->172.17.0.4:35661, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:29239") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:58316->172.17.0.4:29239, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:734: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:63007") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:53128->172.17.0.4:63007, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:47598") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:39278->172.17.0.4:47598, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:33974") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:50504->172.17.0.4:33974, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:1385") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:42228->172.17.0.4:1385, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:734: testing " leading space" 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:18078") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:54124->172.17.0.4:18078, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:63237") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:37678->172.17.0.4:63237, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:24178") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:53978->172.17.0.4:24178, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:29995") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:59362->172.17.0.4:29995, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:734: testing "~leading tilde" 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:54803") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:47592->172.17.0.4:54803, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:26642") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:52122->172.17.0.4:26642, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:39046") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:42876->172.17.0.4:39046, err= 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:12031") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:47998->172.17.0.4:12031, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:734: testing "␍leading CR" 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:17613") 2026/09/10 03:41:26 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:37044->172.17.0.4:17613, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:59584") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:41698->172.17.0.4:59584, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:50253") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:48352->172.17.0.4:50253, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:53503") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:33070->172.17.0.4:53503, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:734: testing "␊leading LF" 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:39519") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:38726->172.17.0.4:39519, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:35603") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:33754->172.17.0.4:35603, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:17058") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:46820->172.17.0.4:17058, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:46791") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:56826->172.17.0.4:46791, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:734: testing "␉leading HT" 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:16002") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:44890->172.17.0.4:16002, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:65307") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:41404->172.17.0.4:65307, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:1546") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:38650->172.17.0.4:1546, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:22810") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:41444->172.17.0.4:22810, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:734: testing "␋leading VT" 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:28470") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:55784->172.17.0.4:28470, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:48192") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:37110->172.17.0.4:48192, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:11566") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:46302->172.17.0.4:11566, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:41377") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:44140->172.17.0.4:41377, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:734: testing ".leading dot" 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:36280") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:42476->172.17.0.4:36280, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:46204") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:40912->172.17.0.4:46204, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:5082") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:37464->172.17.0.4:5082, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:33752") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:41604->172.17.0.4:33752, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:734: testing "trailing space " 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:28267") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:59908->172.17.0.4:28267, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:38032") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:37534->172.17.0.4:38032, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:34114") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:41540->172.17.0.4:34114, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:45322") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:58194->172.17.0.4:45322, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:734: testing "trailing CR␍" 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:35734") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:46906->172.17.0.4:35734, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:57268") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:50078->172.17.0.4:57268, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:9783") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:36872->172.17.0.4:9783, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:25002") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:56032->172.17.0.4:25002, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:734: testing "trailing LF␊" 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:18376") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:57766->172.17.0.4:18376, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:47805") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:60770->172.17.0.4:47805, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:36010") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:43748->172.17.0.4:36010, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:34965") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:45938->172.17.0.4:34965, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:734: testing "trailing HT␉" 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:41855") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:33812->172.17.0.4:41855, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:20729") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:53798->172.17.0.4:20729, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:22934") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:47102->172.17.0.4:22934, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:15840") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:40824->172.17.0.4:15840, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:734: testing "trailing VT␋" 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:55308") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:48244->172.17.0.4:55308, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:38968") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:52438->172.17.0.4:38968, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:61607") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:35658->172.17.0.4:61607, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:5775") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:36370->172.17.0.4:5775, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:734: testing "trailing dot." 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:38741") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:53724->172.17.0.4:38741, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:62130") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:56722->172.17.0.4:62130, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:27562") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:46610->172.17.0.4:27562, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:1677") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:38226->172.17.0.4:1677, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:734: testing "invalid utf-8\xfe" 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:44788") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:49292->172.17.0.4:44788, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:38105") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:38178->172.17.0.4:38105, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:42030") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:39244->172.17.0.4:42030, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:15533") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:45826->172.17.0.4:15533, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:734: testing "test%46.txt" 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:18774") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:44040->172.17.0.4:18774, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:46088") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:42184->172.17.0.4:46088, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:48261") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:45222->172.17.0.4:48261, err= 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:46017") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:39734->172.17.0.4:46017, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:18585") 2026/09/10 03:41:27 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:35972->172.17.0.4:18585, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: Connecting to FTP server 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:21") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:39252->172.17.0.4:21, err= 2026/09/10 03:41:28 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:7305") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:54654->172.17.0.4:7305, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:3809") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:59026->172.17.0.4:3809, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:813: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:846: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:899: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:20588") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:58432->172.17.0.4:20588, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:36678") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:49396->172.17.0.4:36678, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:34295") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:54200->172.17.0.4:34295, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:39847") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:39940->172.17.0.4:39847, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:37872") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:41498->172.17.0.4:37872, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:64954") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:43310->172.17.0.4:64954, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:24826") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:55448->172.17.0.4:24826, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:27158") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:47520->172.17.0.4:27158, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:32645") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:49650->172.17.0.4:32645, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:58733") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:38428->172.17.0.4:58733, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:13286") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:53004->172.17.0.4:13286, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:31130") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:46996->172.17.0.4:31130, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:19032") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:59182->172.17.0.4:19032, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:1384") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:51132->172.17.0.4:1384, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:18403") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:48500->172.17.0.4:18403, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:53016") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:40542->172.17.0.4:53016, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:2878") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:47684->172.17.0.4:2878, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/09/10 03:41:28 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/09/10 03:41:28 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/10 03:41:28 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:28 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:28 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{euAi9}" suffix to name 2026/09/10 03:41:28 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:28 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:28 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:39266->172.17.0.4:21, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:8357") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:57492->172.17.0.4:8357, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:64297") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:34170->172.17.0.4:64297, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:46400") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:44604->172.17.0.4:46400, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:32039") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:44854->172.17.0.4:32039, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:31882") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:37398->172.17.0.4:31882, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:5813") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:51838->172.17.0.4:5813, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:31766") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:49254->172.17.0.4:31766, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:20194") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:55050->172.17.0.4:20194, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:22212") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:34462->172.17.0.4:22212, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:52601") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:46606->172.17.0.4:52601, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1152: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:22632") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:54464->172.17.0.4:22632, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:44303") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:43716->172.17.0.4:44303, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:13259") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:56952->172.17.0.4:13259, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:28914") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:40896->172.17.0.4:28914, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:47088") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:55464->172.17.0.4:47088, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1184: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1221: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/09/10 03:41:28 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-mizazaz9mayo/hello? sausage/êé" 2026/09/10 03:41:28 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/10 03:41:28 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:28 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:28 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{euAi9}" suffix to name 2026/09/10 03:41:28 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:28 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:28 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: Connecting to FTP server 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:39282->172.17.0.4:21, err= 2026/09/10 03:41:28 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-mizazaz9mayo/hello? sausage/êé" to be canonical "TestFTPProftpd{euAi9}:rclone-test-mizazaz9mayo/hello? sausage/êé" 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:64017") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:54078->172.17.0.4:64017, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:42907") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:53898->172.17.0.4:42907, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: Connecting to FTP server 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:39294->172.17.0.4:21, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:31750") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:34640->172.17.0.4:31750, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:65058") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:57154->172.17.0.4:65058, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:9319") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:41876->172.17.0.4:9319, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:53466") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:57904->172.17.0.4:53466, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:51494") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:41860->172.17.0.4:51494, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:9961") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:44326->172.17.0.4:9961, err= 2026/09/10 03:41:28 DEBUG : Waiting for deletions to finish 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:2481") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:53464->172.17.0.4:2481, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:40387") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:41578->172.17.0.4:40387, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:24786") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:46524->172.17.0.4:24786, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:60304") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:45286->172.17.0.4:60304, err= 2026/09/10 03:41:28 INFO : a/b/c/d/e.txt: Deleted 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:4220") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:35888->172.17.0.4:4220, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:50390") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:36798->172.17.0.4:50390, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:60690") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:54070->172.17.0.4:60690, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: dial("tcp","172.17.0.4:64271") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé: > dial: conn=172.17.0.1:44498->172.17.0.4:64271, err= 2026/09/10 03:41:28 DEBUG : removing 1 level 4 directories 2026/09/10 03:41:28 INFO : a/b/c/d: Removing directory 2026/09/10 03:41:28 DEBUG : removing 1 level 3 directories 2026/09/10 03:41:28 INFO : a/b/c: Removing directory 2026/09/10 03:41:28 DEBUG : removing 1 level 2 directories 2026/09/10 03:41:28 INFO : a/b: Removing directory 2026/09/10 03:41:28 DEBUG : removing 1 level 1 directories 2026/09/10 03:41:28 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1285: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:32823") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:43592->172.17.0.4:32823, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:64569") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:35576->172.17.0.4:64569, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:15849") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:58286->172.17.0.4:15849, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:7136") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:52674->172.17.0.4:7136, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:36906") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:34808->172.17.0.4:36906, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:15268") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:54476->172.17.0.4:15268, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: Connecting to FTP server 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:21") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:39308->172.17.0.4:21, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:30938") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:52654->172.17.0.4:30938, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:27694") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:34102->172.17.0.4:27694, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:63041") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:44924->172.17.0.4:63041, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:33143") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:37276->172.17.0.4:33143, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:46889") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:40682->172.17.0.4:46889, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:58986") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:36984->172.17.0.4:58986, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:24136") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:37406->172.17.0.4:24136, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:31567") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:37066->172.17.0.4:31567, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:10792") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:40228->172.17.0.4:10792, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:11282") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:58812->172.17.0.4:11282, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:12485") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:54086->172.17.0.4:12485, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:4441") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:45304->172.17.0.4:4441, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:42145") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:33936->172.17.0.4:42145, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:52007") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:38974->172.17.0.4:52007, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:11152") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:40010->172.17.0.4:11152, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:56260") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:57940->172.17.0.4:56260, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:29864") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:59370->172.17.0.4:29864, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1437: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/09/10 03:41:28 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-qanuvaz6defo" 2026/09/10 03:41:28 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/10 03:41:28 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:28 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:28 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{euAi9}" suffix to name 2026/09/10 03:41:28 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:28 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:28 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: Connecting to FTP server 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: dial("tcp","172.17.0.4:21") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: > dial: conn=172.17.0.1:39322->172.17.0.4:21, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:28818") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:38228->172.17.0.4:28818, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: dial("tcp","172.17.0.4:47257") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: > dial: conn=172.17.0.1:41276->172.17.0.4:47257, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: dial("tcp","172.17.0.4:24665") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: > dial: conn=172.17.0.1:50318->172.17.0.4:24665, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: dial("tcp","172.17.0.4:19831") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: > dial: conn=172.17.0.1:42600->172.17.0.4:19831, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: dial("tcp","172.17.0.4:35070") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: > dial: conn=172.17.0.1:33618->172.17.0.4:35070, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: dial("tcp","172.17.0.4:30014") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: > dial: conn=172.17.0.1:49022->172.17.0.4:30014, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: dial("tcp","172.17.0.4:21294") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: > dial: conn=172.17.0.1:58314->172.17.0.4:21294, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: dial("tcp","172.17.0.4:5490") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: > dial: conn=172.17.0.1:48024->172.17.0.4:5490, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:29627") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:56886->172.17.0.4:29627, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:36163") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:52216->172.17.0.4:36163, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:13007") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:51276->172.17.0.4:13007, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:37955") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:50102->172.17.0.4:37955, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:28627") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:39330->172.17.0.4:28627, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: dial("tcp","172.17.0.4:11903") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: > dial: conn=172.17.0.1:40758->172.17.0.4:11903, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: dial("tcp","172.17.0.4:40018") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: > dial: conn=172.17.0.1:38308->172.17.0.4:40018, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: dial("tcp","172.17.0.4:28334") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: > dial: conn=172.17.0.1:46978->172.17.0.4:28334, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: dial("tcp","172.17.0.4:13942") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: > dial: conn=172.17.0.1:37096->172.17.0.4:13942, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: Purge dir "new_name" 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-qanuvaz6defo: 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:1633: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1664: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1735: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:10492") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:47028->172.17.0.4:10492, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:44023") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:59338->172.17.0.4:44023, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:59485") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:42598->172.17.0.4:59485, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:54778") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:49878->172.17.0.4:54778, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:15281") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:58228->172.17.0.4:15281, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:53513") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:48912->172.17.0.4:53513, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:6498") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:53970->172.17.0.4:6498, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:33475") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:38204->172.17.0.4:33475, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:34248") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:49788->172.17.0.4:34248, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:10254") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:34438->172.17.0.4:10254, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:54059") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:49596->172.17.0.4:54059, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:14144") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:59288->172.17.0.4:14144, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:14942") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:39630->172.17.0.4:14942, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:30730") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:54884->172.17.0.4:30730, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:6985") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:45436->172.17.0.4:6985, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:5035") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:60226->172.17.0.4:5035, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/09/10 03:41:28 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-mizazaz9mayo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/09/10 03:41:28 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/10 03:41:28 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:28 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:28 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{euAi9}" suffix to name 2026/09/10 03:41:28 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:28 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:28 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:39334->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:22161") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:37368->172.17.0.4:22161, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/09/10 03:41:28 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-mizazaz9mayo/not found.txt" 2026/09/10 03:41:28 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/10 03:41:28 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:28 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:28 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{euAi9}" suffix to name 2026/09/10 03:41:28 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:28 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:28 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/not found.txt: Connecting to FTP server 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/not found.txt: dial("tcp","172.17.0.4:21") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/not found.txt: > dial: conn=172.17.0.1:39342->172.17.0.4:21, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/not found.txt: dial("tcp","172.17.0.4:31527") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/not found.txt: > dial: conn=172.17.0.1:50448->172.17.0.4:31527, err= 2026/09/10 03:41:28 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1994: Opening root remote "TestFTPProftpd:" path "rclone-test-mizazaz9mayo" from "TestFTPProftpd:rclone-test-mizazaz9mayo" 2026/09/10 03:41:28 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/09/10 03:41:28 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/10 03:41:28 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:28 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:28 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{euAi9}" suffix to name 2026/09/10 03:41:28 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:28 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:28 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:39348->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:5879") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:51758->172.17.0.4:5879, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:51706") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37476->172.17.0.4:51706, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:13427") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:33300->172.17.0.4:13427, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:17057") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:49082->172.17.0.4:17057, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:29015") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34508->172.17.0.4:29015, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:47203") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:42124->172.17.0.4:47203, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2031: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35828") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:59292->172.17.0.4:35828, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:39297") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:33552->172.17.0.4:39297, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:23149") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56762->172.17.0.4:23149, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:63071") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58916->172.17.0.4:63071, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:7739") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44692->172.17.0.4:7739, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:49393") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58470->172.17.0.4:49393, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:64383") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:49466->172.17.0.4:64383, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:44048") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:60158->172.17.0.4:44048, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:26180") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:48354->172.17.0.4:26180, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:1451") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:59754->172.17.0.4:1451, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:50612") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:59116->172.17.0.4:50612, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2090: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:438: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2195: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2211: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:36470") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:50318->172.17.0.4:36470, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:24823") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:55434->172.17.0.4:24823, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:61832") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:34188->172.17.0.4:61832, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:12143") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:39144->172.17.0.4:12143, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:35753") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:34276->172.17.0.4:35753, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2367: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:15238") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:56970->172.17.0.4:15238, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:27187") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:38696->172.17.0.4:27187, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/09/10 03:41:28 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-mizazaz9mayo" 2026/09/10 03:41:28 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/10 03:41:28 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:28 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:28 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{u-gu-}" suffix to name 2026/09/10 03:41:28 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:28 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:28 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: Connecting to FTP server 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:21") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:39350->172.17.0.4:21, err= 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:52430") 2026/09/10 03:41:28 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:46332->172.17.0.4:52430, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2452: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutRetry === RUN TestIntegration/FsMkdir/FsPutRetry/Simple === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:9556") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:47676->172.17.0.4:9556, err= fstests.go:2655: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:2121") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:52726->172.17.0.4:2121, err= fstests.go:2655: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Chunked fstests.go:2697: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:63643") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:44804->172.17.0.4:63643, err= === RUN TestIntegration/FsMkdir/FsPutShortEOF/Chunked fstests.go:2828: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2870: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:48863") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:48342->172.17.0.4:48863, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:40611") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:39204->172.17.0.4:40611, err= 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:61303") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:59464->172.17.0.4:61303, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/09/10 03:41:29 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-mizazaz9mayo/deeper/nonexisting/directory" 2026/09/10 03:41:29 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/10 03:41:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{euAi9}" suffix to name 2026/09/10 03:41:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/10 03:41:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/10 03:41:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/10 03:41:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/deeper/nonexisting/directory: Connecting to FTP server 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo/deeper/nonexisting/directory: > dial: conn=172.17.0.1:39356->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:3019: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:3062: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:3119: FS has no Directory methods and doesn't Wrap 2026/09/10 03:41:29 DEBUG : Waiting for deletions to finish 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:45529") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:32858->172.17.0.4:45529, err= 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:41356") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:38996->172.17.0.4:41356, err= 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:5688") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:57310->172.17.0.4:5688, err= 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:62677") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:33988->172.17.0.4:62677, err= 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:18988") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:50408->172.17.0.4:18988, err= 2026/09/10 03:41:29 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:11617") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:42266->172.17.0.4:11617, err= 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:18720") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:34048->172.17.0.4:18720, err= 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:47468") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:54514->172.17.0.4:47468, err= 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:32358") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:55042->172.17.0.4:32358, err= 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:34049") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:33354->172.17.0.4:34049, err= 2026/09/10 03:41:29 DEBUG : removing 1 level 4 directories 2026/09/10 03:41:29 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/09/10 03:41:29 DEBUG : removing 1 level 3 directories 2026/09/10 03:41:29 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/09/10 03:41:29 DEBUG : removing 1 level 2 directories 2026/09/10 03:41:29 INFO : hello? sausage/êé: Removing directory 2026/09/10 03:41:29 DEBUG : removing 1 level 1 directories 2026/09/10 03:41:29 INFO : hello? sausage: Removing directory 2026/09/10 03:41:29 DEBUG : removing 1 level 0 directories 2026/09/10 03:41:29 INFO : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: Removing directory 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:25861") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:51224->172.17.0.4:25861, err= 2026/09/10 03:41:29 ERROR : error listing: directory not found 2026/09/10 03:41:29 DEBUG : Waiting for deletions to finish 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:51107") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:56532->172.17.0.4:51107, err= 2026/09/10 03:41:29 ERROR : error listing: directory not found 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: dial("tcp","172.17.0.4:12871") 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: > dial: conn=172.17.0.1:32810->172.17.0.4:12871, err= 2026/09/10 03:41:29 ERROR : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: Failed to list "": directory not found 2026/09/10 03:41:29 DEBUG : removing 1 level 0 directories 2026/09/10 03:41:29 INFO : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: Removing directory 2026/09/10 03:41:29 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/09/10 03:41:29 DEBUG : ftp://172.17.0.4:21/rclone-test-mizazaz9mayo: closing 2 unused connections 2026/09/10 03:41:29 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (3.87s) --- 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.57s) --- 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.21s) --- 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.26s) --- 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.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (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.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.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutRetry (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/NetError (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Chunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Simple (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutShortEOF/Chunked (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.884s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 4.940990648s (try 1/5)