"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/11/27 01:16:00 NOTICE: TestFTPProftpd: Starting server 2025/11/27 01:16:01 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.7:21" try 1/100 2025/11/27 01:16:01 DEBUG : TestFTPProftpd: Read 1, error: 2025/11/27 01:16:01 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.7:21" 2025/11/27 01:16:01 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-wuyofek3vupu" 2025/11/27 01:16:01 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/11/27 01:16:01 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/27 01:16:01 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:01 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:01 DEBUG : TestFTPProftpd: detected overridden config - adding "{D0yZ3}" suffix to name 2025/11/27 01:16:01 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:01 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:01 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: Connecting to FTP server 2025/11/27 01:16:01 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:21") 2025/11/27 01:16:01 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:45324->172.17.0.7:21, err= 2025/11/27 01:16:02 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/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:24408") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:56226->172.17.0.7:24408, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:6641") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:41716->172.17.0.7:6641, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/11/27 01:16:02 INFO : dir/subdir: Making directory 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:26308") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:48940->172.17.0.7:26308, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:47082") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:42362->172.17.0.7:47082, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:21029") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:42804->172.17.0.7:21029, err= 2025/11/27 01:16:02 INFO : dir/subdir: Removing directory 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:17432") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:44404->172.17.0.7:17432, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:53269") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:45570->172.17.0.7:53269, err= 2025/11/27 01:16:02 INFO : dir: Removing directory 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:30910") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:40024->172.17.0.7:30910, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:32576") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:37430->172.17.0.7:32576, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:46902") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:58528->172.17.0.7:46902, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:24137") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:58124->172.17.0.7:24137, err= 2025/11/27 01:16:02 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/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:27423") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:38246->172.17.0.7:27423, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:10043") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:51998->172.17.0.7:10043, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:20861") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:60482->172.17.0.7:20861, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:56566") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:50062->172.17.0.7:56566, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:55057") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:48212->172.17.0.7:55057, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:8310") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:50266->172.17.0.7:8310, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:29266") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:44390->172.17.0.7:29266, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:55314") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:34420->172.17.0.7:55314, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:9129") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:48852->172.17.0.7:9129, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:1414") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:36924->172.17.0.7:1414, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:42027") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:60824->172.17.0.7:42027, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:59348") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:40194->172.17.0.7:59348, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:31658") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:51268->172.17.0.7:31658, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:24786") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:36134->172.17.0.7:24786, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:63052") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:39364->172.17.0.7:63052, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:61726") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:48014->172.17.0.7:61726, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:37710") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:52112->172.17.0.7:37710, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:1983") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:42756->172.17.0.7:1983, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:28747") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:43594->172.17.0.7:28747, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:63318") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:33856->172.17.0.7:63318, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:25368") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:54486->172.17.0.7:25368, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:34364") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:60182->172.17.0.7:34364, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:24092") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:54102->172.17.0.7:24092, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:6915") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:55124->172.17.0.7:6915, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:54369") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:35964->172.17.0.7:54369, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:40500") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:59036->172.17.0.7:40500, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:59161") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:55618->172.17.0.7:59161, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:19745") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:41516->172.17.0.7:19745, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:7542") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:54500->172.17.0.7:7542, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:40528") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:36076->172.17.0.7:40528, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:42858") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:43638->172.17.0.7:42858, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:33941") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:39460->172.17.0.7:33941, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:49548") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:44782->172.17.0.7:49548, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:62696") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:56816->172.17.0.7:62696, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:24973") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:40474->172.17.0.7:24973, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:39070") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:41016->172.17.0.7:39070, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:5471") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:54906->172.17.0.7:5471, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:53216") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:36868->172.17.0.7:53216, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:28850") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:34014->172.17.0.7:28850, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:13577") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:55528->172.17.0.7:13577, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:53607") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:54720->172.17.0.7:53607, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:5342") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:52480->172.17.0.7:5342, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:7390") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:35846->172.17.0.7:7390, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:19731") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:57408->172.17.0.7:19731, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:29105") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:59236->172.17.0.7:29105, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:4908") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:35724->172.17.0.7:4908, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:15923") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:58664->172.17.0.7:15923, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:1280") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:36332->172.17.0.7:1280, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:5868") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:59598->172.17.0.7:5868, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:43646") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:38464->172.17.0.7:43646, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:63574") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:39882->172.17.0.7:63574, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:30212") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:37118->172.17.0.7:30212, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:12475") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:60358->172.17.0.7:12475, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:22131") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:49506->172.17.0.7:22131, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:36104") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:33152->172.17.0.7:36104, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:1309") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:59230->172.17.0.7:1309, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:61608") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:58358->172.17.0.7:61608, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:29730") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:48872->172.17.0.7:29730, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:20031") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:50008->172.17.0.7:20031, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:3615") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:45166->172.17.0.7:3615, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:4724") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:50608->172.17.0.7:4724, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:61865") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:42622->172.17.0.7:61865, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:36533") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:58270->172.17.0.7:36533, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:53248") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:59404->172.17.0.7:53248, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:59027") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:58266->172.17.0.7:59027, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:60483") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:35274->172.17.0.7:60483, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:26784") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:34312->172.17.0.7:26784, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:63475") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:35648->172.17.0.7:63475, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:48164") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:50070->172.17.0.7:48164, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:54611") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:47916->172.17.0.7:54611, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:11517") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:45378->172.17.0.7:11517, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:36237") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:50482->172.17.0.7:36237, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:58930") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:55674->172.17.0.7:58930, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:17884") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:51802->172.17.0.7:17884, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:54944") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:43568->172.17.0.7:54944, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:22500") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:36128->172.17.0.7:22500, err= 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:21768") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:52036->172.17.0.7:21768, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:5332") 2025/11/27 01:16:02 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:32852->172.17.0.7:5332, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: Connecting to FTP server 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:21") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:45336->172.17.0.7:21, err= 2025/11/27 01:16:03 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:43552") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:54590->172.17.0.7:43552, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:51024") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:53392->172.17.0.7:51024, 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/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:21052") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:40438->172.17.0.7:21052, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:62111") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:45622->172.17.0.7:62111, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:10570") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:32972->172.17.0.7:10570, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:59320") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:46618->172.17.0.7:59320, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:51791") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:36164->172.17.0.7:51791, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:63060") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:45804->172.17.0.7:63060, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:3770") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:34916->172.17.0.7:3770, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:50172") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:58100->172.17.0.7:50172, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:3993") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:38448->172.17.0.7:3993, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:19905") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:53920->172.17.0.7:19905, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:7625") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:60084->172.17.0.7:7625, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:51232") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:41468->172.17.0.7:51232, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:44655") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:51166->172.17.0.7:44655, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:61583") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:57700->172.17.0.7:61583, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:47643") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:45940->172.17.0.7:47643, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:50415") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:48028->172.17.0.7:50415, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:24893") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:48814->172.17.0.7:24893, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/11/27 01:16:03 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/11/27 01:16:03 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/27 01:16:03 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:03 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:03 DEBUG : TestFTPProftpd: detected overridden config - adding "{D0yZ3}" suffix to name 2025/11/27 01:16:03 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:03 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: Connecting to FTP server 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:21") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:45338->172.17.0.7:21, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:32446") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:52524->172.17.0.7:32446, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:64390") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:40906->172.17.0.7:64390, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:28433") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:38704->172.17.0.7:28433, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:36701") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:59346->172.17.0.7:36701, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:58576") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:38250->172.17.0.7:58576, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:35049") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:48590->172.17.0.7:35049, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:31816") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:53514->172.17.0.7:31816, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:21120") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:52920->172.17.0.7:21120, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:4170") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:47236->172.17.0.7:4170, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:25152") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:43192->172.17.0.7:25152, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:1052") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:54516->172.17.0.7:1052, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:23617") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:44374->172.17.0.7:23617, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:60849") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:36690->172.17.0.7:60849, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:43581") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:38000->172.17.0.7:43581, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:9107") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:52952->172.17.0.7:9107, 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/27 01:16:03 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-wuyofek3vupu/hello? sausage/êé" 2025/11/27 01:16:03 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/27 01:16:03 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:03 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:03 DEBUG : TestFTPProftpd: detected overridden config - adding "{D0yZ3}" suffix to name 2025/11/27 01:16:03 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:03 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: Connecting to FTP server 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:45346->172.17.0.7:21, err= 2025/11/27 01:16:03 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-wuyofek3vupu/hello? sausage/êé" to be canonical "TestFTPProftpd{D0yZ3}:rclone-test-wuyofek3vupu/hello? sausage/êé" 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:59211") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:56492->172.17.0.7:59211, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:12938") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:42436->172.17.0.7:12938, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: Connecting to FTP server 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:45358->172.17.0.7:21, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:20550") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:45570->172.17.0.7:20550, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:45840") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:44434->172.17.0.7:45840, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:29718") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:57310->172.17.0.7:29718, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:42442") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:41366->172.17.0.7:42442, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:57335") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:47364->172.17.0.7:57335, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:28997") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:49186->172.17.0.7:28997, err= 2025/11/27 01:16:03 DEBUG : Waiting for deletions to finish 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:60370") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:58752->172.17.0.7:60370, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:1494") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:51804->172.17.0.7:1494, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:52288") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:53418->172.17.0.7:52288, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:33517") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:44814->172.17.0.7:33517, err= 2025/11/27 01:16:03 INFO : a/b/c/d/e.txt: Deleted 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:42655") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:59100->172.17.0.7:42655, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:52503") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:38100->172.17.0.7:52503, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:47899") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:35948->172.17.0.7:47899, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: dial("tcp","172.17.0.7:21759") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé: > dial: conn=172.17.0.1:55280->172.17.0.7:21759, err= 2025/11/27 01:16:03 DEBUG : removing 1 level 4 directories 2025/11/27 01:16:03 INFO : a/b/c/d: Removing directory 2025/11/27 01:16:03 DEBUG : removing 1 level 3 directories 2025/11/27 01:16:03 INFO : a/b/c: Removing directory 2025/11/27 01:16:03 DEBUG : removing 1 level 2 directories 2025/11/27 01:16:03 INFO : a/b: Removing directory 2025/11/27 01:16:03 DEBUG : removing 1 level 1 directories 2025/11/27 01:16:03 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:16367") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:59432->172.17.0.7:16367, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:40158") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:49638->172.17.0.7:40158, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:18653") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:51820->172.17.0.7:18653, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:10152") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:53056->172.17.0.7:10152, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:26415") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:47762->172.17.0.7:26415, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:16178") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:40760->172.17.0.7:16178, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: Connecting to FTP server 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:21") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:12899") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:45370->172.17.0.7:21, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:41930->172.17.0.7:12899, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:34926") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:40016->172.17.0.7:34926, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:11052") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:60242->172.17.0.7:11052, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:4790") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:43740->172.17.0.7:4790, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:19148") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:56898->172.17.0.7:19148, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:43495") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:53440->172.17.0.7:43495, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:31780") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:57014->172.17.0.7:31780, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:16349") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:48146->172.17.0.7:16349, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:17654") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:55878->172.17.0.7:17654, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:25502") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:34466->172.17.0.7:25502, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:4846") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:56148->172.17.0.7:4846, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:6214") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:38406->172.17.0.7:6214, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:4151") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:10901") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:40818->172.17.0.7:4151, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:53244->172.17.0.7:10901, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:63162") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:50680->172.17.0.7:63162, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:13702") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:36476->172.17.0.7:13702, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:54861") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:57666->172.17.0.7:54861, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/11/27 01:16:03 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-tozofil9moto" 2025/11/27 01:16:03 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/27 01:16:03 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:03 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:03 DEBUG : TestFTPProftpd: detected overridden config - adding "{D0yZ3}" suffix to name 2025/11/27 01:16:03 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:03 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: Connecting to FTP server 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: dial("tcp","172.17.0.7:21") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: > dial: conn=172.17.0.1:45382->172.17.0.7:21, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:51466") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:33208->172.17.0.7:51466, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: dial("tcp","172.17.0.7:33287") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: > dial: conn=172.17.0.1:50490->172.17.0.7:33287, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: dial("tcp","172.17.0.7:20112") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: > dial: conn=172.17.0.1:46164->172.17.0.7:20112, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: dial("tcp","172.17.0.7:43213") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: > dial: conn=172.17.0.1:36646->172.17.0.7:43213, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: dial("tcp","172.17.0.7:13453") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: > dial: conn=172.17.0.1:43922->172.17.0.7:13453, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: dial("tcp","172.17.0.7:63393") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: > dial: conn=172.17.0.1:51904->172.17.0.7:63393, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: dial("tcp","172.17.0.7:1797") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: > dial: conn=172.17.0.1:42896->172.17.0.7:1797, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: dial("tcp","172.17.0.7:40606") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: > dial: conn=172.17.0.1:44674->172.17.0.7:40606, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:39198") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:38650->172.17.0.7:39198, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:60292") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:44986->172.17.0.7:60292, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:32817") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:34278->172.17.0.7:32817, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:37571") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:34874->172.17.0.7:37571, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:3197") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:34064->172.17.0.7:3197, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: dial("tcp","172.17.0.7:49157") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: > dial: conn=172.17.0.1:49344->172.17.0.7:49157, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: dial("tcp","172.17.0.7:12887") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: > dial: conn=172.17.0.1:33458->172.17.0.7:12887, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: dial("tcp","172.17.0.7:32352") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: > dial: conn=172.17.0.1:32976->172.17.0.7:32352, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: dial("tcp","172.17.0.7:46288") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: > dial: conn=172.17.0.1:52198->172.17.0.7:46288, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: Purge dir "new_name" 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-tozofil9moto: 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/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:50321") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:58702->172.17.0.7:50321, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:23191") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:59684->172.17.0.7:23191, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:8737") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:48594->172.17.0.7:8737, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:25589") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:58604->172.17.0.7:25589, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:43362") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:40916->172.17.0.7:43362, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:39019") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:34250->172.17.0.7:39019, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:16120") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:45266->172.17.0.7:16120, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:17340") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:52686->172.17.0.7:17340, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:49057") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:46624->172.17.0.7:49057, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/11/27 01:16:03 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-wuyofek3vupu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/11/27 01:16:03 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/27 01:16:03 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:03 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:03 DEBUG : TestFTPProftpd: detected overridden config - adding "{D0yZ3}" suffix to name 2025/11/27 01:16:03 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:03 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.7:21") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:45396->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.7:31364") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:44176->172.17.0.7:31364, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/11/27 01:16:03 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-wuyofek3vupu/not found.txt" 2025/11/27 01:16:03 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/27 01:16:03 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:03 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:03 DEBUG : TestFTPProftpd: detected overridden config - adding "{D0yZ3}" suffix to name 2025/11/27 01:16:03 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:03 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/not found.txt: Connecting to FTP server 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/not found.txt: dial("tcp","172.17.0.7:21") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/not found.txt: > dial: conn=172.17.0.1:45412->172.17.0.7:21, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/not found.txt: dial("tcp","172.17.0.7:40980") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/not found.txt: > dial: conn=172.17.0.1:55444->172.17.0.7:40980, err= 2025/11/27 01:16:03 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-wuyofek3vupu" from "TestFTPProftpd:rclone-test-wuyofek3vupu" 2025/11/27 01:16:03 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/11/27 01:16:03 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/27 01:16:03 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:03 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:03 DEBUG : TestFTPProftpd: detected overridden config - adding "{D0yZ3}" suffix to name 2025/11/27 01:16:03 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:03 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: Connecting to FTP server 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:21") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:45418->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:7379") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:45410->172.17.0.7:7379, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:27308") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:44040->172.17.0.7:27308, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:33415") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:48108->172.17.0.7:33415, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:45573") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:58698->172.17.0.7:45573, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:52129") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:36250->172.17.0.7:52129, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:6614") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:42106->172.17.0.7:6614, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:15179") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:38330->172.17.0.7:15179, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:32607") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:51452->172.17.0.7:32607, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:5254") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:56746->172.17.0.7:5254, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:10625") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:35926->172.17.0.7:10625, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:1721") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:60876->172.17.0.7:1721, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:17461") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:59256->172.17.0.7:17461, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:38263") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:53798->172.17.0.7:38263, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:64116") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:44474->172.17.0.7:64116, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:28995") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:34870->172.17.0.7:28995, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:9690") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:58690->172.17.0.7:9690, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:49029") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:42532->172.17.0.7:49029, 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/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:57217") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:53438->172.17.0.7:57217, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:3978") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:60988->172.17.0.7:3978, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:39530") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:53830->172.17.0.7:39530, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:8807") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:35970->172.17.0.7:8807, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:63459") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:60204->172.17.0.7:63459, 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/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:60364") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:44616->172.17.0.7:60364, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:8067") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:37672->172.17.0.7:8067, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/11/27 01:16:03 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-wuyofek3vupu" 2025/11/27 01:16:03 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/27 01:16:03 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:03 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:03 DEBUG : TestFTPProftpd: detected overridden config - adding "{kEuJM}" suffix to name 2025/11/27 01:16:03 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:03 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: Connecting to FTP server 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:21") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:45434->172.17.0.7:21, err= 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:17160") 2025/11/27 01:16:03 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:34816->172.17.0.7:17160, 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/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:63659") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:36412->172.17.0.7:63659, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:63487") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:47858->172.17.0.7:63487, err= 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:42178") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:41608->172.17.0.7:42178, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/11/27 01:16:04 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-wuyofek3vupu/deeper/nonexisting/directory" 2025/11/27 01:16:04 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/11/27 01:16:04 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:04 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{D0yZ3}" suffix to name 2025/11/27 01:16:04 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/11/27 01:16:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/11/27 01:16:04 DEBUG : Setting pass="XbgLFV1rHp-zA-vphjmMV6I7WgkRW2mME6wMAn_q5EPzsA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/11/27 01:16:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/deeper/nonexisting/directory: Connecting to FTP server 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/deeper/nonexisting/directory: dial("tcp","172.17.0.7:21") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:43450->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/27 01:16:04 DEBUG : Waiting for deletions to finish 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:18446") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:35074->172.17.0.7:18446, err= 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:43684") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:42802->172.17.0.7:43684, err= 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:58973") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:41664->172.17.0.7:58973, err= 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:54102") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:34712->172.17.0.7:54102, err= 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:41534") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:45200->172.17.0.7:41534, err= 2025/11/27 01:16:04 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:13223") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:57530->172.17.0.7:13223, err= 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:26529") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:50532->172.17.0.7:26529, err= 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:4135") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:57550->172.17.0.7:4135, err= 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:9806") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:43100->172.17.0.7:9806, err= 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:57747") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:33736->172.17.0.7:57747, err= 2025/11/27 01:16:04 DEBUG : removing 1 level 4 directories 2025/11/27 01:16:04 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/11/27 01:16:04 DEBUG : removing 1 level 3 directories 2025/11/27 01:16:04 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/11/27 01:16:04 DEBUG : removing 1 level 2 directories 2025/11/27 01:16:04 INFO : hello? sausage/êé: Removing directory 2025/11/27 01:16:04 DEBUG : removing 1 level 1 directories 2025/11/27 01:16:04 INFO : hello? sausage: Removing directory 2025/11/27 01:16:04 DEBUG : removing 1 level 0 directories 2025/11/27 01:16:04 INFO : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: Removing directory 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:58058") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:48252->172.17.0.7:58058, err= 2025/11/27 01:16:04 ERROR : error listing: directory not found 2025/11/27 01:16:04 DEBUG : Waiting for deletions to finish 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:16158") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:51032->172.17.0.7:16158, err= 2025/11/27 01:16:04 ERROR : error listing: directory not found 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: dial("tcp","172.17.0.7:56179") 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: > dial: conn=172.17.0.1:34420->172.17.0.7:56179, err= 2025/11/27 01:16:04 ERROR : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: Failed to list "": directory not found 2025/11/27 01:16:04 DEBUG : removing 1 level 0 directories 2025/11/27 01:16:04 INFO : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: Removing directory 2025/11/27 01:16:04 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/11/27 01:16:04 DEBUG : ftp://172.17.0.7:21/rclone-test-wuyofek3vupu: closing 2 unused connections 2025/11/27 01:16:04 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (3.81s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.00s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (2.52s) --- 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.16s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.25s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.02s) --- 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.10s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.75s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.75s) --- 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 3.825s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 4.612874286s (try 1/5)