"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestCommandEncodingNeutralisesCRLF --- PASS: TestCommandEncodingNeutralisesCRLF (0.00s) === RUN TestPutFtpConnectionDiscardsDeadConnection === RUN TestPutFtpConnectionDiscardsDeadConnection/network_error_discards === RUN TestPutFtpConnectionDiscardsDeadConnection/FTP_reply_error_with_live_connection_pools === RUN TestPutFtpConnectionDiscardsDeadConnection/FTP_reply_error_with_dead_connection_discards --- PASS: TestPutFtpConnectionDiscardsDeadConnection (0.10s) --- PASS: TestPutFtpConnectionDiscardsDeadConnection/network_error_discards (0.00s) --- PASS: TestPutFtpConnectionDiscardsDeadConnection/FTP_reply_error_with_live_connection_pools (0.00s) --- PASS: TestPutFtpConnectionDiscardsDeadConnection/FTP_reply_error_with_dead_connection_discards (0.10s) === RUN TestFtpReadCloserClose === RUN TestFtpReadCloserClose/425_before_any_read_is_masked_and_the_connection_is_not_pooled === RUN TestFtpReadCloserClose/425_after_data_was_read_stays_an_error === RUN TestFtpReadCloserClose/clean_close_pools_the_connection_once --- PASS: TestFtpReadCloserClose (0.01s) --- PASS: TestFtpReadCloserClose/425_before_any_read_is_masked_and_the_connection_is_not_pooled (0.00s) --- PASS: TestFtpReadCloserClose/425_after_data_was_read_stays_an_error (0.00s) --- PASS: TestFtpReadCloserClose/clean_close_pools_the_connection_once (0.00s) === RUN TestIntegration fstests.go:464: Using remote "TestFTPProftpd:" 2026/11/01 01:49:03 NOTICE: TestFTPProftpd: Starting server 2026/11/01 01:49:04 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.7:21" try 1/100 2026/11/01 01:49:04 DEBUG : TestFTPProftpd: Read 1, error: 2026/11/01 01:49:04 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.7:21" 2026/11/01 01:49:04 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vifetew7resi" 2026/11/01 01:49:04 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/01 01:49:04 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/01 01:49:04 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:04 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:04 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{tgXdK}" suffix to name 2026/11/01 01:49:04 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:04 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:04 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: Connecting to FTP server 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:60660->172.17.0.7:21, err= 2026/11/01 01:49:04 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:505: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:533: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:7996") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:59686->172.17.0.7:7996, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRootCannotChangeHost 2026/11/01 01:49:04 DEBUG : Creating backend with remote "TestFTPProftpd://127.0.0.1:38323/" 2026/11/01 01:49:04 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/01 01:49:04 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:04 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:04 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{tgXdK}" suffix to name 2026/11/01 01:49:04 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:04 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:04 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/127.0.0.1:38323: Connecting to FTP server 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/127.0.0.1:38323: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/127.0.0.1:38323: > dial: conn=172.17.0.1:60666->172.17.0.7:21, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/127.0.0.1:38323: dial("tcp","172.17.0.7:38629") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/127.0.0.1:38323: > dial: conn=172.17.0.1:49444->172.17.0.7:38629, err= 2026/11/01 01:49:04 DEBUG : Creating backend with remote "TestFTPProftpd://127.0.0.1:38323/rclone-test-vifetew7resi/" 2026/11/01 01:49:04 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/01 01:49:04 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:04 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:04 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{tgXdK}" suffix to name 2026/11/01 01:49:04 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:04 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:04 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/127.0.0.1:38323/rclone-test-vifetew7resi: Connecting to FTP server 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/127.0.0.1:38323/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/127.0.0.1:38323/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:60680->172.17.0.7:21, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/127.0.0.1:38323/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:50253") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/127.0.0.1:38323/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:48512->172.17.0.7:50253, err= 2026/11/01 01:49:04 DEBUG : Creating backend with remote "TestFTPProftpd://user:pass@127.0.0.1:38323/" 2026/11/01 01:49:04 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/01 01:49:04 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:04 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:04 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{tgXdK}" suffix to name 2026/11/01 01:49:04 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:04 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:04 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/user:pass@127.0.0.1:38323: Connecting to FTP server 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/user:pass@127.0.0.1:38323: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/user:pass@127.0.0.1:38323: > dial: conn=172.17.0.1:60690->172.17.0.7:21, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/user:pass@127.0.0.1:38323: dial("tcp","172.17.0.7:29796") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/user:pass@127.0.0.1:38323: > dial: conn=172.17.0.1:50820->172.17.0.7:29796, err= === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:58423") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:50610->172.17.0.7:58423, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/11/01 01:49:04 INFO : dir/subdir: Making directory 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:14462") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:42980->172.17.0.7:14462, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:61341") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:36250->172.17.0.7:61341, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:22970") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:33950->172.17.0.7:22970, err= 2026/11/01 01:49:04 INFO : dir/subdir: Removing directory 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:25262") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:55504->172.17.0.7:25262, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:28430") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:53680->172.17.0.7:28430, err= 2026/11/01 01:49:04 INFO : dir: Removing directory 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:53273") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:41192->172.17.0.7:53273, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:51550") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:36740->172.17.0.7:51550, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:26683") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:37220->172.17.0.7:26683, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:64486") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:52724->172.17.0.7:64486, err= 2026/11/01 01:49:04 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:12643") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:46428->172.17.0.7:12643, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:779: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:14598") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:53792->172.17.0.7:14598, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:42154") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:48654->172.17.0.7:42154, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:27313") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:39584->172.17.0.7:27313, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:24076") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:58966->172.17.0.7:24076, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:779: testing "．" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:22720") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:42954->172.17.0.7:22720, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:15635") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:51540->172.17.0.7:15635, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:49872") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:53200->172.17.0.7:49872, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:23724") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:55308->172.17.0.7:23724, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:779: testing "．．" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:13233") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:42664->172.17.0.7:13233, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:64484") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:56100->172.17.0.7:64484, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:43549") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:50372->172.17.0.7:43549, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:55204") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:41182->172.17.0.7:55204, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:779: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:52959") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:44752->172.17.0.7:52959, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:11148") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:34436->172.17.0.7:11148, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:12273") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:43022->172.17.0.7:12273, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:16087") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:51572->172.17.0.7:16087, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:779: testing " leading space" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:8635") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:44134->172.17.0.7:8635, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:65126") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:58384->172.17.0.7:65126, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:63156") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:49536->172.17.0.7:63156, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:15607") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:44368->172.17.0.7:15607, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:779: testing "~leading tilde" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:58015") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:37118->172.17.0.7:58015, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:12083") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:41394->172.17.0.7:12083, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:11414") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:41280->172.17.0.7:11414, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:15451") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:36606->172.17.0.7:15451, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:779: testing "␍leading CR" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:36321") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:45288->172.17.0.7:36321, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:38820") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:59524->172.17.0.7:38820, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:3190") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:53922->172.17.0.7:3190, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:22337") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:44856->172.17.0.7:22337, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:779: testing "␊leading LF" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:64479") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:48556->172.17.0.7:64479, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:2141") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:51566->172.17.0.7:2141, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:33957") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:60456->172.17.0.7:33957, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:13543") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:55702->172.17.0.7:13543, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:779: testing "␉leading HT" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:43272") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:33126->172.17.0.7:43272, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:60247") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:42790->172.17.0.7:60247, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:36595") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:60060->172.17.0.7:36595, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:64968") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:60692->172.17.0.7:64968, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:779: testing "␋leading VT" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:10347") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:50162->172.17.0.7:10347, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:20933") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:58048->172.17.0.7:20933, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:23158") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:45122->172.17.0.7:23158, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:22557") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:51230->172.17.0.7:22557, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:779: testing ".leading dot" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:19883") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:60648->172.17.0.7:19883, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:1173") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:54294->172.17.0.7:1173, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:12227") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:47524->172.17.0.7:12227, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:7307") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:44756->172.17.0.7:7307, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:779: testing "trailing space " 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:11297") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:42568->172.17.0.7:11297, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:23476") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:42376->172.17.0.7:23476, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:22370") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:51052->172.17.0.7:22370, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:18908") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:55252->172.17.0.7:18908, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:779: testing "trailing CR␍" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:23068") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:41044->172.17.0.7:23068, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:19991") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:49140->172.17.0.7:19991, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:33492") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:35872->172.17.0.7:33492, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:15549") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:32938->172.17.0.7:15549, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:779: testing "trailing LF␊" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:31051") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:56768->172.17.0.7:31051, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:43882") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:39148->172.17.0.7:43882, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:29976") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:46586->172.17.0.7:29976, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:1838") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:38548->172.17.0.7:1838, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:779: testing "trailing HT␉" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:17168") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:32882->172.17.0.7:17168, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:32142") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:34152->172.17.0.7:32142, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:23151") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:55480->172.17.0.7:23151, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:16112") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:54802->172.17.0.7:16112, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:779: testing "trailing VT␋" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:33260") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:54054->172.17.0.7:33260, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:56084") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:45480->172.17.0.7:56084, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:28632") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:44180->172.17.0.7:28632, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:10998") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:59374->172.17.0.7:10998, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:779: testing "trailing dot." 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:50796") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:59990->172.17.0.7:50796, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:64203") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:40158->172.17.0.7:64203, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:10431") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:58972->172.17.0.7:10431, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:60120") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:37376->172.17.0.7:60120, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:779: testing "invalid utf-8\xfe" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:19602") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:36254->172.17.0.7:19602, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:32566") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:38032->172.17.0.7:32566, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:17143") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:34774->172.17.0.7:17143, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:38461") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:50244->172.17.0.7:38461, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:779: testing "test%46.txt" 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:32715") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:55828->172.17.0.7:32715, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:28347") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:41486->172.17.0.7:28347, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:44744") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:47504->172.17.0.7:44744, err= 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:42988") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:53804->172.17.0.7:42988, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:50800") 2026/11/01 01:49:04 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:43346->172.17.0.7:50800, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: Connecting to FTP server 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:60704->172.17.0.7:21, err= 2026/11/01 01:49:05 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:29952") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:35612->172.17.0.7:29952, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:48029") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:54862->172.17.0.7:48029, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:858: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:895: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:977: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:31295") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:51470->172.17.0.7:31295, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:15534") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:33710->172.17.0.7:15534, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:29925") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:37644->172.17.0.7:29925, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:17332") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:56096->172.17.0.7:17332, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:62769") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:48332->172.17.0.7:62769, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:24073") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:47252->172.17.0.7:24073, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:64046") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:57714->172.17.0.7:64046, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:10194") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:45298->172.17.0.7:10194, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:47578") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:56214->172.17.0.7:47578, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:65359") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:52972->172.17.0.7:65359, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:7804") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:58082->172.17.0.7:7804, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:64278") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:47976->172.17.0.7:64278, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:31534") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:42726->172.17.0.7:31534, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:52520") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:36402->172.17.0.7:52520, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:7578") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:38426->172.17.0.7:7578, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:8165") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:39184->172.17.0.7:8165, err= 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:43359") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:49518->172.17.0.7:43359, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/11/01 01:49:05 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/11/01 01:49:05 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/01 01:49:05 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:05 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:05 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{tgXdK}" suffix to name 2026/11/01 01:49:05 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:05 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:05 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21: Connecting to FTP server 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:05 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:60712->172.17.0.7:21, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:6771") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:58186->172.17.0.7:6771, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:61160") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:45862->172.17.0.7:61160, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:37007") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:49346->172.17.0.7:37007, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:44009") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:49346->172.17.0.7:44009, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:22166") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:43988->172.17.0.7:22166, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:55384") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:49824->172.17.0.7:55384, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:48300") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:50476->172.17.0.7:48300, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:52531") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:45822->172.17.0.7:52531, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:4111") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:50148->172.17.0.7:4111, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:23192") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:45856->172.17.0.7:23192, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1230: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:4835") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:51100->172.17.0.7:4835, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:48770") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:50952->172.17.0.7:48770, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:63314") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:55470->172.17.0.7:63314, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:33763") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:45654->172.17.0.7:33763, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:31264") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:41324->172.17.0.7:31264, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1262: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1299: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/11/01 01:49:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vifetew7resi/hello? sausage/êé" 2026/11/01 01:49:06 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/01 01:49:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{tgXdK}" suffix to name 2026/11/01 01:49:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: Connecting to FTP server 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:60720->172.17.0.7:21, err= 2026/11/01 01:49:06 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-vifetew7resi/hello? sausage/êé" to be canonical "TestFTPProftpd{tgXdK}:rclone-test-vifetew7resi/hello? sausage/êé" 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:41777") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:37926->172.17.0.7:41777, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:32246") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:39404->172.17.0.7:32246, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: Connecting to FTP server 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:60724->172.17.0.7:21, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:17487") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:50684->172.17.0.7:17487, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:3481") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:54508->172.17.0.7:3481, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:58329") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:43062->172.17.0.7:58329, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:46235") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:50430->172.17.0.7:46235, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:27445") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:36630->172.17.0.7:27445, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:59087") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:51362->172.17.0.7:59087, err= 2026/11/01 01:49:06 DEBUG : Waiting for deletions to finish 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:8440") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:57918->172.17.0.7:8440, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:49240") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:38256->172.17.0.7:49240, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:64115") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:43164->172.17.0.7:64115, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:32232") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:58062->172.17.0.7:32232, err= 2026/11/01 01:49:06 INFO : a/b/c/d/e.txt: Deleted 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:30727") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:34102->172.17.0.7:30727, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:47300") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:47650->172.17.0.7:47300, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:56304") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:59746->172.17.0.7:56304, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: dial("tcp","172.17.0.7:49156") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé: > dial: conn=172.17.0.1:47384->172.17.0.7:49156, err= 2026/11/01 01:49:06 DEBUG : removing 1 level 4 directories 2026/11/01 01:49:06 INFO : a/b/c/d: Removing directory 2026/11/01 01:49:06 DEBUG : removing 1 level 3 directories 2026/11/01 01:49:06 INFO : a/b/c: Removing directory 2026/11/01 01:49:06 DEBUG : removing 1 level 2 directories 2026/11/01 01:49:06 INFO : a/b: Removing directory 2026/11/01 01:49:06 DEBUG : removing 1 level 1 directories 2026/11/01 01:49:06 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1363: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:29074") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:32790->172.17.0.7:29074, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:48274") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:37112->172.17.0.7:48274, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:60165") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:47454->172.17.0.7:60165, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:45382") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:60188->172.17.0.7:45382, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:45508") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:35268->172.17.0.7:45508, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:18704") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:43772->172.17.0.7:18704, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: Connecting to FTP server 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:43894") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:51534->172.17.0.7:43894, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:60734->172.17.0.7:21, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:13135") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:39858->172.17.0.7:13135, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:54678") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:57056->172.17.0.7:54678, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:49236") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:58336->172.17.0.7:49236, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:65258") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:38554->172.17.0.7:65258, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:13978") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:46048->172.17.0.7:13978, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:43718") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:59772->172.17.0.7:43718, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:57992") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:33592->172.17.0.7:57992, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:61459") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:48774->172.17.0.7:61459, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:22134") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:44778->172.17.0.7:22134, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:64002") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:34306->172.17.0.7:64002, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:38562") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:49872->172.17.0.7:38562, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:9718") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:41050->172.17.0.7:9718, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:22882") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:35972->172.17.0.7:22882, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:48444") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:53438->172.17.0.7:48444, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:47006") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:41736->172.17.0.7:47006, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:6046") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:53200->172.17.0.7:6046, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1515: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/11/01 01:49:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-mavehik0weja" 2026/11/01 01:49:06 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/01 01:49:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{tgXdK}" suffix to name 2026/11/01 01:49:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: Connecting to FTP server 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: > dial: conn=172.17.0.1:60744->172.17.0.7:21, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:14736") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:38252->172.17.0.7:14736, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: dial("tcp","172.17.0.7:42357") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: > dial: conn=172.17.0.1:36696->172.17.0.7:42357, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: dial("tcp","172.17.0.7:51142") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: > dial: conn=172.17.0.1:59498->172.17.0.7:51142, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: dial("tcp","172.17.0.7:51807") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: > dial: conn=172.17.0.1:41370->172.17.0.7:51807, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: dial("tcp","172.17.0.7:61595") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: > dial: conn=172.17.0.1:60362->172.17.0.7:61595, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: dial("tcp","172.17.0.7:24156") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: > dial: conn=172.17.0.1:32902->172.17.0.7:24156, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: dial("tcp","172.17.0.7:36830") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: > dial: conn=172.17.0.1:49892->172.17.0.7:36830, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: dial("tcp","172.17.0.7:47471") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: > dial: conn=172.17.0.1:40884->172.17.0.7:47471, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:16860") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:36378->172.17.0.7:16860, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:35504") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:56186->172.17.0.7:35504, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:26268") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:34836->172.17.0.7:26268, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:60268") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:47648->172.17.0.7:60268, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:1671") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:43844->172.17.0.7:1671, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: dial("tcp","172.17.0.7:22853") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: > dial: conn=172.17.0.1:52254->172.17.0.7:22853, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: dial("tcp","172.17.0.7:11560") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: > dial: conn=172.17.0.1:50524->172.17.0.7:11560, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: dial("tcp","172.17.0.7:60793") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: > dial: conn=172.17.0.1:39396->172.17.0.7:60793, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: dial("tcp","172.17.0.7:12958") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: > dial: conn=172.17.0.1:52276->172.17.0.7:12958, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: Purge dir "new_name" 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: Purge dir "" 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-mavehik0weja: closing 1 unused connections === 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:1711: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1742: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1813: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:52843") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:55020->172.17.0.7:52843, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:4742") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:47196->172.17.0.7:4742, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:22813") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:59798->172.17.0.7:22813, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:64813") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:48224->172.17.0.7:64813, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:42692") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:40274->172.17.0.7:42692, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:53731") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:35158->172.17.0.7:53731, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:29185") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:50780->172.17.0.7:29185, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:53123") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:53502->172.17.0.7:53123, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:43182") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:35200->172.17.0.7:43182, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:52018") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:33606->172.17.0.7:52018, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:8518") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:47248->172.17.0.7:8518, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:9810") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:40474->172.17.0.7:9810, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:30411") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:59480->172.17.0.7:30411, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:39418") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:40332->172.17.0.7:39418, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:9032") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:36122->172.17.0.7:9032, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:23899") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:55150->172.17.0.7:23899, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/11/01 01:49:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vifetew7resi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/11/01 01:49:06 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/01 01:49:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{tgXdK}" suffix to name 2026/11/01 01:49:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:60760->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.7:60081") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:56404->172.17.0.7:60081, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/11/01 01:49:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vifetew7resi/not found.txt" 2026/11/01 01:49:06 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/01 01:49:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{tgXdK}" suffix to name 2026/11/01 01:49:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/not found.txt: Connecting to FTP server 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/not found.txt: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/not found.txt: > dial: conn=172.17.0.1:60772->172.17.0.7:21, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/not found.txt: dial("tcp","172.17.0.7:57333") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/not found.txt: > dial: conn=172.17.0.1:47582->172.17.0.7:57333, err= 2026/11/01 01:49:06 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:2072: Opening root remote "TestFTPProftpd:" path "rclone-test-vifetew7resi" from "TestFTPProftpd:rclone-test-vifetew7resi" 2026/11/01 01:49:06 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/11/01 01:49:06 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/01 01:49:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{tgXdK}" suffix to name 2026/11/01 01:49:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: Connecting to FTP server 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:60780->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:42877") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:45120->172.17.0.7:42877, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:37691") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:34436->172.17.0.7:37691, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:53806") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:37252->172.17.0.7:53806, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:55128") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:59570->172.17.0.7:55128, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:54386") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:56872->172.17.0.7:54386, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:27344") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:57040->172.17.0.7:27344, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2109: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:3517") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:41106->172.17.0.7:3517, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:28597") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:55272->172.17.0.7:28597, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:55297") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:32952->172.17.0.7:55297, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:9679") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:57936->172.17.0.7:9679, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:41123") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:53588->172.17.0.7:41123, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:10654") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:53126->172.17.0.7:10654, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:63484") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:59590->172.17.0.7:63484, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:39719") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:58708->172.17.0.7:39719, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:49630") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:40584->172.17.0.7:49630, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:3270") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:58320->172.17.0.7:3270, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:36574") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:58214->172.17.0.7:36574, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2168: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:438: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2278: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2294: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:45780") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:43812->172.17.0.7:45780, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:32065") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:44972->172.17.0.7:32065, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:9676") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:35420->172.17.0.7:9676, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:34920") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:34568->172.17.0.7:34920, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:13621") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:58748->172.17.0.7:13621, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2450: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:29016") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:46138->172.17.0.7:29016, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:27758") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:52332->172.17.0.7:27758, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/11/01 01:49:06 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-vifetew7resi" 2026/11/01 01:49:06 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/01 01:49:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{COAnO}" suffix to name 2026/11/01 01:49:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: Connecting to FTP server 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:60796->172.17.0.7:21, err= 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:48080") 2026/11/01 01:49:06 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:50646->172.17.0.7:48080, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2535: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutRetry === RUN TestIntegration/FsMkdir/FsPutRetry/Simple === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:7456") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:47310->172.17.0.7:7456, err= fstests.go:2738: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:44943") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:43282->172.17.0.7:44943, err= fstests.go:2738: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Chunked fstests.go:2780: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:46360") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:55626->172.17.0.7:46360, err= === RUN TestIntegration/FsMkdir/FsPutShortEOF/Chunked fstests.go:2911: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2953: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:64309") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:34388->172.17.0.7:64309, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:56512") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:60502->172.17.0.7:56512, err= 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:59256") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:53030->172.17.0.7:59256, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/11/01 01:49:08 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vifetew7resi/deeper/nonexisting/directory" 2026/11/01 01:49:08 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/01 01:49:08 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:08 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:08 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:08 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:08 DEBUG : TestFTPProftpd: detected overridden config - adding "{tgXdK}" suffix to name 2026/11/01 01:49:08 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/01 01:49:08 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/01 01:49:08 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/01 01:49:08 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/deeper/nonexisting/directory: Connecting to FTP server 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/deeper/nonexisting/directory: dial("tcp","172.17.0.7:21") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi/deeper/nonexisting/directory: > dial: conn=172.17.0.1:33494->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:3102: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:3145: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:3202: FS has no Directory methods and doesn't Wrap 2026/11/01 01:49:08 DEBUG : Waiting for deletions to finish 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:24416") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:44080->172.17.0.7:24416, err= 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:35507") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:53080->172.17.0.7:35507, err= 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:6090") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:40280->172.17.0.7:6090, err= 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:29100") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:34462->172.17.0.7:29100, err= 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:5663") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:35196->172.17.0.7:5663, err= 2026/11/01 01:49:08 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:53887") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:43342->172.17.0.7:53887, err= 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:47619") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:35904->172.17.0.7:47619, err= 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:15354") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:45904->172.17.0.7:15354, err= 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:18202") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:41516->172.17.0.7:18202, err= 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:9073") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:45206->172.17.0.7:9073, err= 2026/11/01 01:49:08 DEBUG : removing 1 level 4 directories 2026/11/01 01:49:08 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/11/01 01:49:08 DEBUG : removing 1 level 3 directories 2026/11/01 01:49:08 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/11/01 01:49:08 DEBUG : removing 1 level 2 directories 2026/11/01 01:49:08 INFO : hello? sausage/êé: Removing directory 2026/11/01 01:49:08 DEBUG : removing 1 level 1 directories 2026/11/01 01:49:08 INFO : hello? sausage: Removing directory 2026/11/01 01:49:08 DEBUG : removing 1 level 0 directories 2026/11/01 01:49:08 INFO : ftp://172.17.0.7:21/rclone-test-vifetew7resi: Removing directory 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:7057") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:55208->172.17.0.7:7057, err= 2026/11/01 01:49:08 ERROR : error listing: directory not found 2026/11/01 01:49:08 DEBUG : Waiting for deletions to finish 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:53876") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:50734->172.17.0.7:53876, err= 2026/11/01 01:49:08 ERROR : error listing: directory not found 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: dial("tcp","172.17.0.7:58224") 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: > dial: conn=172.17.0.1:54872->172.17.0.7:58224, err= 2026/11/01 01:49:08 ERROR : ftp://172.17.0.7:21/rclone-test-vifetew7resi: Failed to list "": directory not found 2026/11/01 01:49:08 DEBUG : removing 1 level 0 directories 2026/11/01 01:49:08 INFO : ftp://172.17.0.7:21/rclone-test-vifetew7resi: Removing directory 2026/11/01 01:49:08 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/11/01 01:49:08 DEBUG : ftp://172.17.0.7:21/rclone-test-vifetew7resi: closing 2 unused connections 2026/11/01 01:49:08 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (4.81s) --- 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/FsRootCannotChangeHost (0.23s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (3.44s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.02s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.22s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (2.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.02s) --- 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.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.16s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.13s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (0.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (1.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (1.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutRetry (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/NetError (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Chunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Simple (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutShortEOF/Chunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.02s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 4.965s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 9.012335495s (try 1/5)