"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2026/07/11 03:25:34 NOTICE: TestFTPProftpd: Starting server 2026/07/11 03:25:35 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.3:21" try 1/100 2026/07/11 03:25:35 DEBUG : TestFTPProftpd: Read 1, error: 2026/07/11 03:25:35 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.3:21" 2026/07/11 03:25:35 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-tuxujaw9deqi" 2026/07/11 03:25:35 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/07/11 03:25:35 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/07/11 03:25:35 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:35 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:35 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:35 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:35 DEBUG : TestFTPProftpd: detected overridden config - adding "{EF0-z}" suffix to name 2026/07/11 03:25:35 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:35 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:35 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:35 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: Connecting to FTP server 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:21") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:60490->172.17.0.3:21, err= 2026/07/11 03:25:35 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:60104") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:45122->172.17.0.3:60104, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:20222") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:47072->172.17.0.3:20222, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/07/11 03:25:35 INFO : dir/subdir: Making directory 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:19062") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:52000->172.17.0.3:19062, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:15080") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:52930->172.17.0.3:15080, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:46483") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:59764->172.17.0.3:46483, err= 2026/07/11 03:25:35 INFO : dir/subdir: Removing directory 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:53445") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:50732->172.17.0.3:53445, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:33448") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:47942->172.17.0.3:33448, err= 2026/07/11 03:25:35 INFO : dir: Removing directory 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:42059") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:43944->172.17.0.3:42059, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:31063") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:52680->172.17.0.3:31063, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:53814") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:36066->172.17.0.3:53814, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:36605") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:39166->172.17.0.3:36605, err= 2026/07/11 03:25:35 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:42585") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:57370->172.17.0.3:42585, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:708: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:45043") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:40586->172.17.0.3:45043, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:2586") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:36454->172.17.0.3:2586, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:41075") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:59020->172.17.0.3:41075, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:2700") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:39994->172.17.0.3:2700, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:708: testing "．" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:16354") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:38856->172.17.0.3:16354, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:65410") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:41124->172.17.0.3:65410, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:15022") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:42356->172.17.0.3:15022, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:61944") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:39578->172.17.0.3:61944, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:708: testing "．．" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:13769") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:34462->172.17.0.3:13769, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:18454") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:42868->172.17.0.3:18454, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:53074") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:59716->172.17.0.3:53074, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:44906") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:46420->172.17.0.3:44906, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:708: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:56447") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:41934->172.17.0.3:56447, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:45113") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:39346->172.17.0.3:45113, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:49741") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:48438->172.17.0.3:49741, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:53871") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:35082->172.17.0.3:53871, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:708: testing " leading space" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:54001") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:47232->172.17.0.3:54001, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:4156") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:58588->172.17.0.3:4156, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:44980") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:60002->172.17.0.3:44980, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:48571") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:40112->172.17.0.3:48571, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:708: testing "~leading tilde" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:23355") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:45358->172.17.0.3:23355, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:63018") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:36032->172.17.0.3:63018, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:62628") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:58728->172.17.0.3:62628, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:4304") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:60434->172.17.0.3:4304, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:708: testing "␍leading CR" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:50929") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:44334->172.17.0.3:50929, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:30542") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:35502->172.17.0.3:30542, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:45339") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:47528->172.17.0.3:45339, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:16458") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:54768->172.17.0.3:16458, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:708: testing "␊leading LF" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:18822") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:59202->172.17.0.3:18822, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:16410") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:54894->172.17.0.3:16410, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:58020") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:33652->172.17.0.3:58020, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:62841") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:54160->172.17.0.3:62841, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:708: testing "␉leading HT" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:17972") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:33596->172.17.0.3:17972, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:33560") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:59518->172.17.0.3:33560, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:64518") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:54554->172.17.0.3:64518, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:33303") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:40724->172.17.0.3:33303, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:708: testing "␋leading VT" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:33436") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:53232->172.17.0.3:33436, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:14005") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:55312->172.17.0.3:14005, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:29713") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:54478->172.17.0.3:29713, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:46182") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:47658->172.17.0.3:46182, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:708: testing ".leading dot" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:31436") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:46342->172.17.0.3:31436, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:17252") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:42774->172.17.0.3:17252, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:25554") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:45470->172.17.0.3:25554, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:22348") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:33172->172.17.0.3:22348, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:708: testing "trailing space " 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:61342") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:51196->172.17.0.3:61342, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:9760") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:45244->172.17.0.3:9760, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:10684") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:58420->172.17.0.3:10684, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:49809") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:43104->172.17.0.3:49809, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:708: testing "trailing CR␍" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:12893") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:46608->172.17.0.3:12893, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:54640") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:50764->172.17.0.3:54640, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:32845") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:56004->172.17.0.3:32845, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:35225") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:46970->172.17.0.3:35225, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:708: testing "trailing LF␊" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:52124") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:53188->172.17.0.3:52124, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:29939") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:58644->172.17.0.3:29939, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:38505") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:40822->172.17.0.3:38505, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:37519") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:42884->172.17.0.3:37519, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:708: testing "trailing HT␉" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:59457") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:34968->172.17.0.3:59457, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:18310") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:35490->172.17.0.3:18310, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:52954") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:48794->172.17.0.3:52954, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:12744") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:51664->172.17.0.3:12744, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:708: testing "trailing VT␋" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:33696") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:44012->172.17.0.3:33696, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:45439") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:59734->172.17.0.3:45439, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:10051") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:42516->172.17.0.3:10051, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:50645") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:39390->172.17.0.3:50645, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:708: testing "trailing dot." 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:13465") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:49984->172.17.0.3:13465, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:9034") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:59868->172.17.0.3:9034, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:18414") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:48008->172.17.0.3:18414, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:45877") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:36404->172.17.0.3:45877, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:708: testing "invalid utf-8\xfe" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:22015") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:46204->172.17.0.3:22015, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:47103") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:48030->172.17.0.3:47103, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:26525") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:46300->172.17.0.3:26525, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:52428") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:48374->172.17.0.3:52428, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:708: testing "test%46.txt" 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:63332") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:60212->172.17.0.3:63332, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:51055") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:47158->172.17.0.3:51055, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:9241") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:49858->172.17.0.3:9241, err= 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:59139") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:39236->172.17.0.3:59139, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:59792") 2026/07/11 03:25:35 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:43884->172.17.0.3:59792, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: Connecting to FTP server 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:21") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:60506->172.17.0.3:21, err= 2026/07/11 03:25:36 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:9044") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:34140->172.17.0.3:9044, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:59963") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:58534->172.17.0.3:59963, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:787: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:820: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:873: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:42081") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:48096->172.17.0.3:42081, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:64736") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:32982->172.17.0.3:64736, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:50589") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:40552->172.17.0.3:50589, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:51203") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:45912->172.17.0.3:51203, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:23753") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:47406->172.17.0.3:23753, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:34574") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:33138->172.17.0.3:34574, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:54403") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:42184->172.17.0.3:54403, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:34117") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:35168->172.17.0.3:34117, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:14061") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:49842->172.17.0.3:14061, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:64877") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:40180->172.17.0.3:64877, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:37358") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:54772->172.17.0.3:37358, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:2823") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:33702->172.17.0.3:2823, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:21545") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:51958->172.17.0.3:21545, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:36690") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:56410->172.17.0.3:36690, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:25135") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:40826->172.17.0.3:25135, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:48254") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:48018->172.17.0.3:48254, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:33532") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:52402->172.17.0.3:33532, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/07/11 03:25:36 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/07/11 03:25:36 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/07/11 03:25:36 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:36 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:36 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:36 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:36 DEBUG : TestFTPProftpd: detected overridden config - adding "{EF0-z}" suffix to name 2026/07/11 03:25:36 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:36 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:36 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:36 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:60518->172.17.0.3:21, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:3237") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56366->172.17.0.3:3237, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:37977") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:48504->172.17.0.3:37977, err= 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:7184") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:40736->172.17.0.3:7184, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:40964") 2026/07/11 03:25:36 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:34066->172.17.0.3:40964, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:55512") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:53558->172.17.0.3:55512, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:23451") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:43096->172.17.0.3:23451, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:1834") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:38490->172.17.0.3:1834, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:54500") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:47372->172.17.0.3:54500, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:62199") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:38604->172.17.0.3:62199, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:56226") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:36176->172.17.0.3:56226, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1126: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:11535") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:44374->172.17.0.3:11535, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:64393") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:52500->172.17.0.3:64393, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:39305") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:58806->172.17.0.3:39305, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:19555") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:57538->172.17.0.3:19555, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:58822") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:60522->172.17.0.3:58822, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1158: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1195: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/07/11 03:25:37 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-tuxujaw9deqi/hello? sausage/êé" 2026/07/11 03:25:37 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/07/11 03:25:37 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:37 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:37 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:37 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:37 DEBUG : TestFTPProftpd: detected overridden config - adding "{EF0-z}" suffix to name 2026/07/11 03:25:37 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:37 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:37 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:37 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: Connecting to FTP server 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:60524->172.17.0.3:21, err= 2026/07/11 03:25:37 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-tuxujaw9deqi/hello? sausage/êé" to be canonical "TestFTPProftpd{EF0-z}:rclone-test-tuxujaw9deqi/hello? sausage/êé" 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:3700") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:58214->172.17.0.3:3700, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:2275") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:42826->172.17.0.3:2275, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: Connecting to FTP server 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:60526->172.17.0.3:21, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:27955") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:32978->172.17.0.3:27955, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:30516") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:59098->172.17.0.3:30516, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:45435") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:56780->172.17.0.3:45435, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:19759") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:42322->172.17.0.3:19759, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:48558") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:58646->172.17.0.3:48558, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:5863") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:44738->172.17.0.3:5863, err= 2026/07/11 03:25:37 DEBUG : Waiting for deletions to finish 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:29972") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:59096->172.17.0.3:29972, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:44776") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:42154->172.17.0.3:44776, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:62172") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:52874->172.17.0.3:62172, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:37537") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:35416->172.17.0.3:37537, err= 2026/07/11 03:25:37 INFO : a/b/c/d/e.txt: Deleted 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:15603") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:60078->172.17.0.3:15603, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:56554") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:37670->172.17.0.3:56554, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:14077") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:33134->172.17.0.3:14077, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: dial("tcp","172.17.0.3:40214") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé: > dial: conn=172.17.0.1:45882->172.17.0.3:40214, err= 2026/07/11 03:25:37 DEBUG : removing 1 level 4 directories 2026/07/11 03:25:37 INFO : a/b/c/d: Removing directory 2026/07/11 03:25:37 DEBUG : removing 1 level 3 directories 2026/07/11 03:25:37 INFO : a/b/c: Removing directory 2026/07/11 03:25:37 DEBUG : removing 1 level 2 directories 2026/07/11 03:25:37 INFO : a/b: Removing directory 2026/07/11 03:25:37 DEBUG : removing 1 level 1 directories 2026/07/11 03:25:37 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1259: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:15851") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:49712->172.17.0.3:15851, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:18757") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:46466->172.17.0.3:18757, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:43876") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:39024->172.17.0.3:43876, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:1519") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:59824->172.17.0.3:1519, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:41486") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:45076->172.17.0.3:41486, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:12916") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:58134->172.17.0.3:12916, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: Connecting to FTP server 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:21") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:60532->172.17.0.3:21, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:54899") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:33606->172.17.0.3:54899, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:16259") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:49778->172.17.0.3:16259, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:10069") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:59614->172.17.0.3:10069, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:30367") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:56488->172.17.0.3:30367, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:25954") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:38060->172.17.0.3:25954, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:38983") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:40966->172.17.0.3:38983, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:54242") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:54977") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:46562->172.17.0.3:54977, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:44536->172.17.0.3:54242, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:41304") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:60676->172.17.0.3:41304, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:46404") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:50646->172.17.0.3:46404, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:48342") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:49200->172.17.0.3:48342, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:27754") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:58126->172.17.0.3:27754, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:10253") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:60926->172.17.0.3:10253, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:54125") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:38112->172.17.0.3:54125, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:17560") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:48350->172.17.0.3:17560, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:2981") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:55446->172.17.0.3:2981, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:51865") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:33320->172.17.0.3:51865, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1407: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/07/11 03:25:37 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hezayub6cipi" 2026/07/11 03:25:37 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/07/11 03:25:37 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:37 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:37 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:37 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:37 DEBUG : TestFTPProftpd: detected overridden config - adding "{EF0-z}" suffix to name 2026/07/11 03:25:37 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:37 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:37 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:37 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: Connecting to FTP server 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: dial("tcp","172.17.0.3:21") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: > dial: conn=172.17.0.1:60538->172.17.0.3:21, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:39637") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:51228->172.17.0.3:39637, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: dial("tcp","172.17.0.3:22500") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: > dial: conn=172.17.0.1:41234->172.17.0.3:22500, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: dial("tcp","172.17.0.3:28493") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: > dial: conn=172.17.0.1:53390->172.17.0.3:28493, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: dial("tcp","172.17.0.3:25481") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: > dial: conn=172.17.0.1:50586->172.17.0.3:25481, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: dial("tcp","172.17.0.3:40569") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: > dial: conn=172.17.0.1:46140->172.17.0.3:40569, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: dial("tcp","172.17.0.3:39622") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: > dial: conn=172.17.0.1:38944->172.17.0.3:39622, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: dial("tcp","172.17.0.3:9550") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: > dial: conn=172.17.0.1:44392->172.17.0.3:9550, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: dial("tcp","172.17.0.3:7817") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: > dial: conn=172.17.0.1:58478->172.17.0.3:7817, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:57483") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:43098->172.17.0.3:57483, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:23836") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:41610->172.17.0.3:23836, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:50068") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:57044->172.17.0.3:50068, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:53361") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:55192->172.17.0.3:53361, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:24307") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:40988->172.17.0.3:24307, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: dial("tcp","172.17.0.3:59723") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: > dial: conn=172.17.0.1:55054->172.17.0.3:59723, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: dial("tcp","172.17.0.3:59934") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: > dial: conn=172.17.0.1:51714->172.17.0.3:59934, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: dial("tcp","172.17.0.3:19985") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: > dial: conn=172.17.0.1:48160->172.17.0.3:19985, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: dial("tcp","172.17.0.3:23598") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: > dial: conn=172.17.0.1:47238->172.17.0.3:23598, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: Purge dir "new_name" 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-hezayub6cipi: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1601: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1632: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1703: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:5539") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:60530->172.17.0.3:5539, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:32121") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:44908->172.17.0.3:32121, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:5238") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:54762->172.17.0.3:5238, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:63644") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:48378->172.17.0.3:63644, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:48566") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:54072->172.17.0.3:48566, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:25497") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:47186->172.17.0.3:25497, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:14284") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:52078->172.17.0.3:14284, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:21561") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:37290->172.17.0.3:21561, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:57313") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:52412->172.17.0.3:57313, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:26308") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:53382->172.17.0.3:26308, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:65425") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:41920->172.17.0.3:65425, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:3250") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:47148->172.17.0.3:3250, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:18225") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:36776->172.17.0.3:18225, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:16999") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:60632->172.17.0.3:16999, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:13761") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:36682->172.17.0.3:13761, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/07/11 03:25:37 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-tuxujaw9deqi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/07/11 03:25:37 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/07/11 03:25:37 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:37 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:37 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:37 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:37 DEBUG : TestFTPProftpd: detected overridden config - adding "{EF0-z}" suffix to name 2026/07/11 03:25:37 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:37 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:37 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:37 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:21") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:60550->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:21013") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:42708->172.17.0.3:21013, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/07/11 03:25:37 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-tuxujaw9deqi/not found.txt" 2026/07/11 03:25:37 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/07/11 03:25:37 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:37 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:37 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:37 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:37 DEBUG : TestFTPProftpd: detected overridden config - adding "{EF0-z}" suffix to name 2026/07/11 03:25:37 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:37 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:37 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:37 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/not found.txt: Connecting to FTP server 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/not found.txt: dial("tcp","172.17.0.3:21") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/not found.txt: > dial: conn=172.17.0.1:60554->172.17.0.3:21, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/not found.txt: dial("tcp","172.17.0.3:29218") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/not found.txt: > dial: conn=172.17.0.1:45152->172.17.0.3:29218, err= 2026/07/11 03:25:37 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1958: Opening root remote "TestFTPProftpd:" path "rclone-test-tuxujaw9deqi" from "TestFTPProftpd:rclone-test-tuxujaw9deqi" 2026/07/11 03:25:37 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/07/11 03:25:37 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/07/11 03:25:37 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:37 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:37 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:37 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:37 DEBUG : TestFTPProftpd: detected overridden config - adding "{EF0-z}" suffix to name 2026/07/11 03:25:37 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:37 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:37 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:37 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:60564->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:8892") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:36348->172.17.0.3:8892, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:22170") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:54498->172.17.0.3:22170, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:60755") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:33494->172.17.0.3:60755, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:6826") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:49280->172.17.0.3:6826, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:65444") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:49260->172.17.0.3:65444, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:8446") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:42148->172.17.0.3:8446, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1995: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:53485") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56426->172.17.0.3:53485, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:16319") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:52148->172.17.0.3:16319, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:43535") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:44708->172.17.0.3:43535, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:22400") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56086->172.17.0.3:22400, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:15313") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:47802->172.17.0.3:15313, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:23760") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:49280->172.17.0.3:23760, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33274") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:50134->172.17.0.3:33274, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:31125") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:53522->172.17.0.3:31125, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:42780") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:43590->172.17.0.3:42780, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:7269") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:58030->172.17.0.3:7269, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:1706") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:36244->172.17.0.3:1706, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2054: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2159: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2175: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:37030") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:33708->172.17.0.3:37030, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:17084") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:58728->172.17.0.3:17084, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:3447") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:54526->172.17.0.3:3447, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:55281") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:43910->172.17.0.3:55281, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:40904") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:59602->172.17.0.3:40904, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2331: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:57920") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:44846->172.17.0.3:57920, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:32293") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:54806->172.17.0.3:32293, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/07/11 03:25:37 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-tuxujaw9deqi" 2026/07/11 03:25:37 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/07/11 03:25:37 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:37 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:37 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:37 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:37 DEBUG : TestFTPProftpd: detected overridden config - adding "{QrcdB}" suffix to name 2026/07/11 03:25:37 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:37 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:37 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:37 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: Connecting to FTP server 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:21") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:60576->172.17.0.3:21, err= 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:9129") 2026/07/11 03:25:37 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:50746->172.17.0.3:9129, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2414: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2526: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:59614") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:36018->172.17.0.3:59614, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:34388") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:54384->172.17.0.3:34388, err= 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:10371") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:51724->172.17.0.3:10371, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/07/11 03:25:38 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-tuxujaw9deqi/deeper/nonexisting/directory" 2026/07/11 03:25:38 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/07/11 03:25:38 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:38 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:38 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:38 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:38 DEBUG : TestFTPProftpd: detected overridden config - adding "{EF0-z}" suffix to name 2026/07/11 03:25:38 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/07/11 03:25:38 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/07/11 03:25:38 DEBUG : Setting pass="Of11rH9laBj_HAKNTEOe6VoRWtfckM2LxtkJLDGCkKmt5g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/07/11 03:25:38 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/deeper/nonexisting/directory: Connecting to FTP server 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/deeper/nonexisting/directory: dial("tcp","172.17.0.3:21") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi/deeper/nonexisting/directory: > dial: conn=172.17.0.1:60584->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2675: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2718: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2775: FS has no Directory methods and doesn't Wrap 2026/07/11 03:25:38 DEBUG : Waiting for deletions to finish 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:48672") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:38560->172.17.0.3:48672, err= 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:5598") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:58202->172.17.0.3:5598, err= 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:1788") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:43372->172.17.0.3:1788, err= 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:50027") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:57644->172.17.0.3:50027, err= 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:20146") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:39384->172.17.0.3:20146, err= 2026/07/11 03:25:38 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:53224") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:47082->172.17.0.3:53224, err= 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:22636") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:52638->172.17.0.3:22636, err= 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:6094") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:53370->172.17.0.3:6094, err= 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:64651") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:58428->172.17.0.3:64651, err= 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:25979") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:34072->172.17.0.3:25979, err= 2026/07/11 03:25:38 DEBUG : removing 1 level 4 directories 2026/07/11 03:25:38 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/07/11 03:25:38 DEBUG : removing 1 level 3 directories 2026/07/11 03:25:38 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/07/11 03:25:38 DEBUG : removing 1 level 2 directories 2026/07/11 03:25:38 INFO : hello? sausage/êé: Removing directory 2026/07/11 03:25:38 DEBUG : removing 1 level 1 directories 2026/07/11 03:25:38 INFO : hello? sausage: Removing directory 2026/07/11 03:25:38 DEBUG : removing 1 level 0 directories 2026/07/11 03:25:38 INFO : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: Removing directory 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:65116") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:40510->172.17.0.3:65116, err= 2026/07/11 03:25:38 ERROR : error listing: directory not found 2026/07/11 03:25:38 DEBUG : Waiting for deletions to finish 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:39672") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:33512->172.17.0.3:39672, err= 2026/07/11 03:25:38 ERROR : error listing: directory not found 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: dial("tcp","172.17.0.3:59970") 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: > dial: conn=172.17.0.1:45258->172.17.0.3:59970, err= 2026/07/11 03:25:38 ERROR : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: Failed to list "": directory not found 2026/07/11 03:25:38 DEBUG : removing 1 level 0 directories 2026/07/11 03:25:38 INFO : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: Removing directory 2026/07/11 03:25:38 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/07/11 03:25:38 DEBUG : ftp://172.17.0.3:21/rclone-test-tuxujaw9deqi: closing 2 unused connections 2026/07/11 03:25:38 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (3.73s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.00s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (2.44s) --- 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.13s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.06s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 3.743s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 4.937426681s (try 1/5)