"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/06 03:52:07 NOTICE: TestFTPProftpd: Starting server 2026/09/06 03:52:08 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.5:21" try 1/100 2026/09/06 03:52:08 DEBUG : TestFTPProftpd: Read 1, error: 2026/09/06 03:52:08 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.5:21" 2026/09/06 03:52:08 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-porozed6vete" 2026/09/06 03:52:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/09/06 03:52:08 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/06 03:52:08 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:08 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:08 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:08 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:08 DEBUG : TestFTPProftpd: detected overridden config - adding "{JGfzK}" suffix to name 2026/09/06 03:52:08 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:08 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:08 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:08 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: Connecting to FTP server 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:21") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:40324->172.17.0.5:21, err= 2026/09/06 03:52:08 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/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:5055") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:40062->172.17.0.5:5055, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:13752") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:52818->172.17.0.5:13752, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/09/06 03:52:08 INFO : dir/subdir: Making directory 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:3371") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:54414->172.17.0.5:3371, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:29715") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:45960->172.17.0.5:29715, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:43298") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:44810->172.17.0.5:43298, err= 2026/09/06 03:52:08 INFO : dir/subdir: Removing directory 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:26642") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:34506->172.17.0.5:26642, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:65052") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:54918->172.17.0.5:65052, err= 2026/09/06 03:52:08 INFO : dir: Removing directory 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:39542") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:50960->172.17.0.5:39542, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:42409") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:45796->172.17.0.5:42409, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:51702") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:54472->172.17.0.5:51702, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:36327") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:55444->172.17.0.5:36327, err= 2026/09/06 03:52:08 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/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:37751") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:55252->172.17.0.5:37751, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:734: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:48445") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:34910->172.17.0.5:48445, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:21664") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:55880->172.17.0.5:21664, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:12087") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:42972->172.17.0.5:12087, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:19266") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:47178->172.17.0.5:19266, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:734: testing "．" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:22648") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:55286->172.17.0.5:22648, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:16567") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:42494->172.17.0.5:16567, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:40379") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:33846->172.17.0.5:40379, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:38330") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:47262->172.17.0.5:38330, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:734: testing "．．" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:52143") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:33742->172.17.0.5:52143, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:22571") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:43450->172.17.0.5:22571, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:41527") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:56872->172.17.0.5:41527, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:61860") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:53656->172.17.0.5:61860, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:734: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:48833") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:32868->172.17.0.5:48833, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:32779") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:60468->172.17.0.5:32779, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:29983") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:38138->172.17.0.5:29983, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:19161") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:54486->172.17.0.5:19161, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:734: testing " leading space" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:11354") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:53916->172.17.0.5:11354, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:52580") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:37070->172.17.0.5:52580, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:15967") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:40962->172.17.0.5:15967, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:15385") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:58750->172.17.0.5:15385, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:734: testing "~leading tilde" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:65309") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:59572->172.17.0.5:65309, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:18314") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:35234->172.17.0.5:18314, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:44076") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:45582->172.17.0.5:44076, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:43072") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:48442->172.17.0.5:43072, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:734: testing "␍leading CR" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:43932") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:48492->172.17.0.5:43932, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:43594") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:41652->172.17.0.5:43594, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:17080") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:56650->172.17.0.5:17080, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:20806") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:50826->172.17.0.5:20806, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:734: testing "␊leading LF" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:29761") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:46352->172.17.0.5:29761, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:52384") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:48078->172.17.0.5:52384, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:57533") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:42686->172.17.0.5:57533, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:12672") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:56424->172.17.0.5:12672, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:734: testing "␉leading HT" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:8513") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:35024->172.17.0.5:8513, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:4086") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:38858->172.17.0.5:4086, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:30915") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:44522->172.17.0.5:30915, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:30138") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:49146->172.17.0.5:30138, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:734: testing "␋leading VT" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:19630") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:48950->172.17.0.5:19630, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:5759") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:36740->172.17.0.5:5759, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:2933") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:47982->172.17.0.5:2933, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:6238") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:51500->172.17.0.5:6238, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:734: testing ".leading dot" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:27307") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:49414->172.17.0.5:27307, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:43437") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:53624->172.17.0.5:43437, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:2563") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:60212->172.17.0.5:2563, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:10605") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:43656->172.17.0.5:10605, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:734: testing "trailing space " 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:10681") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:39778->172.17.0.5:10681, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:31523") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:33340->172.17.0.5:31523, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:28743") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:56052->172.17.0.5:28743, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:21011") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:58906->172.17.0.5:21011, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:734: testing "trailing CR␍" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:18569") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:57818->172.17.0.5:18569, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:43686") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:44890->172.17.0.5:43686, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:35373") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:33614->172.17.0.5:35373, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:18343") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:39538->172.17.0.5:18343, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:734: testing "trailing LF␊" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:60976") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:48678->172.17.0.5:60976, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:13915") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:53590->172.17.0.5:13915, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:60392") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:45130->172.17.0.5:60392, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:39373") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:39330->172.17.0.5:39373, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:734: testing "trailing HT␉" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:56485") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:55686->172.17.0.5:56485, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:11937") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:37194->172.17.0.5:11937, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:59156") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:37186->172.17.0.5:59156, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:20712") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:41286->172.17.0.5:20712, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:734: testing "trailing VT␋" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:63297") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:51150->172.17.0.5:63297, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:51154") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:37168->172.17.0.5:51154, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:32360") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:41484->172.17.0.5:32360, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:6275") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:48352->172.17.0.5:6275, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:734: testing "trailing dot." 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:54217") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:53022->172.17.0.5:54217, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:62251") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:55396->172.17.0.5:62251, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:35389") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:58444->172.17.0.5:35389, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:8312") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:48048->172.17.0.5:8312, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:734: testing "invalid utf-8\xfe" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:2475") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:53376->172.17.0.5:2475, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:37299") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:49110->172.17.0.5:37299, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:13527") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:57330->172.17.0.5:13527, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:28759") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:37340->172.17.0.5:28759, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:734: testing "test%46.txt" 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:15201") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:58596->172.17.0.5:15201, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:15067") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:50530->172.17.0.5:15067, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:38341") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:53746->172.17.0.5:38341, err= 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:24859") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:44904->172.17.0.5:24859, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:45566") 2026/09/06 03:52:08 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:50632->172.17.0.5:45566, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: Connecting to FTP server 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:21") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:40336->172.17.0.5:21, err= 2026/09/06 03:52:09 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:5519") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:52160->172.17.0.5:5519, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:43266") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:49124->172.17.0.5:43266, 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/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:34755") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:55028->172.17.0.5:34755, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:47680") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:38912->172.17.0.5:47680, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:52474") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:59844->172.17.0.5:52474, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:60521") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:60444->172.17.0.5:60521, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:13240") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:60734->172.17.0.5:13240, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:42771") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:52332->172.17.0.5:42771, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:35745") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:55992->172.17.0.5:35745, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:23911") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:43548->172.17.0.5:23911, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:32117") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:37542->172.17.0.5:32117, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:32801") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:43816->172.17.0.5:32801, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:36735") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:44374->172.17.0.5:36735, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:14691") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:34508->172.17.0.5:14691, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:32098") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:50764->172.17.0.5:32098, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:61329") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:54224->172.17.0.5:61329, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:47997") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:51598->172.17.0.5:47997, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:14886") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:44710->172.17.0.5:14886, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:14281") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:52538->172.17.0.5:14281, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/09/06 03:52:09 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/09/06 03:52:09 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/06 03:52:09 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:09 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:09 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:09 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:09 DEBUG : TestFTPProftpd: detected overridden config - adding "{JGfzK}" suffix to name 2026/09/06 03:52:09 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:09 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:09 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:09 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21: Connecting to FTP server 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:21") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:40342->172.17.0.5:21, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:18915") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:54908->172.17.0.5:18915, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:47990") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:43086->172.17.0.5:47990, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:45133") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:49106->172.17.0.5:45133, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:1035") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:44360->172.17.0.5:1035, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:15511") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:50460->172.17.0.5:15511, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:13856") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:42594->172.17.0.5:13856, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:25275") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:42018->172.17.0.5:25275, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:21051") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:40840->172.17.0.5:21051, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:41951") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:53244->172.17.0.5:41951, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:5313") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:54944->172.17.0.5:5313, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1152: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:31142") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:36184->172.17.0.5:31142, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:4095") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:47580->172.17.0.5:4095, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:53084") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:58290->172.17.0.5:53084, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:35637") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:49950->172.17.0.5:35637, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:46337") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:42680->172.17.0.5:46337, 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/06 03:52:09 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-porozed6vete/hello? sausage/êé" 2026/09/06 03:52:09 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/06 03:52:09 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:09 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:09 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:09 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:09 DEBUG : TestFTPProftpd: detected overridden config - adding "{JGfzK}" suffix to name 2026/09/06 03:52:09 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:09 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:09 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:09 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: Connecting to FTP server 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:21") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:40350->172.17.0.5:21, err= 2026/09/06 03:52:09 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-porozed6vete/hello? sausage/êé" to be canonical "TestFTPProftpd{JGfzK}:rclone-test-porozed6vete/hello? sausage/êé" 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:14472") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:48234->172.17.0.5:14472, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:15390") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:56636->172.17.0.5:15390, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: Connecting to FTP server 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:21") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:40356->172.17.0.5:21, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:9201") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:40430->172.17.0.5:9201, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:19568") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:52130->172.17.0.5:19568, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:32342") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:47238->172.17.0.5:32342, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:4498") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:47646->172.17.0.5:4498, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:55027") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:42998->172.17.0.5:55027, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:8991") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:32936->172.17.0.5:8991, err= 2026/09/06 03:52:09 DEBUG : Waiting for deletions to finish 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:57148") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:57950->172.17.0.5:57148, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:11397") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:36194->172.17.0.5:11397, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:65123") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:44038->172.17.0.5:65123, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:57163") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:55780->172.17.0.5:57163, err= 2026/09/06 03:52:09 INFO : a/b/c/d/e.txt: Deleted 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:58296") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:38950->172.17.0.5:58296, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:64836") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:36704->172.17.0.5:64836, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:26279") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:54792->172.17.0.5:26279, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: dial("tcp","172.17.0.5:4386") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé: > dial: conn=172.17.0.1:39952->172.17.0.5:4386, err= 2026/09/06 03:52:09 DEBUG : removing 1 level 4 directories 2026/09/06 03:52:09 INFO : a/b/c/d: Removing directory 2026/09/06 03:52:09 DEBUG : removing 1 level 3 directories 2026/09/06 03:52:09 INFO : a/b/c: Removing directory 2026/09/06 03:52:09 DEBUG : removing 1 level 2 directories 2026/09/06 03:52:09 INFO : a/b: Removing directory 2026/09/06 03:52:09 DEBUG : removing 1 level 1 directories 2026/09/06 03:52:09 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1285: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:22304") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:55434->172.17.0.5:22304, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:17782") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:36778->172.17.0.5:17782, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:33276") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:40330->172.17.0.5:33276, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:17291") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:39520->172.17.0.5:17291, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:29999") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:54980->172.17.0.5:29999, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:10513") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:44272->172.17.0.5:10513, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: Connecting to FTP server 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:21") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:40360->172.17.0.5:21, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:52013") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:33782->172.17.0.5:52013, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:50725") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:56484->172.17.0.5:50725, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:52887") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:41098->172.17.0.5:52887, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:46833") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:54848->172.17.0.5:46833, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:41606") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:52458->172.17.0.5:41606, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:22251") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:41396->172.17.0.5:22251, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:19279") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:51002->172.17.0.5:19279, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:42912") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:35212->172.17.0.5:42912, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:11404") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:36128->172.17.0.5:11404, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:24087") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:47238->172.17.0.5:24087, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:3005") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:50448->172.17.0.5:3005, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:55274") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:59642->172.17.0.5:55274, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:50354") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:52822->172.17.0.5:50354, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:19882") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:49112->172.17.0.5:19882, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:10420") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:32946->172.17.0.5:10420, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:37737") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:53748->172.17.0.5:37737, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:44436") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:36692->172.17.0.5:44436, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1437: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/09/06 03:52:09 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-fihimac0nuwu" 2026/09/06 03:52:09 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/06 03:52:09 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:09 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:09 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:09 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:09 DEBUG : TestFTPProftpd: detected overridden config - adding "{JGfzK}" suffix to name 2026/09/06 03:52:09 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:09 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:09 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:09 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: Connecting to FTP server 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: dial("tcp","172.17.0.5:21") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: > dial: conn=172.17.0.1:40370->172.17.0.5:21, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:64216") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:53196->172.17.0.5:64216, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: dial("tcp","172.17.0.5:26410") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: > dial: conn=172.17.0.1:40252->172.17.0.5:26410, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: dial("tcp","172.17.0.5:30912") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: > dial: conn=172.17.0.1:49552->172.17.0.5:30912, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: dial("tcp","172.17.0.5:36204") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: > dial: conn=172.17.0.1:40638->172.17.0.5:36204, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: dial("tcp","172.17.0.5:5020") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: > dial: conn=172.17.0.1:57328->172.17.0.5:5020, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: dial("tcp","172.17.0.5:33948") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: > dial: conn=172.17.0.1:49078->172.17.0.5:33948, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: dial("tcp","172.17.0.5:26311") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: > dial: conn=172.17.0.1:33986->172.17.0.5:26311, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: dial("tcp","172.17.0.5:40423") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: > dial: conn=172.17.0.1:37382->172.17.0.5:40423, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:39187") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:44178->172.17.0.5:39187, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:33139") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:58666->172.17.0.5:33139, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:38945") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:46346->172.17.0.5:38945, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:20192") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:40488->172.17.0.5:20192, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:6149") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:35150->172.17.0.5:6149, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: dial("tcp","172.17.0.5:51898") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: > dial: conn=172.17.0.1:49734->172.17.0.5:51898, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: dial("tcp","172.17.0.5:6214") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: > dial: conn=172.17.0.1:42484->172.17.0.5:6214, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: dial("tcp","172.17.0.5:56983") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: > dial: conn=172.17.0.1:33582->172.17.0.5:56983, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: dial("tcp","172.17.0.5:62562") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: > dial: conn=172.17.0.1:37414->172.17.0.5:62562, err= 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: Purge dir "new_name" 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-fihimac0nuwu: 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/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:33266") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:46894->172.17.0.5:33266, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:8160") 2026/09/06 03:52:09 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:40346->172.17.0.5:8160, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:58159") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:56898->172.17.0.5:58159, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:43814") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:35402->172.17.0.5:43814, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:35068") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:38856->172.17.0.5:35068, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:33150") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:49388->172.17.0.5:33150, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:34679") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:54354->172.17.0.5:34679, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:56647") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:44874->172.17.0.5:56647, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:57401") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:38972->172.17.0.5:57401, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:52307") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:56846->172.17.0.5:52307, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:54707") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:53732->172.17.0.5:54707, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:10846") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:40560->172.17.0.5:10846, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:33064") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:49476->172.17.0.5:33064, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:61691") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:40400->172.17.0.5:61691, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:20314") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:59590->172.17.0.5:20314, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:36136") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:56072->172.17.0.5:36136, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/09/06 03:52:10 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-porozed6vete/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/09/06 03:52:10 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/06 03:52:10 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:10 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:10 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:10 DEBUG : TestFTPProftpd: detected overridden config - adding "{JGfzK}" suffix to name 2026/09/06 03:52:10 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:10 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:10 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.5:21") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:40380->172.17.0.5:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.5:49386") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:59432->172.17.0.5:49386, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/09/06 03:52:10 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-porozed6vete/not found.txt" 2026/09/06 03:52:10 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/06 03:52:10 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:10 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:10 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:10 DEBUG : TestFTPProftpd: detected overridden config - adding "{JGfzK}" suffix to name 2026/09/06 03:52:10 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:10 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:10 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/not found.txt: Connecting to FTP server 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/not found.txt: dial("tcp","172.17.0.5:21") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/not found.txt: > dial: conn=172.17.0.1:40382->172.17.0.5:21, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/not found.txt: dial("tcp","172.17.0.5:39798") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/not found.txt: > dial: conn=172.17.0.1:46382->172.17.0.5:39798, err= 2026/09/06 03:52:10 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1994: Opening root remote "TestFTPProftpd:" path "rclone-test-porozed6vete" from "TestFTPProftpd:rclone-test-porozed6vete" 2026/09/06 03:52:10 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/09/06 03:52:10 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/06 03:52:10 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:10 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:10 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:10 DEBUG : TestFTPProftpd: detected overridden config - adding "{JGfzK}" suffix to name 2026/09/06 03:52:10 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:10 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:10 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: Connecting to FTP server 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:21") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:40398->172.17.0.5:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:42039") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:45038->172.17.0.5:42039, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:50987") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:60818->172.17.0.5:50987, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:18261") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:40700->172.17.0.5:18261, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:20216") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:35566->172.17.0.5:20216, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:43023") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:36638->172.17.0.5:43023, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:18426") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:44470->172.17.0.5:18426, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2031: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:22230") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:37864->172.17.0.5:22230, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:17976") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:52896->172.17.0.5:17976, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:36054") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:47958->172.17.0.5:36054, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:30470") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:52170->172.17.0.5:30470, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:58488") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:39636->172.17.0.5:58488, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:58807") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:32788->172.17.0.5:58807, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:25239") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:38498->172.17.0.5:25239, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:39075") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:46952->172.17.0.5:39075, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:39070") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:37906->172.17.0.5:39070, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:7954") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:51084->172.17.0.5:7954, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:64445") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:52488->172.17.0.5:64445, 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/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:50387") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:48478->172.17.0.5:50387, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:49240") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:50550->172.17.0.5:49240, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:50012") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:38224->172.17.0.5:50012, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:54927") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:39498->172.17.0.5:54927, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:8773") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:38266->172.17.0.5:8773, 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/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:56741") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:40284->172.17.0.5:56741, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:16938") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:57392->172.17.0.5:16938, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/09/06 03:52:10 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-porozed6vete" 2026/09/06 03:52:10 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/06 03:52:10 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:10 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:10 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:10 DEBUG : TestFTPProftpd: detected overridden config - adding "{aoqPu}" suffix to name 2026/09/06 03:52:10 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:10 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:10 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: Connecting to FTP server 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:21") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:40408->172.17.0.5:21, err= 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:32418") 2026/09/06 03:52:10 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:50406->172.17.0.5:32418, 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/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:40428") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:43266->172.17.0.5:40428, err= fstests.go:2655: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:6010") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:56050->172.17.0.5:6010, 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/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:7325") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:35886->172.17.0.5:7325, 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/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:7175") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:40492->172.17.0.5:7175, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:49191") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:50618->172.17.0.5:49191, err= 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:1327") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:38950->172.17.0.5:1327, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/09/06 03:52:11 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-porozed6vete/deeper/nonexisting/directory" 2026/09/06 03:52:11 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/06 03:52:11 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:11 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:11 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:11 DEBUG : TestFTPProftpd: detected overridden config - adding "{JGfzK}" suffix to name 2026/09/06 03:52:11 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/06 03:52:11 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/06 03:52:11 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/06 03:52:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/deeper/nonexisting/directory: Connecting to FTP server 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/deeper/nonexisting/directory: dial("tcp","172.17.0.5:21") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete/deeper/nonexisting/directory: > dial: conn=172.17.0.1:38958->172.17.0.5: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/06 03:52:11 DEBUG : Waiting for deletions to finish 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:22277") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:59502->172.17.0.5:22277, err= 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:13681") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:45260->172.17.0.5:13681, err= 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:36151") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:57094->172.17.0.5:36151, err= 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:58262") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:46664->172.17.0.5:58262, err= 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:58681") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:45356->172.17.0.5:58681, err= 2026/09/06 03:52:11 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:18630") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:39366->172.17.0.5:18630, err= 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:8755") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:33398->172.17.0.5:8755, err= 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:12669") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:52966->172.17.0.5:12669, err= 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:23503") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:51352->172.17.0.5:23503, err= 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:6239") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:32796->172.17.0.5:6239, err= 2026/09/06 03:52:11 DEBUG : removing 1 level 4 directories 2026/09/06 03:52:11 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/09/06 03:52:11 DEBUG : removing 1 level 3 directories 2026/09/06 03:52:11 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/09/06 03:52:11 DEBUG : removing 1 level 2 directories 2026/09/06 03:52:11 INFO : hello? sausage/êé: Removing directory 2026/09/06 03:52:11 DEBUG : removing 1 level 1 directories 2026/09/06 03:52:11 INFO : hello? sausage: Removing directory 2026/09/06 03:52:11 DEBUG : removing 1 level 0 directories 2026/09/06 03:52:11 INFO : ftp://172.17.0.5:21/rclone-test-porozed6vete: Removing directory 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:28189") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:57928->172.17.0.5:28189, err= 2026/09/06 03:52:11 ERROR : error listing: directory not found 2026/09/06 03:52:11 DEBUG : Waiting for deletions to finish 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:34753") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:57468->172.17.0.5:34753, err= 2026/09/06 03:52:11 ERROR : error listing: directory not found 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: dial("tcp","172.17.0.5:33843") 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: > dial: conn=172.17.0.1:39496->172.17.0.5:33843, err= 2026/09/06 03:52:11 ERROR : ftp://172.17.0.5:21/rclone-test-porozed6vete: Failed to list "": directory not found 2026/09/06 03:52:11 DEBUG : removing 1 level 0 directories 2026/09/06 03:52:11 INFO : ftp://172.17.0.5:21/rclone-test-porozed6vete: Removing directory 2026/09/06 03:52:11 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/09/06 03:52:11 DEBUG : ftp://172.17.0.5:21/rclone-test-porozed6vete: closing 2 unused connections 2026/09/06 03:52:11 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (4.70s) --- 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 (3.37s) --- 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.19s) --- 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.03s) --- 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.99s) --- 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.03s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.01s) --- 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.10s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.06s) --- 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.08s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.03s) --- 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.02s) --- 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 (1.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (1.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutRetry (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/NetError (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Chunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Simple (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutShortEOF/Chunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.02s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- 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 4.718s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 6.382882683s (try 1/5)