"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/09/23 15:05:18 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-jejojuy9xomu" 2025/09/23 15:05:18 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/23 15:05:18 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/23 15:05:18 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:18 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:18 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:18 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:18 DEBUG : TestFTPProftpd: detected overridden config - adding "{PP4m3}" suffix to name 2025/09/23 15:05:18 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:18 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:18 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:18 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: Connecting to FTP server 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:21") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:49064->172.17.0.2:21, err= 2025/09/23 15:05:18 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/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:25785") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:56528->172.17.0.2:25785, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:2496") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:48086->172.17.0.2:2496, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/09/23 15:05:18 INFO : dir/subdir: Making directory 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:55391") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:41370->172.17.0.2:55391, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:25535") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:51760->172.17.0.2:25535, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:59636") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:45568->172.17.0.2:59636, err= 2025/09/23 15:05:18 INFO : dir/subdir: Removing directory 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:12976") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:45704->172.17.0.2:12976, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:37826") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:54374->172.17.0.2:37826, err= 2025/09/23 15:05:18 INFO : dir: Removing directory 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:53340") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:42606->172.17.0.2:53340, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:1343") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:32872->172.17.0.2:1343, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:63526") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:59966->172.17.0.2:63526, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:36756") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:36208->172.17.0.2:36756, err= 2025/09/23 15:05:18 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/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:18375") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:58602->172.17.0.2:18375, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:15777") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:55650->172.17.0.2:15777, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:57934") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:46548->172.17.0.2:57934, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:46152") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:47700->172.17.0.2:46152, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:22598") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:35320->172.17.0.2:22598, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:52991") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:48344->172.17.0.2:52991, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:42372") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:46186->172.17.0.2:42372, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:59597") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:48350->172.17.0.2:59597, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:27537") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:57646->172.17.0.2:27537, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:48740") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:33842->172.17.0.2:48740, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:59955") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:47874->172.17.0.2:59955, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:51993") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:35530->172.17.0.2:51993, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:60364") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:36022->172.17.0.2:60364, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:23143") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:53970->172.17.0.2:23143, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:57352") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:49114->172.17.0.2:57352, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:6953") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:53522->172.17.0.2:6953, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:58745") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:50414->172.17.0.2:58745, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:5238") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:34976->172.17.0.2:5238, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:9419") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:54508->172.17.0.2:9419, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:40183") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:39972->172.17.0.2:40183, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:29999") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:42004->172.17.0.2:29999, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:10892") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:35252->172.17.0.2:10892, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:30039") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:33562->172.17.0.2:30039, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:54511") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:50406->172.17.0.2:54511, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:4994") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:54616->172.17.0.2:4994, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:41992") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:38470->172.17.0.2:41992, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:26802") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:38974->172.17.0.2:26802, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:57310") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:43242->172.17.0.2:57310, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:42312") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:58682->172.17.0.2:42312, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:24793") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:51408->172.17.0.2:24793, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:28531") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:47642->172.17.0.2:28531, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:59664") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:42030->172.17.0.2:59664, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:39547") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:56644->172.17.0.2:39547, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:20931") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:55312->172.17.0.2:20931, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:40281") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:56312->172.17.0.2:40281, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:61121") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:51538->172.17.0.2:61121, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:8387") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:53872->172.17.0.2:8387, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:17118") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:60124->172.17.0.2:17118, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:55184") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:45320->172.17.0.2:55184, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:34901") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:54154->172.17.0.2:34901, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:64835") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:45130->172.17.0.2:64835, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:49604") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:59446->172.17.0.2:49604, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:21360") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:49050->172.17.0.2:21360, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:59664") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:42036->172.17.0.2:59664, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:7212") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:35676->172.17.0.2:7212, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:13177") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:55642->172.17.0.2:13177, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:1082") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:34420->172.17.0.2:1082, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:64933") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:47664->172.17.0.2:64933, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:17391") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:42740->172.17.0.2:17391, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:9478") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:52108->172.17.0.2:9478, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:39582") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:57410->172.17.0.2:39582, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:46367") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:47362->172.17.0.2:46367, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:19346") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:41646->172.17.0.2:19346, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:4087") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:38554->172.17.0.2:4087, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:35343") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:41232->172.17.0.2:35343, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:23316") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:37872->172.17.0.2:23316, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:45056") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:49146->172.17.0.2:45056, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:61121") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:51546->172.17.0.2:61121, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:15092") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:48830->172.17.0.2:15092, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:21833") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:36558->172.17.0.2:21833, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:20380") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:37720->172.17.0.2:20380, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:42600") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:60608->172.17.0.2:42600, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:15963") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:42532->172.17.0.2:15963, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:58903") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:48156->172.17.0.2:58903, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:62507") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:59148->172.17.0.2:62507, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:55220") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:56676->172.17.0.2:55220, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:54490") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:59094->172.17.0.2:54490, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:5360") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:37976->172.17.0.2:5360, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:6804") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:39730->172.17.0.2:6804, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:44139") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:36112->172.17.0.2:44139, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:39238") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:54950->172.17.0.2:39238, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:6104") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:45284->172.17.0.2:6104, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:28208") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:55360->172.17.0.2:28208, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:59574") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:54390->172.17.0.2:59574, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:64744") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:35104->172.17.0.2:64744, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:34397") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:45468->172.17.0.2:34397, err= 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:7217") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:32872->172.17.0.2:7217, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:64803") 2025/09/23 15:05:18 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:33644->172.17.0.2:64803, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: Connecting to FTP server 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:21") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:49070->172.17.0.2:21, err= 2025/09/23 15:05:19 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:35605") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:42578->172.17.0.2:35605, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:23787") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:42992->172.17.0.2:23787, 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/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:47230") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:52552->172.17.0.2:47230, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:31554") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:58048->172.17.0.2:31554, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:30119") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:38334->172.17.0.2:30119, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:57079") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:48182->172.17.0.2:57079, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:55538") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:49488->172.17.0.2:55538, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:18461") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:39456->172.17.0.2:18461, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:33601") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:58780->172.17.0.2:33601, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:52506") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:54206->172.17.0.2:52506, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:46630") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:48224->172.17.0.2:46630, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:15274") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:53592->172.17.0.2:15274, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:48434") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:40470->172.17.0.2:48434, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:15224") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:47392->172.17.0.2:15224, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:30024") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:41402->172.17.0.2:30024, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:56488") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:49608->172.17.0.2:56488, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:65081") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:59296->172.17.0.2:65081, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:7995") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:47058->172.17.0.2:7995, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:24597") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:55632->172.17.0.2:24597, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/09/23 15:05:19 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/09/23 15:05:19 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/23 15:05:19 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:19 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:19 DEBUG : TestFTPProftpd: detected overridden config - adding "{PP4m3}" suffix to name 2025/09/23 15:05:19 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:19 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:49074->172.17.0.2:21, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:61782") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:45840->172.17.0.2:61782, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:43634") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:60828->172.17.0.2:43634, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:27567") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:38576->172.17.0.2:27567, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:34211") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:50046->172.17.0.2:34211, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:28353") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:51718->172.17.0.2:28353, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:21847") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:57942->172.17.0.2:21847, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:22122") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:37224->172.17.0.2:22122, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:26501") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:51204->172.17.0.2:26501, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:3155") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:50754->172.17.0.2:3155, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:49084") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:43120->172.17.0.2:49084, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:59582") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:52478->172.17.0.2:59582, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:11285") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:44876->172.17.0.2:11285, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:4513") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:49230->172.17.0.2:4513, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:29652") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:37618->172.17.0.2:29652, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:34049") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:37190->172.17.0.2:34049, 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/09/23 15:05:19 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-jejojuy9xomu/hello? sausage/êé" 2025/09/23 15:05:19 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/23 15:05:19 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:19 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:19 DEBUG : TestFTPProftpd: detected overridden config - adding "{PP4m3}" suffix to name 2025/09/23 15:05:19 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:19 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:19 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:19 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: Connecting to FTP server 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:49084->172.17.0.2:21, err= 2025/09/23 15:05:19 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-jejojuy9xomu/hello? sausage/êé" to be canonical "TestFTPProftpd{PP4m3}:rclone-test-jejojuy9xomu/hello? sausage/êé" 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:42886") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:40436->172.17.0.2:42886, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:30139") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:55654->172.17.0.2:30139, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: Connecting to FTP server 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:49086->172.17.0.2:21, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:43894") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:45382->172.17.0.2:43894, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:50631") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:43420->172.17.0.2:50631, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:17729") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:60322->172.17.0.2:17729, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:47257") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:42582->172.17.0.2:47257, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:43956") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:46356->172.17.0.2:43956, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:40475") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:33620->172.17.0.2:40475, err= 2025/09/23 15:05:19 DEBUG : Waiting for deletions to finish 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:45525") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:35640->172.17.0.2:45525, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:9721") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:56828->172.17.0.2:9721, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:16247") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:41930->172.17.0.2:16247, err= 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:39931") 2025/09/23 15:05:19 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:60916->172.17.0.2:39931, err= 2025/09/23 15:05:20 INFO : a/b/c/d/e.txt: Deleted 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:55804") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:57554->172.17.0.2:55804, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:5455") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:36034->172.17.0.2:5455, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:56496") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:35562->172.17.0.2:56496, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: dial("tcp","172.17.0.2:11613") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé: > dial: conn=172.17.0.1:47670->172.17.0.2:11613, err= 2025/09/23 15:05:20 DEBUG : removing 1 level 4 directories 2025/09/23 15:05:20 INFO : a/b/c/d: Removing directory 2025/09/23 15:05:20 DEBUG : removing 1 level 3 directories 2025/09/23 15:05:20 INFO : a/b/c: Removing directory 2025/09/23 15:05:20 DEBUG : removing 1 level 2 directories 2025/09/23 15:05:20 INFO : a/b: Removing directory 2025/09/23 15:05:20 DEBUG : removing 1 level 1 directories 2025/09/23 15:05:20 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:50720") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:57390->172.17.0.2:50720, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:60183") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:40742->172.17.0.2:60183, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:63145") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:40092->172.17.0.2:63145, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:42264") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:56226->172.17.0.2:42264, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:50187") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:36986->172.17.0.2:50187, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:16071") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:58708->172.17.0.2:16071, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: Connecting to FTP server 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:21") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:49102->172.17.0.2:21, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:10330") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:41106->172.17.0.2:10330, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:16025") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:34964->172.17.0.2:16025, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:37158") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:43962->172.17.0.2:37158, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:31551") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:58318->172.17.0.2:31551, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:61677") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:33884->172.17.0.2:61677, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:52298") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:60456->172.17.0.2:52298, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:24581") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:46694->172.17.0.2:24581, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:45627") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:53772->172.17.0.2:45627, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:20057") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:42378->172.17.0.2:20057, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:46674") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:48402->172.17.0.2:46674, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:11367") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:58342->172.17.0.2:11367, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:63500") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:45688->172.17.0.2:63500, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:53581") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:42768->172.17.0.2:53581, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:46625") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:33378->172.17.0.2:46625, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:11011") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:55178->172.17.0.2:11011, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:41277") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:58348->172.17.0.2:41277, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:10914") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:47868->172.17.0.2:10914, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/09/23 15:05:20 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-semexuf5viri" 2025/09/23 15:05:20 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/23 15:05:20 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:20 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:20 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:20 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:20 DEBUG : TestFTPProftpd: detected overridden config - adding "{PP4m3}" suffix to name 2025/09/23 15:05:20 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:20 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:20 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:20 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: Connecting to FTP server 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: dial("tcp","172.17.0.2:21") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: > dial: conn=172.17.0.1:49110->172.17.0.2:21, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:41520") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:55582->172.17.0.2:41520, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: dial("tcp","172.17.0.2:56178") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: > dial: conn=172.17.0.1:56614->172.17.0.2:56178, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: dial("tcp","172.17.0.2:52534") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: > dial: conn=172.17.0.1:53378->172.17.0.2:52534, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: dial("tcp","172.17.0.2:38154") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: > dial: conn=172.17.0.1:55560->172.17.0.2:38154, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: dial("tcp","172.17.0.2:46802") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: > dial: conn=172.17.0.1:33516->172.17.0.2:46802, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: dial("tcp","172.17.0.2:37699") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: > dial: conn=172.17.0.1:42658->172.17.0.2:37699, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: dial("tcp","172.17.0.2:53601") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: > dial: conn=172.17.0.1:37640->172.17.0.2:53601, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: dial("tcp","172.17.0.2:15492") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: > dial: conn=172.17.0.1:55600->172.17.0.2:15492, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:60552") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:58666->172.17.0.2:60552, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:22616") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:38988->172.17.0.2:22616, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:34585") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:35962->172.17.0.2:34585, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:26120") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:55480->172.17.0.2:26120, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:53525") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:56744->172.17.0.2:53525, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: dial("tcp","172.17.0.2:35140") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: > dial: conn=172.17.0.1:57482->172.17.0.2:35140, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: dial("tcp","172.17.0.2:12123") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: > dial: conn=172.17.0.1:41984->172.17.0.2:12123, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: dial("tcp","172.17.0.2:22051") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: > dial: conn=172.17.0.1:54152->172.17.0.2:22051, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: dial("tcp","172.17.0.2:26618") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: > dial: conn=172.17.0.1:60952->172.17.0.2:26618, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: Purge dir "new_name" 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-semexuf5viri: 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/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:58430") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:41556->172.17.0.2:58430, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:39315") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:47714->172.17.0.2:39315, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:20666") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:41448->172.17.0.2:20666, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:22584") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:41480->172.17.0.2:22584, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:55747") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:39912->172.17.0.2:55747, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:3261") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:49694->172.17.0.2:3261, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:16344") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:38480->172.17.0.2:16344, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:43407") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:42710->172.17.0.2:43407, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:24359") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:42170->172.17.0.2:24359, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/09/23 15:05:20 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-jejojuy9xomu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/09/23 15:05:20 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/23 15:05:20 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:20 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:20 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:20 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:20 DEBUG : TestFTPProftpd: detected overridden config - adding "{PP4m3}" suffix to name 2025/09/23 15:05:20 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:20 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:20 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:20 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:21") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:49118->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:55018") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:37988->172.17.0.2:55018, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/09/23 15:05:20 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-jejojuy9xomu/not found.txt" 2025/09/23 15:05:20 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/23 15:05:20 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:20 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:20 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:20 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:20 DEBUG : TestFTPProftpd: detected overridden config - adding "{PP4m3}" suffix to name 2025/09/23 15:05:20 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:20 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:20 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:20 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/not found.txt: Connecting to FTP server 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/not found.txt: dial("tcp","172.17.0.2:21") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/not found.txt: > dial: conn=172.17.0.1:49124->172.17.0.2:21, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/not found.txt: dial("tcp","172.17.0.2:19737") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/not found.txt: > dial: conn=172.17.0.1:56288->172.17.0.2:19737, err= 2025/09/23 15:05:20 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-jejojuy9xomu" from "TestFTPProftpd:rclone-test-jejojuy9xomu" 2025/09/23 15:05:20 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/09/23 15:05:20 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/23 15:05:20 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:20 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:20 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:20 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:20 DEBUG : TestFTPProftpd: detected overridden config - adding "{PP4m3}" suffix to name 2025/09/23 15:05:20 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:20 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:20 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:20 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:49128->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:11744") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:55518->172.17.0.2:11744, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:27523") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:44440->172.17.0.2:27523, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:12740") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:49592->172.17.0.2:12740, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:20442") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:52184->172.17.0.2:20442, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:27769") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50218->172.17.0.2:27769, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:15482") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:40402->172.17.0.2:15482, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:11348") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:39096->172.17.0.2:11348, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:46788") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:60494->172.17.0.2:46788, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:42924") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:58384->172.17.0.2:42924, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:11835") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:41462->172.17.0.2:11835, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:20976") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:44114->172.17.0.2:20976, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:40773") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:57806->172.17.0.2:40773, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:1127") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:51108->172.17.0.2:1127, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:12379") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:57910->172.17.0.2:12379, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:50774") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:33450->172.17.0.2:50774, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:60004") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:60470->172.17.0.2:60004, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:5950") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:40704->172.17.0.2:5950, 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/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:11086") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:40368->172.17.0.2:11086, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:41821") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:57244->172.17.0.2:41821, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:33610") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:56072->172.17.0.2:33610, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:45538") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:51860->172.17.0.2:45538, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:7454") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:44894->172.17.0.2:7454, 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/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:32908") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:43688->172.17.0.2:32908, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:7908") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:59322->172.17.0.2:7908, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/09/23 15:05:20 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-jejojuy9xomu" 2025/09/23 15:05:20 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/23 15:05:20 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:20 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:20 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:20 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:20 DEBUG : TestFTPProftpd: detected overridden config - adding "{6rwg8}" suffix to name 2025/09/23 15:05:20 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:20 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:20 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:20 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: Connecting to FTP server 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:21") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:49138->172.17.0.2:21, err= 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:47296") 2025/09/23 15:05:20 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:37812->172.17.0.2:47296, 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/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:41879") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:33292->172.17.0.2:41879, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:7466") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:33576->172.17.0.2:7466, err= 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:35869") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:37516->172.17.0.2:35869, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/09/23 15:05:21 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-jejojuy9xomu/deeper/nonexisting/directory" 2025/09/23 15:05:21 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/23 15:05:21 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:21 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:21 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:21 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:21 DEBUG : TestFTPProftpd: detected overridden config - adding "{PP4m3}" suffix to name 2025/09/23 15:05:21 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/23 15:05:21 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/23 15:05:21 DEBUG : Setting pass="rQbq_uFl5tHCo5_kYdp8P5Uwy8Et0xAdbK8Vf2h-1Hkr9g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/23 15:05:21 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/deeper/nonexisting/directory: Connecting to FTP server 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/deeper/nonexisting/directory: dial("tcp","172.17.0.2:21") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:49144->172.17.0.2: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/09/23 15:05:21 DEBUG : Waiting for deletions to finish 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:56538") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:50186->172.17.0.2:56538, err= 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:55800") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:48302->172.17.0.2:55800, err= 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:59818") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:49576->172.17.0.2:59818, err= 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:11398") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:39084->172.17.0.2:11398, err= 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:62099") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:39218->172.17.0.2:62099, err= 2025/09/23 15:05:21 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:64498") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:47362->172.17.0.2:64498, err= 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:57933") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:35090->172.17.0.2:57933, err= 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:24314") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:59462->172.17.0.2:24314, err= 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:22891") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:43492->172.17.0.2:22891, err= 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:61094") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:36344->172.17.0.2:61094, err= 2025/09/23 15:05:21 DEBUG : removing 1 level 4 directories 2025/09/23 15:05:21 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/09/23 15:05:21 DEBUG : removing 1 level 3 directories 2025/09/23 15:05:21 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/09/23 15:05:21 DEBUG : removing 1 level 2 directories 2025/09/23 15:05:21 INFO : hello? sausage/êé: Removing directory 2025/09/23 15:05:21 DEBUG : removing 1 level 1 directories 2025/09/23 15:05:21 INFO : hello? sausage: Removing directory 2025/09/23 15:05:21 DEBUG : removing 1 level 0 directories 2025/09/23 15:05:21 INFO : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: Removing directory 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:59146") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:48898->172.17.0.2:59146, err= 2025/09/23 15:05:21 ERROR : error listing: directory not found 2025/09/23 15:05:21 DEBUG : Waiting for deletions to finish 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:60582") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:50934->172.17.0.2:60582, err= 2025/09/23 15:05:21 ERROR : error listing: directory not found 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: dial("tcp","172.17.0.2:21924") 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: > dial: conn=172.17.0.1:44150->172.17.0.2:21924, err= 2025/09/23 15:05:21 ERROR : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: Failed to list "": directory not found 2025/09/23 15:05:21 DEBUG : removing 1 level 0 directories 2025/09/23 15:05:21 INFO : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: Removing directory 2025/09/23 15:05:21 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/09/23 15:05:21 DEBUG : ftp://172.17.0.2:21/rclone-test-jejojuy9xomu: closing 2 unused connections --- PASS: TestIntegration (2.89s) --- 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.82s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.02s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.28s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.02s) --- 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.03s) --- 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.41s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.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.09s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.09s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.08s) --- 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/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.02s) --- 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.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.02s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 2.918s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 3.784180085s (try 1/5)