"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/11/23 02:54:47 NOTICE: TestFTPProftpd: Starting server 2025/11/23 02:54:48 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.7:21" try 1/100 2025/11/23 02:54:48 DEBUG : TestFTPProftpd: Read 1, error: 2025/11/23 02:54:48 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.7:21" 2025/11/23 02:54:48 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-menetoz9xowe" 2025/11/23 02:54:48 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/11/23 02:54:48 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/23 02:54:48 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:48 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:48 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:48 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:48 DEBUG : TestFTPProftpd: detected overridden config - adding "{4_bsX}" suffix to name 2025/11/23 02:54:48 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:48 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:48 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:48 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: Connecting to FTP server 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:21") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:48472->172.17.0.7:21, err= 2025/11/23 02:54:48 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:31664") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:44198->172.17.0.7:31664, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:55618") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:48544->172.17.0.7:55618, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/11/23 02:54:48 INFO : dir/subdir: Making directory 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:60263") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:33298->172.17.0.7:60263, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:64295") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:39118->172.17.0.7:64295, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:35139") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:42346->172.17.0.7:35139, err= 2025/11/23 02:54:48 INFO : dir/subdir: Removing directory 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:60407") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:34988->172.17.0.7:60407, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:40096") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:47034->172.17.0.7:40096, err= 2025/11/23 02:54:48 INFO : dir: Removing directory 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:59243") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:42780->172.17.0.7:59243, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:4601") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:47476->172.17.0.7:4601, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:4013") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:42438->172.17.0.7:4013, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:52012") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:49932->172.17.0.7:52012, err= 2025/11/23 02:54:48 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:38488") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:51390->172.17.0.7:38488, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:27031") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:41090->172.17.0.7:27031, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:29849") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:33312->172.17.0.7:29849, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:50471") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:55598->172.17.0.7:50471, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:41359") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:57562->172.17.0.7:41359, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:41738") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:59338->172.17.0.7:41738, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:35100") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:33236->172.17.0.7:35100, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:48659") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:41768->172.17.0.7:48659, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:3484") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:51662->172.17.0.7:3484, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:58618") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:38974->172.17.0.7:58618, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:50427") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:41950->172.17.0.7:50427, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:32600") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:58582->172.17.0.7:32600, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:60669") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:34534->172.17.0.7:60669, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:23762") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:37400->172.17.0.7:23762, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:3091") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:59242->172.17.0.7:3091, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:35579") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:40540->172.17.0.7:35579, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:27517") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:53162->172.17.0.7:27517, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:12134") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:36930->172.17.0.7:12134, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:37070") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:45342->172.17.0.7:37070, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:47878") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:59362->172.17.0.7:47878, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:42775") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:55402->172.17.0.7:42775, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:27154") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:44298->172.17.0.7:27154, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:42606") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:43212->172.17.0.7:42606, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:41535") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:41026->172.17.0.7:41535, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:61270") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:48044->172.17.0.7:61270, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:37479") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:40538->172.17.0.7:37479, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:16096") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:38170->172.17.0.7:16096, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:54978") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:37208->172.17.0.7:54978, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:41056") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:54974->172.17.0.7:41056, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:19086") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:60946->172.17.0.7:19086, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:41456") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:39038->172.17.0.7:41456, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:14009") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:42530->172.17.0.7:14009, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:45093") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:52844->172.17.0.7:45093, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:5770") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:55326->172.17.0.7:5770, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:63457") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:60194->172.17.0.7:63457, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:20918") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:39546->172.17.0.7:20918, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:46485") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:48672->172.17.0.7:46485, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:33022") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:43412->172.17.0.7:33022, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:4042") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:55938->172.17.0.7:4042, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:48946") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:38286->172.17.0.7:48946, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:26106") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:49938->172.17.0.7:26106, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:53446") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:58390->172.17.0.7:53446, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:16011") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:46530->172.17.0.7:16011, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:21240") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:43032->172.17.0.7:21240, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:11674") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:46734->172.17.0.7:11674, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:18079") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:36286->172.17.0.7:18079, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:55795") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:33694->172.17.0.7:55795, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:38168") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:44330->172.17.0.7:38168, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:29190") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:34174->172.17.0.7:29190, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:27331") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:37580->172.17.0.7:27331, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:20511") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:40198->172.17.0.7:20511, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:6430") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:58748->172.17.0.7:6430, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:53462") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:50862->172.17.0.7:53462, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:62094") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:49232->172.17.0.7:62094, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:46942") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:58814->172.17.0.7:46942, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:49197") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:49910->172.17.0.7:49197, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:34038") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:33634->172.17.0.7:34038, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:62015") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:43652->172.17.0.7:62015, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:38641") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:54630->172.17.0.7:38641, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:9560") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:39786->172.17.0.7:9560, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:15566") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:52074->172.17.0.7:15566, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:14562") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:47338->172.17.0.7:14562, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:22545") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:51352->172.17.0.7:22545, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:59636") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:42724->172.17.0.7:59636, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:19309") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:49898->172.17.0.7:19309, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:20468") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:44654->172.17.0.7:20468, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:15020") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:47588->172.17.0.7:15020, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:64770") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:45596->172.17.0.7:64770, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:52466") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:48946->172.17.0.7:52466, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:18039") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:39908->172.17.0.7:18039, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:48182") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:59380->172.17.0.7:48182, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:13037") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:55578->172.17.0.7:13037, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:5950") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:48372->172.17.0.7:5950, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:63169") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:48974->172.17.0.7:63169, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:33254") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:46216->172.17.0.7:33254, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:16601") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:44576->172.17.0.7:16601, err= 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:15714") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:47830->172.17.0.7:15714, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:23515") 2025/11/23 02:54:48 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:44702->172.17.0.7:23515, err= 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: Connecting to FTP server 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:21") 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:48476->172.17.0.7:21, err= 2025/11/23 02:54:49 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:41510") 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:53804->172.17.0.7:41510, err= 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:17530") 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:44978->172.17.0.7:17530, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:11699") 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:57354->172.17.0.7:11699, err= 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:1083") 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:55280->172.17.0.7:1083, err= 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:4162") 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:51056->172.17.0.7:4162, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:24390") 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:49996->172.17.0.7:24390, err= 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:49757") 2025/11/23 02:54:49 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:35120->172.17.0.7:49757, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:24001") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:39008->172.17.0.7:24001, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:24423") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:56254->172.17.0.7:24423, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:9857") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:53800->172.17.0.7:9857, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:50889") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:56722->172.17.0.7:50889, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:30073") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:43770->172.17.0.7:30073, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:58163") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:46002->172.17.0.7:58163, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:21795") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:50802->172.17.0.7:21795, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:6660") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:46742->172.17.0.7:6660, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:24552") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:37802->172.17.0.7:24552, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:17399") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:45298->172.17.0.7:17399, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:51966") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:47598->172.17.0.7:51966, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:63535") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:54374->172.17.0.7:63535, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/11/23 02:54:50 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/11/23 02:54:50 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/23 02:54:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:50 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:50 DEBUG : TestFTPProftpd: detected overridden config - adding "{4_bsX}" suffix to name 2025/11/23 02:54:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:50 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: Connecting to FTP server 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:21") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:48492->172.17.0.7:21, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:19950") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:42762->172.17.0.7:19950, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:51460") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:36056->172.17.0.7:51460, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:63815") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:35550->172.17.0.7:63815, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:50257") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:34796->172.17.0.7:50257, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:19987") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:42386->172.17.0.7:19987, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:30188") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:45498->172.17.0.7:30188, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:52738") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:43880->172.17.0.7:52738, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:49237") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:53300->172.17.0.7:49237, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:54176") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:51756->172.17.0.7:54176, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:56930") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:38906->172.17.0.7:56930, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:17778") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:49284->172.17.0.7:17778, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:7366") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:34162->172.17.0.7:7366, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:36836") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:53478->172.17.0.7:36836, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:58264") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:35098->172.17.0.7:58264, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:23872") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:43472->172.17.0.7:23872, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1153: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1190: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/11/23 02:54:50 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-menetoz9xowe/hello? sausage/êé" 2025/11/23 02:54:50 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/23 02:54:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:50 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:50 DEBUG : TestFTPProftpd: detected overridden config - adding "{4_bsX}" suffix to name 2025/11/23 02:54:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:50 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: Connecting to FTP server 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:48504->172.17.0.7:21, err= 2025/11/23 02:54:50 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-menetoz9xowe/hello? sausage/êé" to be canonical "TestFTPProftpd{4_bsX}:rclone-test-menetoz9xowe/hello? sausage/êé" 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:31855") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:36346->172.17.0.7:31855, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:54599") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:37842->172.17.0.7:54599, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: Connecting to FTP server 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:61222") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:48520->172.17.0.7:21, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:40034->172.17.0.7:61222, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:11234") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:46012->172.17.0.7:11234, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:47977") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:58910->172.17.0.7:47977, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:20052") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:52690->172.17.0.7:20052, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:28208") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:35040->172.17.0.7:28208, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:37179") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:42396->172.17.0.7:37179, err= 2025/11/23 02:54:50 DEBUG : Waiting for deletions to finish 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:30712") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:54628->172.17.0.7:30712, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:40227") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:52194->172.17.0.7:40227, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:42189") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:56306->172.17.0.7:42189, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:64429") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:51102->172.17.0.7:64429, err= 2025/11/23 02:54:50 INFO : a/b/c/d/e.txt: Deleted 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:46339") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:38024->172.17.0.7:46339, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:40198") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:52308->172.17.0.7:40198, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:25242") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:35294->172.17.0.7:25242, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: dial("tcp","172.17.0.7:41070") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé: > dial: conn=172.17.0.1:50340->172.17.0.7:41070, err= 2025/11/23 02:54:50 DEBUG : removing 1 level 4 directories 2025/11/23 02:54:50 INFO : a/b/c/d: Removing directory 2025/11/23 02:54:50 DEBUG : removing 1 level 3 directories 2025/11/23 02:54:50 INFO : a/b/c: Removing directory 2025/11/23 02:54:50 DEBUG : removing 1 level 2 directories 2025/11/23 02:54:50 INFO : a/b: Removing directory 2025/11/23 02:54:50 DEBUG : removing 1 level 1 directories 2025/11/23 02:54:50 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:47512") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:36688->172.17.0.7:47512, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:58323") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:45426->172.17.0.7:58323, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:27010") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:49674->172.17.0.7:27010, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:6368") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:44940->172.17.0.7:6368, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:42545") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:41088->172.17.0.7:42545, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:49988") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:34878->172.17.0.7:49988, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: Connecting to FTP server 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:21") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:48524->172.17.0.7:21, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:29767") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:42456->172.17.0.7:29767, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:55448") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:39640->172.17.0.7:55448, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:51379") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:35190->172.17.0.7:51379, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:18088") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:46396->172.17.0.7:18088, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:35343") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:42448->172.17.0.7:35343, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:4048") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:54118->172.17.0.7:4048, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:58817") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:58816->172.17.0.7:58817, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:40070") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:56770->172.17.0.7:40070, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:44007") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:54684->172.17.0.7:44007, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:62663") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:53136->172.17.0.7:62663, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:56114") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:34854->172.17.0.7:56114, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:40851") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:38518->172.17.0.7:40851, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:64453") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:38458->172.17.0.7:64453, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:55095") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:47790->172.17.0.7:55095, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:3024") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:48998->172.17.0.7:3024, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:30357") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:33352->172.17.0.7:30357, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:7978") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:55880->172.17.0.7:7978, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/11/23 02:54:50 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vugikuv0waba" 2025/11/23 02:54:50 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/23 02:54:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:50 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:50 DEBUG : TestFTPProftpd: detected overridden config - adding "{4_bsX}" suffix to name 2025/11/23 02:54:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:50 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: Connecting to FTP server 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: dial("tcp","172.17.0.7:21") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: > dial: conn=172.17.0.1:48530->172.17.0.7:21, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:23742") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:57456->172.17.0.7:23742, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: dial("tcp","172.17.0.7:50284") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: > dial: conn=172.17.0.1:58690->172.17.0.7:50284, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: dial("tcp","172.17.0.7:5489") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: > dial: conn=172.17.0.1:43960->172.17.0.7:5489, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: dial("tcp","172.17.0.7:30401") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: > dial: conn=172.17.0.1:51872->172.17.0.7:30401, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: dial("tcp","172.17.0.7:1366") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: > dial: conn=172.17.0.1:58586->172.17.0.7:1366, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: dial("tcp","172.17.0.7:35588") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: > dial: conn=172.17.0.1:40968->172.17.0.7:35588, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: dial("tcp","172.17.0.7:35247") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: > dial: conn=172.17.0.1:45650->172.17.0.7:35247, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: dial("tcp","172.17.0.7:47056") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: > dial: conn=172.17.0.1:46130->172.17.0.7:47056, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:50884") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:40270->172.17.0.7:50884, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:53074") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:38870->172.17.0.7:53074, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:1025") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:44642->172.17.0.7:1025, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:50820") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:55244->172.17.0.7:50820, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:58415") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:41934->172.17.0.7:58415, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: dial("tcp","172.17.0.7:45771") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: > dial: conn=172.17.0.1:56326->172.17.0.7:45771, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: dial("tcp","172.17.0.7:51166") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: > dial: conn=172.17.0.1:46590->172.17.0.7:51166, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: dial("tcp","172.17.0.7:3929") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: > dial: conn=172.17.0.1:35018->172.17.0.7:3929, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: dial("tcp","172.17.0.7:40334") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: > dial: conn=172.17.0.1:45294->172.17.0.7:40334, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: Purge dir "new_name" 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-vugikuv0waba: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:25211") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:54438->172.17.0.7:25211, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:52580") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:60844->172.17.0.7:52580, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:19348") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:37176->172.17.0.7:19348, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:49165") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:37548->172.17.0.7:49165, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:22927") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:52870->172.17.0.7:22927, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:50258") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:35966->172.17.0.7:50258, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:12867") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:37634->172.17.0.7:12867, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:13818") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:44418->172.17.0.7:13818, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:37462") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:45874->172.17.0.7:37462, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/11/23 02:54:50 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-menetoz9xowe/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/11/23 02:54:50 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/23 02:54:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:50 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:50 DEBUG : TestFTPProftpd: detected overridden config - adding "{4_bsX}" suffix to name 2025/11/23 02:54:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:50 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.7:21") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:48532->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.7:4318") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:52378->172.17.0.7:4318, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/11/23 02:54:50 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-menetoz9xowe/not found.txt" 2025/11/23 02:54:50 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/23 02:54:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:50 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:50 DEBUG : TestFTPProftpd: detected overridden config - adding "{4_bsX}" suffix to name 2025/11/23 02:54:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:50 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/not found.txt: Connecting to FTP server 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/not found.txt: dial("tcp","172.17.0.7:21") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/not found.txt: > dial: conn=172.17.0.1:48542->172.17.0.7:21, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/not found.txt: dial("tcp","172.17.0.7:26565") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/not found.txt: > dial: conn=172.17.0.1:46770->172.17.0.7:26565, err= 2025/11/23 02:54:50 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-menetoz9xowe" from "TestFTPProftpd:rclone-test-menetoz9xowe" 2025/11/23 02:54:50 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/11/23 02:54:50 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/23 02:54:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:50 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:50 DEBUG : TestFTPProftpd: detected overridden config - adding "{4_bsX}" suffix to name 2025/11/23 02:54:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:50 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: Connecting to FTP server 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:21") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:48552->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:54687") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:60752->172.17.0.7:54687, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:31504") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:34794->172.17.0.7:31504, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:61486") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:35144->172.17.0.7:61486, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:36023") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:49736->172.17.0.7:36023, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:26075") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:41796->172.17.0.7:26075, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:59729") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:44482->172.17.0.7:59729, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:48363") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:48066->172.17.0.7:48363, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:22430") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:45950->172.17.0.7:22430, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:61511") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:40530->172.17.0.7:61511, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:39043") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:50130->172.17.0.7:39043, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:57323") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:47974->172.17.0.7:57323, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:63667") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:42174->172.17.0.7:63667, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:52661") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:34698->172.17.0.7:52661, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:15730") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:45784->172.17.0.7:15730, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:9830") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:50756->172.17.0.7:9830, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:59595") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:43446->172.17.0.7:59595, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:20150") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:40638->172.17.0.7:20150, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2004: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2109: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:26706") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:53904->172.17.0.7:26706, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:61081") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:49362->172.17.0.7:61081, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:47725") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:58104->172.17.0.7:47725, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:2459") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:49032->172.17.0.7:2459, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:44900") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:43996->172.17.0.7:44900, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2281: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:20126") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:40384->172.17.0.7:20126, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:28857") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:52886->172.17.0.7:28857, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/11/23 02:54:50 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-menetoz9xowe" 2025/11/23 02:54:50 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/23 02:54:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:50 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:50 DEBUG : TestFTPProftpd: detected overridden config - adding "{N3tJl}" suffix to name 2025/11/23 02:54:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:50 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: Connecting to FTP server 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:21") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:48568->172.17.0.7:21, err= 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:42288") 2025/11/23 02:54:50 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:56304->172.17.0.7:42288, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2476: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:48456") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:58524->172.17.0.7:48456, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:16938") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:60100->172.17.0.7:16938, err= 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:13324") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:44936->172.17.0.7:13324, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/11/23 02:54:51 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-menetoz9xowe/deeper/nonexisting/directory" 2025/11/23 02:54:51 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/23 02:54:51 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:51 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:51 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:51 DEBUG : TestFTPProftpd: detected overridden config - adding "{4_bsX}" suffix to name 2025/11/23 02:54:51 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/23 02:54:51 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/23 02:54:51 DEBUG : Setting pass="zSIxzRn9xJ5PAzPw3_633dScB8FpxG4S6-kPNBvO3aK2SQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/23 02:54:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/deeper/nonexisting/directory: Connecting to FTP server 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/deeper/nonexisting/directory: dial("tcp","172.17.0.7:21") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe/deeper/nonexisting/directory: > dial: conn=172.17.0.1:48570->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/11/23 02:54:51 DEBUG : Waiting for deletions to finish 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:8580") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:56456->172.17.0.7:8580, err= 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:8801") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:36916->172.17.0.7:8801, err= 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:30384") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:37682->172.17.0.7:30384, err= 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:64670") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:46506->172.17.0.7:64670, err= 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:6750") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:54866->172.17.0.7:6750, err= 2025/11/23 02:54:51 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:6053") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:59428->172.17.0.7:6053, err= 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:46657") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:54262->172.17.0.7:46657, err= 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:31650") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:36010->172.17.0.7:31650, err= 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:16716") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:49764->172.17.0.7:16716, err= 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:46647") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:37214->172.17.0.7:46647, err= 2025/11/23 02:54:51 DEBUG : removing 1 level 4 directories 2025/11/23 02:54:51 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/11/23 02:54:51 DEBUG : removing 1 level 3 directories 2025/11/23 02:54:51 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/11/23 02:54:51 DEBUG : removing 1 level 2 directories 2025/11/23 02:54:51 INFO : hello? sausage/êé: Removing directory 2025/11/23 02:54:51 DEBUG : removing 1 level 1 directories 2025/11/23 02:54:51 INFO : hello? sausage: Removing directory 2025/11/23 02:54:51 DEBUG : removing 1 level 0 directories 2025/11/23 02:54:51 INFO : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: Removing directory 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:63352") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:54640->172.17.0.7:63352, err= 2025/11/23 02:54:51 ERROR : error listing: directory not found 2025/11/23 02:54:51 DEBUG : Waiting for deletions to finish 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:38936") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:52398->172.17.0.7:38936, err= 2025/11/23 02:54:51 ERROR : error listing: directory not found 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: dial("tcp","172.17.0.7:57637") 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: > dial: conn=172.17.0.1:40002->172.17.0.7:57637, err= 2025/11/23 02:54:51 ERROR : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: Failed to list "": directory not found 2025/11/23 02:54:51 DEBUG : removing 1 level 0 directories 2025/11/23 02:54:51 INFO : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: Removing directory 2025/11/23 02:54:51 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/11/23 02:54:51 DEBUG : ftp://172.17.0.7:21/rclone-test-menetoz9xowe: closing 2 unused connections 2025/11/23 02:54:51 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (3.72s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.00s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (2.62s) --- 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.15s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.01s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.06s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.01s) --- 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/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.02s) --- 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.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.87s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.87s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.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.736s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 5.204550359s (try 1/5)