"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 TestIntegration fstests.go:464: Using remote "TestFTPProftpd:" 2026/10/26 02:33:26 NOTICE: TestFTPProftpd: Starting server 2026/10/26 02:33:27 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.4:21" try 1/100 2026/10/26 02:33:27 DEBUG : TestFTPProftpd: Read 1, error: 2026/10/26 02:33:27 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.4:21" 2026/10/26 02:33:27 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-joxitax6qedo" 2026/10/26 02:33:27 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/10/26 02:33:27 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/26 02:33:27 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:27 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:27 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:27 DEBUG : TestFTPProftpd: detected overridden config - adding "{HO0cd}" suffix to name 2026/10/26 02:33:27 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:27 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:27 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: Connecting to FTP server 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:41816->172.17.0.4:21, err= 2026/10/26 02:33:27 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/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:7140") 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:43412->172.17.0.4:7140, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRootCannotChangeHost 2026/10/26 02:33:27 DEBUG : Creating backend with remote "TestFTPProftpd://127.0.0.1:35235/" 2026/10/26 02:33:27 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/26 02:33:27 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:27 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:27 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:27 DEBUG : TestFTPProftpd: detected overridden config - adding "{HO0cd}" suffix to name 2026/10/26 02:33:27 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:27 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:27 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/127.0.0.1:35235: Connecting to FTP server 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/127.0.0.1:35235: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/127.0.0.1:35235: > dial: conn=172.17.0.1:41824->172.17.0.4:21, err= 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/127.0.0.1:35235: dial("tcp","172.17.0.4:58331") 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/127.0.0.1:35235: > dial: conn=172.17.0.1:57448->172.17.0.4:58331, err= 2026/10/26 02:33:27 DEBUG : Creating backend with remote "TestFTPProftpd://127.0.0.1:35235/rclone-test-joxitax6qedo/" 2026/10/26 02:33:27 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/26 02:33:27 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:27 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:27 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:27 DEBUG : TestFTPProftpd: detected overridden config - adding "{HO0cd}" suffix to name 2026/10/26 02:33:27 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:27 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:27 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/127.0.0.1:35235/rclone-test-joxitax6qedo: Connecting to FTP server 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/127.0.0.1:35235/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/127.0.0.1:35235/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:41828->172.17.0.4:21, err= 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/127.0.0.1:35235/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:58805") 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/127.0.0.1:35235/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:46314->172.17.0.4:58805, err= 2026/10/26 02:33:27 DEBUG : Creating backend with remote "TestFTPProftpd://user:pass@127.0.0.1:35235/" 2026/10/26 02:33:27 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/26 02:33:27 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:27 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:27 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:27 DEBUG : TestFTPProftpd: detected overridden config - adding "{HO0cd}" suffix to name 2026/10/26 02:33:27 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:27 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:27 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/user:pass@127.0.0.1:35235: Connecting to FTP server 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/user:pass@127.0.0.1:35235: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/user:pass@127.0.0.1:35235: > dial: conn=172.17.0.1:41834->172.17.0.4:21, err= 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/user:pass@127.0.0.1:35235: dial("tcp","172.17.0.4:26687") 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/user:pass@127.0.0.1:35235: > dial: conn=172.17.0.1:58292->172.17.0.4:26687, err= === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:34340") 2026/10/26 02:33:27 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:33100->172.17.0.4:34340, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/10/26 02:33:28 INFO : dir/subdir: Making directory 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:15525") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:42510->172.17.0.4:15525, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:1833") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:39224->172.17.0.4:1833, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:33052") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:59992->172.17.0.4:33052, err= 2026/10/26 02:33:28 INFO : dir/subdir: Removing directory 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:17605") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:53694->172.17.0.4:17605, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:45192") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:35912->172.17.0.4:45192, err= 2026/10/26 02:33:28 INFO : dir: Removing directory 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:18256") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:59224->172.17.0.4:18256, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:49217") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:41802->172.17.0.4:49217, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:41411") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:50204->172.17.0.4:41411, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:21008") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:35654->172.17.0.4:21008, err= 2026/10/26 02:33:28 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/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:18805") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:38766->172.17.0.4:18805, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:779: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:62176") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:39574->172.17.0.4:62176, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:36568") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:56678->172.17.0.4:36568, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:13423") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:48264->172.17.0.4:13423, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:64571") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:54520->172.17.0.4:64571, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:779: testing "．" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:47350") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:51432->172.17.0.4:47350, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:1735") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:35870->172.17.0.4:1735, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:63601") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:46840->172.17.0.4:63601, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:40882") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:49204->172.17.0.4:40882, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:779: testing "．．" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:3120") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:35708->172.17.0.4:3120, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:63112") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:48506->172.17.0.4:63112, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:53646") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:57672->172.17.0.4:53646, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:26946") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:38828->172.17.0.4:26946, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:779: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:64974") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:45104->172.17.0.4:64974, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:48012") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:49062->172.17.0.4:48012, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:11961") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:43382->172.17.0.4:11961, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:8559") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:33472->172.17.0.4:8559, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:779: testing " leading space" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:47049") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:48404->172.17.0.4:47049, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:60832") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:35046->172.17.0.4:60832, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:12710") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:35584->172.17.0.4:12710, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:53166") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:51946->172.17.0.4:53166, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:779: testing "~leading tilde" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:29638") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:58248->172.17.0.4:29638, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:27212") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:52650->172.17.0.4:27212, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:53976") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:35172->172.17.0.4:53976, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:61666") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:53138->172.17.0.4:61666, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:779: testing "␍leading CR" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:43793") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:47402->172.17.0.4:43793, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:33634") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:36200->172.17.0.4:33634, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:14387") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:38836->172.17.0.4:14387, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:27475") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:37866->172.17.0.4:27475, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:779: testing "␊leading LF" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:9510") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:54134->172.17.0.4:9510, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:34372") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:58726->172.17.0.4:34372, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:45257") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:42360->172.17.0.4:45257, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:6152") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:37858->172.17.0.4:6152, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:779: testing "␉leading HT" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:5406") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:51352->172.17.0.4:5406, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:57656") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:56514->172.17.0.4:57656, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:5188") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:48312->172.17.0.4:5188, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:51733") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:39296->172.17.0.4:51733, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:779: testing "␋leading VT" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:58368") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:42180->172.17.0.4:58368, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:3255") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:55554->172.17.0.4:3255, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:27080") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:60514->172.17.0.4:27080, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:60464") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:32970->172.17.0.4:60464, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:779: testing ".leading dot" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:65343") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:54994->172.17.0.4:65343, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:15191") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:50902->172.17.0.4:15191, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:21876") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:52722->172.17.0.4:21876, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:64783") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:57424->172.17.0.4:64783, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:779: testing "trailing space " 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:62180") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:58958->172.17.0.4:62180, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:32813") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:57682->172.17.0.4:32813, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:7808") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:33794->172.17.0.4:7808, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:43694") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:47674->172.17.0.4:43694, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:779: testing "trailing CR␍" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:28110") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:45346->172.17.0.4:28110, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:19495") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:34102->172.17.0.4:19495, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:31326") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:55830->172.17.0.4:31326, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:56724") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:44936->172.17.0.4:56724, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:779: testing "trailing LF␊" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:45683") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:57342->172.17.0.4:45683, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:19767") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:55616->172.17.0.4:19767, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:52856") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:57348->172.17.0.4:52856, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:23941") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:56064->172.17.0.4:23941, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:779: testing "trailing HT␉" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:52378") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:56516->172.17.0.4:52378, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:1708") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:55450->172.17.0.4:1708, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:50393") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:37768->172.17.0.4:50393, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:60865") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:33196->172.17.0.4:60865, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:779: testing "trailing VT␋" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:35057") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:40428->172.17.0.4:35057, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:30115") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:48610->172.17.0.4:30115, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:1482") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:48050->172.17.0.4:1482, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:39439") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:51250->172.17.0.4:39439, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:779: testing "trailing dot." 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:22237") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:50862->172.17.0.4:22237, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:5647") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:36682->172.17.0.4:5647, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:25637") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:60676->172.17.0.4:25637, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:15070") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:51654->172.17.0.4:15070, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:779: testing "invalid utf-8\xfe" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:7879") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:55906->172.17.0.4:7879, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:51694") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:33382->172.17.0.4:51694, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:9999") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:54818->172.17.0.4:9999, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:7688") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:33080->172.17.0.4:7688, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:779: testing "test%46.txt" 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:1350") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:52582->172.17.0.4:1350, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:30851") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:50244->172.17.0.4:30851, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:6936") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:51744->172.17.0.4:6936, err= 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:62507") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:37454->172.17.0.4:62507, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:62641") 2026/10/26 02:33:28 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:34116->172.17.0.4:62641, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: Connecting to FTP server 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:41840->172.17.0.4:21, err= 2026/10/26 02:33:29 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:19732") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:48924->172.17.0.4:19732, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:27028") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:41768->172.17.0.4:27028, 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/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:37561") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:46788->172.17.0.4:37561, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:53155") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:35158->172.17.0.4:53155, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:31836") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:47822->172.17.0.4:31836, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:61733") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:50604->172.17.0.4:61733, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:32756") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:34182->172.17.0.4:32756, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:19556") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:34638->172.17.0.4:19556, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:49651") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:60434->172.17.0.4:49651, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:34516") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:38808->172.17.0.4:34516, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:53103") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:46624->172.17.0.4:53103, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:38623") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:42392->172.17.0.4:38623, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:31865") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:42738->172.17.0.4:31865, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:63549") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:35566->172.17.0.4:63549, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:39730") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:51678->172.17.0.4:39730, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:61097") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:42156->172.17.0.4:61097, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:24314") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:50014->172.17.0.4:24314, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:31262") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:54718->172.17.0.4:31262, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:61415") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:51956->172.17.0.4:61415, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/10/26 02:33:29 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/10/26 02:33:29 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/26 02:33:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{HO0cd}" suffix to name 2026/10/26 02:33:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:41848->172.17.0.4:21, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:9502") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:51608->172.17.0.4:9502, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:63388") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:43324->172.17.0.4:63388, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:36544") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:33174->172.17.0.4:36544, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:51928") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:58338->172.17.0.4:51928, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:35147") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:43996->172.17.0.4:35147, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:15099") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:39502->172.17.0.4:15099, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:15350") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:58582->172.17.0.4:15350, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:46278") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:40236->172.17.0.4:46278, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:52483") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:39716->172.17.0.4:52483, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:12629") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:55168->172.17.0.4:12629, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1230: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:4771") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:36730->172.17.0.4:4771, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:21085") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:45982->172.17.0.4:21085, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:60800") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:52012->172.17.0.4:60800, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:23479") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:34314->172.17.0.4:23479, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:47090") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:42064->172.17.0.4:47090, 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/10/26 02:33:29 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-joxitax6qedo/hello? sausage/êé" 2026/10/26 02:33:29 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/26 02:33:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{HO0cd}" suffix to name 2026/10/26 02:33:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: Connecting to FTP server 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:41860->172.17.0.4:21, err= 2026/10/26 02:33:29 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-joxitax6qedo/hello? sausage/êé" to be canonical "TestFTPProftpd{HO0cd}:rclone-test-joxitax6qedo/hello? sausage/êé" 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:43386") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:55192->172.17.0.4:43386, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:7203") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:37070->172.17.0.4:7203, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: Connecting to FTP server 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:41868->172.17.0.4:21, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:10942") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:45876->172.17.0.4:10942, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:55106") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:37612->172.17.0.4:55106, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:38586") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:47576->172.17.0.4:38586, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:29038") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:42658->172.17.0.4:29038, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:32651") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:52474->172.17.0.4:32651, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:55383") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:53120->172.17.0.4:55383, err= 2026/10/26 02:33:29 DEBUG : Waiting for deletions to finish 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:32362") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:37104->172.17.0.4:32362, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:40516") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:49392->172.17.0.4:40516, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:17389") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:50618->172.17.0.4:17389, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:57823") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:60744->172.17.0.4:57823, err= 2026/10/26 02:33:29 INFO : a/b/c/d/e.txt: Deleted 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:34689") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:56716->172.17.0.4:34689, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:15065") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:46210->172.17.0.4:15065, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:39378") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:56832->172.17.0.4:39378, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: dial("tcp","172.17.0.4:21593") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé: > dial: conn=172.17.0.1:58692->172.17.0.4:21593, err= 2026/10/26 02:33:29 DEBUG : removing 1 level 4 directories 2026/10/26 02:33:29 INFO : a/b/c/d: Removing directory 2026/10/26 02:33:29 DEBUG : removing 1 level 3 directories 2026/10/26 02:33:29 INFO : a/b/c: Removing directory 2026/10/26 02:33:29 DEBUG : removing 1 level 2 directories 2026/10/26 02:33:29 INFO : a/b: Removing directory 2026/10/26 02:33:29 DEBUG : removing 1 level 1 directories 2026/10/26 02:33:29 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1363: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:32826") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:43098->172.17.0.4:32826, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:11100") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:44556->172.17.0.4:11100, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:13391") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:42010->172.17.0.4:13391, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:29025") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:34262->172.17.0.4:29025, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:42832") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:46574->172.17.0.4:42832, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:31924") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:51836->172.17.0.4:31924, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: Connecting to FTP server 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:13141") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:41874->172.17.0.4:21, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:50358->172.17.0.4:13141, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:55238") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:51230->172.17.0.4:55238, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:11814") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:36450->172.17.0.4:11814, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:25982") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:32902->172.17.0.4:25982, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:19493") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:40994->172.17.0.4:19493, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:57000") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:56338->172.17.0.4:57000, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:50741") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:50414->172.17.0.4:50741, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:15552") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:32936->172.17.0.4:15552, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:42655") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:53408->172.17.0.4:42655, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:41055") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:41372->172.17.0.4:41055, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:17507") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:41804->172.17.0.4:17507, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:41899") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:54922->172.17.0.4:41899, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:24936") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:18389") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:54102->172.17.0.4:24936, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:35772->172.17.0.4:18389, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:38217") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:47890->172.17.0.4:38217, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:35772") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:50502->172.17.0.4:35772, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:40798") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:59036->172.17.0.4:40798, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1515: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/10/26 02:33:29 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-teweqah5vehe" 2026/10/26 02:33:29 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/26 02:33:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{HO0cd}" suffix to name 2026/10/26 02:33:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: Connecting to FTP server 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: > dial: conn=172.17.0.1:41884->172.17.0.4:21, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:43479") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:51786->172.17.0.4:43479, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: dial("tcp","172.17.0.4:24330") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: > dial: conn=172.17.0.1:46898->172.17.0.4:24330, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: dial("tcp","172.17.0.4:45073") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: > dial: conn=172.17.0.1:38614->172.17.0.4:45073, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: dial("tcp","172.17.0.4:55395") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: > dial: conn=172.17.0.1:35490->172.17.0.4:55395, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: dial("tcp","172.17.0.4:36955") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: > dial: conn=172.17.0.1:53936->172.17.0.4:36955, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: dial("tcp","172.17.0.4:46478") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: > dial: conn=172.17.0.1:39798->172.17.0.4:46478, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: dial("tcp","172.17.0.4:18517") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: > dial: conn=172.17.0.1:40230->172.17.0.4:18517, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: dial("tcp","172.17.0.4:10721") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: > dial: conn=172.17.0.1:49872->172.17.0.4:10721, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:55175") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:38522->172.17.0.4:55175, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:27952") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:41288->172.17.0.4:27952, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:34098") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:57184->172.17.0.4:34098, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:42508") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:35324->172.17.0.4:42508, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:38652") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:44394->172.17.0.4:38652, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: dial("tcp","172.17.0.4:26732") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: > dial: conn=172.17.0.1:35434->172.17.0.4:26732, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: dial("tcp","172.17.0.4:58395") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: > dial: conn=172.17.0.1:49228->172.17.0.4:58395, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: dial("tcp","172.17.0.4:1548") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: > dial: conn=172.17.0.1:58152->172.17.0.4:1548, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: dial("tcp","172.17.0.4:48776") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: > dial: conn=172.17.0.1:45658->172.17.0.4:48776, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: Purge dir "new_name" 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-teweqah5vehe: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go: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/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:26185") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:39292->172.17.0.4:26185, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:20491") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:34636->172.17.0.4:20491, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:8265") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:42260->172.17.0.4:8265, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:24159") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:36492->172.17.0.4:24159, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:40261") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:41272->172.17.0.4:40261, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:16395") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:52576->172.17.0.4:16395, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:65362") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:45606->172.17.0.4:65362, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:32334") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:48390->172.17.0.4:32334, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:53926") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:51728->172.17.0.4:53926, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:34817") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:55582->172.17.0.4:34817, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:48396") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:57088->172.17.0.4:48396, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:53520") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:60938->172.17.0.4:53520, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:49868") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:34596->172.17.0.4:49868, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:37097") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:48290->172.17.0.4:37097, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:5044") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:36072->172.17.0.4:5044, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:24850") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:43358->172.17.0.4:24850, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/10/26 02:33:29 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-joxitax6qedo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/10/26 02:33:29 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/26 02:33:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{HO0cd}" suffix to name 2026/10/26 02:33:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:41898->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:14483") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:49542->172.17.0.4:14483, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/10/26 02:33:29 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-joxitax6qedo/not found.txt" 2026/10/26 02:33:29 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/26 02:33:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{HO0cd}" suffix to name 2026/10/26 02:33:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/not found.txt: Connecting to FTP server 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/not found.txt: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/not found.txt: > dial: conn=172.17.0.1:41906->172.17.0.4:21, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/not found.txt: dial("tcp","172.17.0.4:11861") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/not found.txt: > dial: conn=172.17.0.1:41358->172.17.0.4:11861, err= 2026/10/26 02:33:29 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:2072: Opening root remote "TestFTPProftpd:" path "rclone-test-joxitax6qedo" from "TestFTPProftpd:rclone-test-joxitax6qedo" 2026/10/26 02:33:29 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/10/26 02:33:29 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/26 02:33:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{HO0cd}" suffix to name 2026/10/26 02:33:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:41914->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37957") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:54934->172.17.0.4:37957, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:18866") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:42432->172.17.0.4:18866, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:3720") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:51124->172.17.0.4:3720, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:51588") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:39940->172.17.0.4:51588, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:54877") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:45184->172.17.0.4:54877, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:8752") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:53000->172.17.0.4:8752, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2109: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:63474") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:59782->172.17.0.4:63474, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:13544") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:53922->172.17.0.4:13544, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:27601") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34822->172.17.0.4:27601, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:53336") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:33126->172.17.0.4:53336, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:44403") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:52472->172.17.0.4:44403, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:56145") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:51148->172.17.0.4:56145, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:27619") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:49384->172.17.0.4:27619, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:5051") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:54602->172.17.0.4:5051, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:64151") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:42158->172.17.0.4:64151, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:24692") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:35134->172.17.0.4:24692, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:7638") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:42446->172.17.0.4:7638, 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:2273: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2289: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:27209") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:54440->172.17.0.4:27209, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:17252") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:58718->172.17.0.4:17252, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:46422") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:42118->172.17.0.4:46422, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:49656") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:54582->172.17.0.4:49656, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:57267") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:40588->172.17.0.4:57267, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2445: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:47271") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:47458->172.17.0.4:47271, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:36911") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:33998->172.17.0.4:36911, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/10/26 02:33:29 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-joxitax6qedo" 2026/10/26 02:33:29 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/26 02:33:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{-iTjz}" suffix to name 2026/10/26 02:33:29 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:29 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:29 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: Connecting to FTP server 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:41922->172.17.0.4:21, err= 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:39456") 2026/10/26 02:33:29 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:32852->172.17.0.4:39456, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2530: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutRetry === RUN TestIntegration/FsMkdir/FsPutRetry/Simple === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:41688") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:60432->172.17.0.4:41688, err= fstests.go:2733: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:55966") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:42836->172.17.0.4:55966, err= fstests.go:2733: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Chunked fstests.go:2775: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:15211") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:57346->172.17.0.4:15211, err= === RUN TestIntegration/FsMkdir/FsPutShortEOF/Chunked fstests.go:2906: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2948: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:32692") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:47270->172.17.0.4:32692, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:44400") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:55086->172.17.0.4:44400, err= 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:28826") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:34710->172.17.0.4:28826, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/10/26 02:33:30 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-joxitax6qedo/deeper/nonexisting/directory" 2026/10/26 02:33:30 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/26 02:33:30 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:30 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:30 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:30 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:30 DEBUG : TestFTPProftpd: detected overridden config - adding "{HO0cd}" suffix to name 2026/10/26 02:33:30 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/26 02:33:30 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/26 02:33:30 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/26 02:33:30 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/deeper/nonexisting/directory: Connecting to FTP server 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo/deeper/nonexisting/directory: > dial: conn=172.17.0.1:41928->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:3097: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:3140: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:3197: FS has no Directory methods and doesn't Wrap 2026/10/26 02:33:30 DEBUG : Waiting for deletions to finish 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:43121") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:32960->172.17.0.4:43121, err= 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:8979") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:51784->172.17.0.4:8979, err= 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:8247") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:60980->172.17.0.4:8247, err= 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:25287") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:47756->172.17.0.4:25287, err= 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:11894") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:33738->172.17.0.4:11894, err= 2026/10/26 02:33:30 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:41194") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:57252->172.17.0.4:41194, err= 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:5912") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:51760->172.17.0.4:5912, err= 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:36981") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:54982->172.17.0.4:36981, err= 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:62461") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:45234->172.17.0.4:62461, err= 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:2585") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:52346->172.17.0.4:2585, err= 2026/10/26 02:33:30 DEBUG : removing 1 level 4 directories 2026/10/26 02:33:30 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/10/26 02:33:30 DEBUG : removing 1 level 3 directories 2026/10/26 02:33:30 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/10/26 02:33:30 DEBUG : removing 1 level 2 directories 2026/10/26 02:33:30 INFO : hello? sausage/êé: Removing directory 2026/10/26 02:33:30 DEBUG : removing 1 level 1 directories 2026/10/26 02:33:30 INFO : hello? sausage: Removing directory 2026/10/26 02:33:30 DEBUG : removing 1 level 0 directories 2026/10/26 02:33:30 INFO : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: Removing directory 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:7583") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:58458->172.17.0.4:7583, err= 2026/10/26 02:33:30 ERROR : error listing: directory not found 2026/10/26 02:33:30 DEBUG : Waiting for deletions to finish 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:36853") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:40424->172.17.0.4:36853, err= 2026/10/26 02:33:30 ERROR : error listing: directory not found 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: dial("tcp","172.17.0.4:49098") 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: > dial: conn=172.17.0.1:33838->172.17.0.4:49098, err= 2026/10/26 02:33:30 ERROR : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: Failed to list "": directory not found 2026/10/26 02:33:30 DEBUG : removing 1 level 0 directories 2026/10/26 02:33:30 INFO : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: Removing directory 2026/10/26 02:33:30 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/10/26 02:33:30 DEBUG : ftp://172.17.0.4:21/rclone-test-joxitax6qedo: closing 2 unused connections 2026/10/26 02:33:30 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (3.84s) --- 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.03s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (2.52s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.17s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.01s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.25s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.66s) --- 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.01s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 3.954s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 4.976558089s (try 1/5)