"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestCommandEncodingNeutralisesCRLF --- PASS: TestCommandEncodingNeutralisesCRLF (0.00s) === RUN TestPutFtpConnectionDiscardsDeadConnection === RUN TestPutFtpConnectionDiscardsDeadConnection/network_error_discards === RUN TestPutFtpConnectionDiscardsDeadConnection/FTP_reply_error_with_live_connection_pools === RUN TestPutFtpConnectionDiscardsDeadConnection/FTP_reply_error_with_dead_connection_discards --- PASS: TestPutFtpConnectionDiscardsDeadConnection (0.10s) --- PASS: TestPutFtpConnectionDiscardsDeadConnection/network_error_discards (0.00s) --- PASS: TestPutFtpConnectionDiscardsDeadConnection/FTP_reply_error_with_live_connection_pools (0.00s) --- PASS: TestPutFtpConnectionDiscardsDeadConnection/FTP_reply_error_with_dead_connection_discards (0.10s) === RUN TestFtpReadCloserClose === RUN TestFtpReadCloserClose/425_before_any_read_is_masked_and_the_connection_is_not_pooled === RUN TestFtpReadCloserClose/425_after_data_was_read_stays_an_error === RUN TestFtpReadCloserClose/clean_close_pools_the_connection_once --- PASS: TestFtpReadCloserClose (0.00s) --- PASS: TestFtpReadCloserClose/425_before_any_read_is_masked_and_the_connection_is_not_pooled (0.00s) --- PASS: TestFtpReadCloserClose/425_after_data_was_read_stays_an_error (0.00s) --- PASS: TestFtpReadCloserClose/clean_close_pools_the_connection_once (0.00s) === RUN TestIntegration fstests.go:464: Using remote "TestFTPProftpd:" 2026/11/02 02:18:03 NOTICE: TestFTPProftpd: Starting server 2026/11/02 02:18:04 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.2:21" try 1/100 2026/11/02 02:18:04 DEBUG : TestFTPProftpd: Read 1, error: 2026/11/02 02:18:04 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.2:21" 2026/11/02 02:18:04 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-filocad0cubi" 2026/11/02 02:18:04 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/11/02 02:18:04 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/02 02:18:04 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:04 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:04 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{_nh9V}" suffix to name 2026/11/02 02:18:04 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:04 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:04 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:04 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: Connecting to FTP server 2026/11/02 02:18:04 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:04 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:35370->172.17.0.2:21, err= 2026/11/02 02:18:05 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:505: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:533: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:13509") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:49116->172.17.0.2:13509, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRootCannotChangeHost 2026/11/02 02:18:05 DEBUG : Creating backend with remote "TestFTPProftpd://127.0.0.1:33375/" 2026/11/02 02:18:05 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/02 02:18:05 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:05 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:05 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{_nh9V}" suffix to name 2026/11/02 02:18:05 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:05 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:05 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/127.0.0.1:33375: Connecting to FTP server 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/127.0.0.1:33375: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/127.0.0.1:33375: > dial: conn=172.17.0.1:35382->172.17.0.2:21, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/127.0.0.1:33375: dial("tcp","172.17.0.2:8376") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/127.0.0.1:33375: > dial: conn=172.17.0.1:48204->172.17.0.2:8376, err= 2026/11/02 02:18:05 DEBUG : Creating backend with remote "TestFTPProftpd://127.0.0.1:33375/rclone-test-filocad0cubi/" 2026/11/02 02:18:05 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/02 02:18:05 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:05 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:05 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{_nh9V}" suffix to name 2026/11/02 02:18:05 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:05 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:05 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/127.0.0.1:33375/rclone-test-filocad0cubi: Connecting to FTP server 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/127.0.0.1:33375/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/127.0.0.1:33375/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:35392->172.17.0.2:21, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/127.0.0.1:33375/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:48839") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/127.0.0.1:33375/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:38196->172.17.0.2:48839, err= 2026/11/02 02:18:05 DEBUG : Creating backend with remote "TestFTPProftpd://user:pass@127.0.0.1:33375/" 2026/11/02 02:18:05 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/02 02:18:05 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:05 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:05 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{_nh9V}" suffix to name 2026/11/02 02:18:05 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:05 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:05 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/user:pass@127.0.0.1:33375: Connecting to FTP server 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/user:pass@127.0.0.1:33375: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/user:pass@127.0.0.1:33375: > dial: conn=172.17.0.1:35406->172.17.0.2:21, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/user:pass@127.0.0.1:33375: dial("tcp","172.17.0.2:5441") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/user:pass@127.0.0.1:33375: > dial: conn=172.17.0.1:38656->172.17.0.2:5441, err= === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:53376") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:44412->172.17.0.2:53376, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/11/02 02:18:05 INFO : dir/subdir: Making directory 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:30394") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:44286->172.17.0.2:30394, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:34349") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:43524->172.17.0.2:34349, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:22574") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:44126->172.17.0.2:22574, err= 2026/11/02 02:18:05 INFO : dir/subdir: Removing directory 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:25855") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:46590->172.17.0.2:25855, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:5211") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:50170->172.17.0.2:5211, err= 2026/11/02 02:18:05 INFO : dir: Removing directory 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:32946") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:41208->172.17.0.2:32946, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:38746") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:49024->172.17.0.2:38746, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:18371") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:51588->172.17.0.2:18371, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:10588") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:49542->172.17.0.2:10588, err= 2026/11/02 02:18:05 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:19950") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:34276->172.17.0.2:19950, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:779: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:62777") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:60966->172.17.0.2:62777, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:23192") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:43628->172.17.0.2:23192, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:10255") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:49554->172.17.0.2:10255, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:61451") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:48780->172.17.0.2:61451, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:779: testing "．" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:32691") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:57918->172.17.0.2:32691, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:45582") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:37304->172.17.0.2:45582, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:18983") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:51056->172.17.0.2:18983, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:47075") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:34750->172.17.0.2:47075, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:779: testing "．．" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:25272") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:53710->172.17.0.2:25272, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:47641") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:57236->172.17.0.2:47641, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:34303") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:38352->172.17.0.2:34303, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:54159") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:34706->172.17.0.2:54159, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:779: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:3371") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:51342->172.17.0.2:3371, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:14483") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:43956->172.17.0.2:14483, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:1909") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:43626->172.17.0.2:1909, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:17650") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:58226->172.17.0.2:17650, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:779: testing " leading space" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:43334") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:57478->172.17.0.2:43334, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:39616") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:39120->172.17.0.2:39616, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:57970") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:43882->172.17.0.2:57970, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:55820") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:58442->172.17.0.2:55820, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:779: testing "~leading tilde" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:27457") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:54178->172.17.0.2:27457, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:22830") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:52570->172.17.0.2:22830, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:24634") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:35212->172.17.0.2:24634, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:49007") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:49996->172.17.0.2:49007, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:779: testing "␍leading CR" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:47662") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:37400->172.17.0.2:47662, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:28821") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:40006->172.17.0.2:28821, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:16419") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:43330->172.17.0.2:16419, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:20873") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:45604->172.17.0.2:20873, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:779: testing "␊leading LF" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:46168") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:48720->172.17.0.2:46168, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:25983") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:36660->172.17.0.2:25983, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:39799") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:44082->172.17.0.2:39799, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:43411") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:54174->172.17.0.2:43411, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:779: testing "␉leading HT" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:48152") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:35278->172.17.0.2:48152, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:49030") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:49188->172.17.0.2:49030, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:39328") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:34408->172.17.0.2:39328, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:15309") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:47744->172.17.0.2:15309, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:779: testing "␋leading VT" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:29078") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:47120->172.17.0.2:29078, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:57287") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:53190->172.17.0.2:57287, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:61360") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:53022->172.17.0.2:61360, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:53326") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:43846->172.17.0.2:53326, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:779: testing ".leading dot" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:39394") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:36732->172.17.0.2:39394, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:30129") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:47248->172.17.0.2:30129, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:41951") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:59390->172.17.0.2:41951, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:41742") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:43640->172.17.0.2:41742, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:779: testing "trailing space " 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:43589") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:37430->172.17.0.2:43589, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:42836") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:43596->172.17.0.2:42836, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:58369") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:55312->172.17.0.2:58369, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:21388") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:41946->172.17.0.2:21388, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:779: testing "trailing CR␍" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:16917") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:56352->172.17.0.2:16917, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:50805") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:39264->172.17.0.2:50805, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:11673") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:50436->172.17.0.2:11673, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:43351") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:33360->172.17.0.2:43351, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:779: testing "trailing LF␊" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:8100") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:54172->172.17.0.2:8100, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:35284") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:39220->172.17.0.2:35284, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:26824") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:47918->172.17.0.2:26824, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:54738") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:44292->172.17.0.2:54738, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:779: testing "trailing HT␉" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:63081") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:32912->172.17.0.2:63081, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:42219") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:34150->172.17.0.2:42219, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:10077") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:54888->172.17.0.2:10077, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:43715") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:58250->172.17.0.2:43715, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:779: testing "trailing VT␋" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:2668") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:40692->172.17.0.2:2668, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:48852") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:48650->172.17.0.2:48852, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:21591") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:47896->172.17.0.2:21591, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:49796") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:37574->172.17.0.2:49796, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:779: testing "trailing dot." 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:32348") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:33356->172.17.0.2:32348, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:59895") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:39056->172.17.0.2:59895, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:64082") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:32798->172.17.0.2:64082, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:60402") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:33940->172.17.0.2:60402, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:779: testing "invalid utf-8\xfe" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:51648") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:58206->172.17.0.2:51648, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:59907") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:50150->172.17.0.2:59907, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:48194") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:41194->172.17.0.2:48194, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:25508") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:35722->172.17.0.2:25508, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:779: testing "test%46.txt" 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:24502") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:38990->172.17.0.2:24502, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:24610") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:44440->172.17.0.2:24610, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:1715") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:53144->172.17.0.2:1715, err= 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:2556") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:55660->172.17.0.2:2556, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:1912") 2026/11/02 02:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:36724->172.17.0.2:1912, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: Connecting to FTP server 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:35410->172.17.0.2:21, err= 2026/11/02 02:18:06 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:51266") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:46574->172.17.0.2:51266, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:32004") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:40124->172.17.0.2:32004, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:858: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:895: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:977: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:59845") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:36256->172.17.0.2:59845, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:57866") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:52552->172.17.0.2:57866, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:6691") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:57458->172.17.0.2:6691, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:37721") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:40094->172.17.0.2:37721, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:34963") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:39476->172.17.0.2:34963, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:52044") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:44328->172.17.0.2:52044, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:43384") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:34806->172.17.0.2:43384, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:34047") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:44098->172.17.0.2:34047, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:13701") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:35182->172.17.0.2:13701, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:19680") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:56920->172.17.0.2:19680, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:63512") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:57068->172.17.0.2:63512, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:56042") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:48918->172.17.0.2:56042, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:49130") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:33948->172.17.0.2:49130, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:46303") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:43486->172.17.0.2:46303, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:60392") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:39998->172.17.0.2:60392, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:1159") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:59448->172.17.0.2:1159, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:42359") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:40044->172.17.0.2:42359, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/11/02 02:18:06 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/11/02 02:18:06 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/02 02:18:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{_nh9V}" suffix to name 2026/11/02 02:18:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:35426->172.17.0.2:21, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:3874") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:37906->172.17.0.2:3874, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:12098") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:39760->172.17.0.2:12098, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:47601") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:47934->172.17.0.2:47601, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:63591") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:43170->172.17.0.2:63591, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:4833") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:34786->172.17.0.2:4833, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:11428") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:33020->172.17.0.2:11428, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:18340") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:34224->172.17.0.2:18340, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:4666") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:33720->172.17.0.2:4666, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:49496") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:35132->172.17.0.2:49496, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:54824") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:55396->172.17.0.2:54824, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1230: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:38199") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:44880->172.17.0.2:38199, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:11073") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:43944->172.17.0.2:11073, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:10754") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:60022->172.17.0.2:10754, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:23931") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:41902->172.17.0.2:23931, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:42053") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:49822->172.17.0.2:42053, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1262: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1299: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/11/02 02:18:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-filocad0cubi/hello? sausage/êé" 2026/11/02 02:18:06 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/02 02:18:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{_nh9V}" suffix to name 2026/11/02 02:18:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: Connecting to FTP server 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:35438->172.17.0.2:21, err= 2026/11/02 02:18:06 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-filocad0cubi/hello? sausage/êé" to be canonical "TestFTPProftpd{_nh9V}:rclone-test-filocad0cubi/hello? sausage/êé" 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:33510") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:46436->172.17.0.2:33510, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:28213") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:44368->172.17.0.2:28213, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: Connecting to FTP server 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:35444->172.17.0.2:21, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:58405") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:42032->172.17.0.2:58405, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:31218") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:45860->172.17.0.2:31218, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:5151") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:48976->172.17.0.2:5151, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:1233") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:46242->172.17.0.2:1233, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:18468") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:52128->172.17.0.2:18468, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:29224") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:53390->172.17.0.2:29224, err= 2026/11/02 02:18:06 DEBUG : Waiting for deletions to finish 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:19544") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:52608->172.17.0.2:19544, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:61628") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:33216->172.17.0.2:61628, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:36465") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:58628->172.17.0.2:36465, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:12970") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:47430->172.17.0.2:12970, err= 2026/11/02 02:18:06 INFO : a/b/c/d/e.txt: Deleted 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:9539") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:56418->172.17.0.2:9539, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:1908") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:53854->172.17.0.2:1908, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:8557") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:60848->172.17.0.2:8557, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: dial("tcp","172.17.0.2:37854") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé: > dial: conn=172.17.0.1:55560->172.17.0.2:37854, err= 2026/11/02 02:18:06 DEBUG : removing 1 level 4 directories 2026/11/02 02:18:06 INFO : a/b/c/d: Removing directory 2026/11/02 02:18:06 DEBUG : removing 1 level 3 directories 2026/11/02 02:18:06 INFO : a/b/c: Removing directory 2026/11/02 02:18:06 DEBUG : removing 1 level 2 directories 2026/11/02 02:18:06 INFO : a/b: Removing directory 2026/11/02 02:18:06 DEBUG : removing 1 level 1 directories 2026/11/02 02:18:06 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1363: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:5064") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:41592->172.17.0.2:5064, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:16262") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:35720->172.17.0.2:16262, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:47720") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:34486->172.17.0.2:47720, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:41762") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:45172->172.17.0.2:41762, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:50201") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:60462->172.17.0.2:50201, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:34230") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:57474->172.17.0.2:34230, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: Connecting to FTP server 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:35446->172.17.0.2:21, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:19611") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:52546->172.17.0.2:19611, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:36319") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:56698->172.17.0.2:36319, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:18714") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:50522->172.17.0.2:18714, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:35523") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:53962->172.17.0.2:35523, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:46907") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:57958->172.17.0.2:46907, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:62285") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:49154->172.17.0.2:62285, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:38267") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:52006->172.17.0.2:38267, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:64553") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:53502->172.17.0.2:64553, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:16691") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:34606->172.17.0.2:16691, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:26782") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:49882->172.17.0.2:26782, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:37415") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:36960->172.17.0.2:37415, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:30685") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:53984->172.17.0.2:30685, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:21863") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:9607") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:57682->172.17.0.2:9607, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:37538->172.17.0.2:21863, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:61971") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:36116->172.17.0.2:61971, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:8089") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:43020->172.17.0.2:8089, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:32272") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:40302->172.17.0.2:32272, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1515: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/11/02 02:18:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zaxubux2sina" 2026/11/02 02:18:06 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/02 02:18:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{_nh9V}" suffix to name 2026/11/02 02:18:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: Connecting to FTP server 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: > dial: conn=172.17.0.1:35448->172.17.0.2:21, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:58608") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:58458->172.17.0.2:58608, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: dial("tcp","172.17.0.2:32059") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: > dial: conn=172.17.0.1:48036->172.17.0.2:32059, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: dial("tcp","172.17.0.2:24633") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: > dial: conn=172.17.0.1:49328->172.17.0.2:24633, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: dial("tcp","172.17.0.2:59257") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: > dial: conn=172.17.0.1:38784->172.17.0.2:59257, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: dial("tcp","172.17.0.2:17489") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: > dial: conn=172.17.0.1:35400->172.17.0.2:17489, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: dial("tcp","172.17.0.2:31657") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: > dial: conn=172.17.0.1:44482->172.17.0.2:31657, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: dial("tcp","172.17.0.2:64783") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: > dial: conn=172.17.0.1:33460->172.17.0.2:64783, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: dial("tcp","172.17.0.2:29473") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: > dial: conn=172.17.0.1:35532->172.17.0.2:29473, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:21999") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:40722->172.17.0.2:21999, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:16849") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:52246->172.17.0.2:16849, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:38795") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:35414->172.17.0.2:38795, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:14326") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:59206->172.17.0.2:14326, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:43347") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:60692->172.17.0.2:43347, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: dial("tcp","172.17.0.2:30925") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: > dial: conn=172.17.0.1:43326->172.17.0.2:30925, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: dial("tcp","172.17.0.2:26657") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: > dial: conn=172.17.0.1:42306->172.17.0.2:26657, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: dial("tcp","172.17.0.2:16805") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: > dial: conn=172.17.0.1:38178->172.17.0.2:16805, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: dial("tcp","172.17.0.2:2217") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: > dial: conn=172.17.0.1:59612->172.17.0.2:2217, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: Purge dir "new_name" 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: Purge dir "" 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zaxubux2sina: closing 1 unused connections === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1711: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1742: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1813: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:4066") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:38228->172.17.0.2:4066, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:36851") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:58542->172.17.0.2:36851, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:47156") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:51194->172.17.0.2:47156, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:10383") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:42164->172.17.0.2:10383, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:14470") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:41440->172.17.0.2:14470, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:37614") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:60926->172.17.0.2:37614, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:51583") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:35118->172.17.0.2:51583, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:43443") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:41722->172.17.0.2:43443, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:8741") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:59622->172.17.0.2:8741, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:54168") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:50896->172.17.0.2:54168, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:42841") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:53338->172.17.0.2:42841, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:50799") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:41856->172.17.0.2:50799, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:42888") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:40930->172.17.0.2:42888, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:19024") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:40512->172.17.0.2:19024, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:6872") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:43538->172.17.0.2:6872, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:22832") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:60192->172.17.0.2:22832, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/11/02 02:18:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-filocad0cubi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/11/02 02:18:06 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/02 02:18:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{_nh9V}" suffix to name 2026/11/02 02:18:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:35452->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:53439") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:47786->172.17.0.2:53439, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/11/02 02:18:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-filocad0cubi/not found.txt" 2026/11/02 02:18:06 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/02 02:18:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{_nh9V}" suffix to name 2026/11/02 02:18:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/not found.txt: Connecting to FTP server 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/not found.txt: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/not found.txt: > dial: conn=172.17.0.1:35466->172.17.0.2:21, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/not found.txt: dial("tcp","172.17.0.2:39170") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/not found.txt: > dial: conn=172.17.0.1:57852->172.17.0.2:39170, err= 2026/11/02 02:18:06 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:2072: Opening root remote "TestFTPProftpd:" path "rclone-test-filocad0cubi" from "TestFTPProftpd:rclone-test-filocad0cubi" 2026/11/02 02:18:06 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/11/02 02:18:06 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/02 02:18:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{_nh9V}" suffix to name 2026/11/02 02:18:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:35472->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:38280") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:57778->172.17.0.2:38280, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:32001") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:58788->172.17.0.2:32001, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:22326") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:55942->172.17.0.2:22326, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:61513") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:52336->172.17.0.2:61513, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:37680") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:51380->172.17.0.2:37680, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:27444") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:44506->172.17.0.2:27444, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2109: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:65476") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:57046->172.17.0.2:65476, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:41386") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:52494->172.17.0.2:41386, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:27240") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:43260->172.17.0.2:27240, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:45730") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:60144->172.17.0.2:45730, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:59669") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:43200->172.17.0.2:59669, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:20188") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:41762->172.17.0.2:20188, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:38195") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:45414->172.17.0.2:38195, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:2863") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:42080->172.17.0.2:2863, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:1754") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:53836->172.17.0.2:1754, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:40639") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:43580->172.17.0.2:40639, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:50789") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:54724->172.17.0.2:50789, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2168: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:438: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2278: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2294: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:62942") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:34932->172.17.0.2:62942, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:7497") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:33256->172.17.0.2:7497, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:43457") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:39706->172.17.0.2:43457, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:21776") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:51648->172.17.0.2:21776, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:23463") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:60962->172.17.0.2:23463, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2450: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:8480") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:50092->172.17.0.2:8480, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:44575") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:54076->172.17.0.2:44575, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/11/02 02:18:06 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-filocad0cubi" 2026/11/02 02:18:06 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/02 02:18:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{X_OrM}" suffix to name 2026/11/02 02:18:06 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:06 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:06 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: Connecting to FTP server 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:35484->172.17.0.2:21, err= 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:28492") 2026/11/02 02:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:46224->172.17.0.2:28492, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2535: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutRetry === RUN TestIntegration/FsMkdir/FsPutRetry/Simple === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:53187") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:33728->172.17.0.2:53187, err= fstests.go:2738: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:50965") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:52486->172.17.0.2:50965, err= fstests.go:2738: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Chunked fstests.go:2780: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:46370") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:35254->172.17.0.2:46370, err= === RUN TestIntegration/FsMkdir/FsPutShortEOF/Chunked fstests.go:2911: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2953: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:5284") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:59958->172.17.0.2:5284, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:58425") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:60040->172.17.0.2:58425, err= 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:49510") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:42192->172.17.0.2:49510, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/11/02 02:18:07 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-filocad0cubi/deeper/nonexisting/directory" 2026/11/02 02:18:07 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/11/02 02:18:07 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:07 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:07 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:07 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:07 DEBUG : TestFTPProftpd: detected overridden config - adding "{_nh9V}" suffix to name 2026/11/02 02:18:07 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/11/02 02:18:07 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/11/02 02:18:07 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/11/02 02:18:07 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/deeper/nonexisting/directory: Connecting to FTP server 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/deeper/nonexisting/directory: dial("tcp","172.17.0.2:21") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi/deeper/nonexisting/directory: > dial: conn=172.17.0.1:59820->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:3102: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:3145: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:3202: FS has no Directory methods and doesn't Wrap 2026/11/02 02:18:07 DEBUG : Waiting for deletions to finish 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:16015") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:56052->172.17.0.2:16015, err= 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:57228") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:40686->172.17.0.2:57228, err= 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:3387") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:39078->172.17.0.2:3387, err= 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:61608") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:54008->172.17.0.2:61608, err= 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:18524") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:34146->172.17.0.2:18524, err= 2026/11/02 02:18:07 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:31696") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:33642->172.17.0.2:31696, err= 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:7113") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:53972->172.17.0.2:7113, err= 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:33455") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:44402->172.17.0.2:33455, err= 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:38683") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:54182->172.17.0.2:38683, err= 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:46275") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:60346->172.17.0.2:46275, err= 2026/11/02 02:18:07 DEBUG : removing 1 level 4 directories 2026/11/02 02:18:07 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/11/02 02:18:07 DEBUG : removing 1 level 3 directories 2026/11/02 02:18:07 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/11/02 02:18:07 DEBUG : removing 1 level 2 directories 2026/11/02 02:18:07 INFO : hello? sausage/êé: Removing directory 2026/11/02 02:18:07 DEBUG : removing 1 level 1 directories 2026/11/02 02:18:07 INFO : hello? sausage: Removing directory 2026/11/02 02:18:07 DEBUG : removing 1 level 0 directories 2026/11/02 02:18:07 INFO : ftp://172.17.0.2:21/rclone-test-filocad0cubi: Removing directory 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:64902") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:49520->172.17.0.2:64902, err= 2026/11/02 02:18:07 ERROR : error listing: directory not found 2026/11/02 02:18:07 DEBUG : Waiting for deletions to finish 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:53023") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:40648->172.17.0.2:53023, err= 2026/11/02 02:18:07 ERROR : error listing: directory not found 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: dial("tcp","172.17.0.2:52043") 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: > dial: conn=172.17.0.1:51592->172.17.0.2:52043, err= 2026/11/02 02:18:07 ERROR : ftp://172.17.0.2:21/rclone-test-filocad0cubi: Failed to list "": directory not found 2026/11/02 02:18:07 DEBUG : removing 1 level 0 directories 2026/11/02 02:18:07 INFO : ftp://172.17.0.2:21/rclone-test-filocad0cubi: Removing directory 2026/11/02 02:18:07 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/11/02 02:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-filocad0cubi: closing 2 unused connections 2026/11/02 02:18:07 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (3.73s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.00s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRootCannotChangeHost (0.03s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (2.43s) --- 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.16s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (0.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.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.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.853s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 4.643014654s (try 1/5)