"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestCommandEncodingNeutralisesCRLF --- PASS: TestCommandEncodingNeutralisesCRLF (0.00s) === RUN TestIntegration fstests.go:464: Using remote "TestFTPProftpd:" 2026/09/19 01:24:13 NOTICE: TestFTPProftpd: Starting server 2026/09/19 01:24:14 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.3:21" try 1/100 2026/09/19 01:24:14 DEBUG : TestFTPProftpd: Read 1, error: 2026/09/19 01:24:14 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.3:21" 2026/09/19 01:24:14 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-garonod4zopo" 2026/09/19 01:24:14 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/09/19 01:24:14 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/19 01:24:14 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:14 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:14 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{YtXpB}" suffix to name 2026/09/19 01:24:14 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:14 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:14 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: Connecting to FTP server 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:21") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:37764->172.17.0.3:21, err= 2026/09/19 01:24:14 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:505: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:533: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:44558") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:55060->172.17.0.3:44558, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:64523") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:38978->172.17.0.3:64523, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/09/19 01:24:14 INFO : dir/subdir: Making directory 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:50015") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:55480->172.17.0.3:50015, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:32114") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:46378->172.17.0.3:32114, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:65401") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:59724->172.17.0.3:65401, err= 2026/09/19 01:24:14 INFO : dir/subdir: Removing directory 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:9202") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:39016->172.17.0.3:9202, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:41863") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:47908->172.17.0.3:41863, err= 2026/09/19 01:24:14 INFO : dir: Removing directory 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:54748") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:60454->172.17.0.3:54748, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:27611") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:34126->172.17.0.3:27611, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:56597") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:45040->172.17.0.3:56597, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:40799") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:35482->172.17.0.3:40799, err= 2026/09/19 01:24:14 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:53022") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:37326->172.17.0.3:53022, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:734: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:57577") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:57778->172.17.0.3:57577, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:56763") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:42556->172.17.0.3:56763, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:33675") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:55876->172.17.0.3:33675, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:33169") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:38248->172.17.0.3:33169, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:734: testing "．" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:1713") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:33534->172.17.0.3:1713, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:14282") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:56536->172.17.0.3:14282, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:32158") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:47416->172.17.0.3:32158, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:6176") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:47374->172.17.0.3:6176, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:734: testing "．．" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:33785") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:38266->172.17.0.3:33785, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:55598") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:46552->172.17.0.3:55598, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:62614") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:52740->172.17.0.3:62614, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:34883") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:56932->172.17.0.3:34883, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:734: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:35270") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:52158->172.17.0.3:35270, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:3040") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:37800->172.17.0.3:3040, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:53706") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:53544->172.17.0.3:53706, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:50641") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:41240->172.17.0.3:50641, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:734: testing " leading space" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:17465") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:36118->172.17.0.3:17465, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:8164") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:33384->172.17.0.3:8164, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:25184") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:51210->172.17.0.3:25184, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:60999") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:57926->172.17.0.3:60999, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:734: testing "~leading tilde" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:7152") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:43782->172.17.0.3:7152, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:9664") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:53068->172.17.0.3:9664, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:27579") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:41454->172.17.0.3:27579, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:7018") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:46388->172.17.0.3:7018, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:734: testing "␍leading CR" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:17843") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:57854->172.17.0.3:17843, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:3907") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:58452->172.17.0.3:3907, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:60743") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:36974->172.17.0.3:60743, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:44431") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:45554->172.17.0.3:44431, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:734: testing "␊leading LF" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:59480") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:34226->172.17.0.3:59480, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:36007") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:45560->172.17.0.3:36007, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:31918") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:33584->172.17.0.3:31918, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:51523") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:35222->172.17.0.3:51523, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:734: testing "␉leading HT" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:27236") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:56078->172.17.0.3:27236, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:64569") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:54150->172.17.0.3:64569, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:19157") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:41896->172.17.0.3:19157, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:27925") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:59750->172.17.0.3:27925, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:734: testing "␋leading VT" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:13317") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:54420->172.17.0.3:13317, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:50291") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:48950->172.17.0.3:50291, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:33077") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:59394->172.17.0.3:33077, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:46078") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:38318->172.17.0.3:46078, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:734: testing ".leading dot" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:40355") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:50258->172.17.0.3:40355, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:30157") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:40448->172.17.0.3:30157, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:15427") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:54576->172.17.0.3:15427, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:10090") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:58454->172.17.0.3:10090, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:734: testing "trailing space " 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:32173") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:55244->172.17.0.3:32173, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:3598") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:34776->172.17.0.3:3598, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:59708") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:44298->172.17.0.3:59708, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:48614") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:44838->172.17.0.3:48614, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:734: testing "trailing CR␍" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:10739") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:41168->172.17.0.3:10739, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:19357") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:44056->172.17.0.3:19357, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:44079") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:60798->172.17.0.3:44079, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:16867") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:52140->172.17.0.3:16867, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:734: testing "trailing LF␊" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:27998") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:60598->172.17.0.3:27998, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:6123") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:43894->172.17.0.3:6123, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:22862") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:46026->172.17.0.3:22862, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:44817") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:35758->172.17.0.3:44817, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:734: testing "trailing HT␉" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:9007") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:35006->172.17.0.3:9007, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:18070") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:59000->172.17.0.3:18070, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:23714") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:51796->172.17.0.3:23714, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:2953") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:46192->172.17.0.3:2953, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:734: testing "trailing VT␋" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:53053") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:55636->172.17.0.3:53053, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:54608") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:43932->172.17.0.3:54608, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:53452") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:39890->172.17.0.3:53452, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:14755") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:36470->172.17.0.3:14755, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:734: testing "trailing dot." 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:53643") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:33362->172.17.0.3:53643, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:7074") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:55632->172.17.0.3:7074, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:41656") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:57364->172.17.0.3:41656, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:1425") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:44914->172.17.0.3:1425, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:734: testing "invalid utf-8\xfe" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:56342") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:39802->172.17.0.3:56342, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:9199") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:40250->172.17.0.3:9199, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:46479") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:60902->172.17.0.3:46479, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:31162") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:56458->172.17.0.3:31162, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:734: testing "test%46.txt" 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:38332") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:57048->172.17.0.3:38332, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:60883") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:45818->172.17.0.3:60883, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:40228") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:50630->172.17.0.3:40228, err= 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:4971") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:46552->172.17.0.3:4971, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:63458") 2026/09/19 01:24:14 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:44810->172.17.0.3:63458, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: Connecting to FTP server 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:21") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:37766->172.17.0.3:21, err= 2026/09/19 01:24:15 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:20902") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:49214->172.17.0.3:20902, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:42492") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:56224->172.17.0.3:42492, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:813: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:846: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:899: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:7865") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:47474->172.17.0.3:7865, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:63026") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:41874->172.17.0.3:63026, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:58636") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:44298->172.17.0.3:58636, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:58042") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:52440->172.17.0.3:58042, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:7782") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:53652->172.17.0.3:7782, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:44568") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:45656->172.17.0.3:44568, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:15794") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:39172->172.17.0.3:15794, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:11957") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:34914->172.17.0.3:11957, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:15973") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:35396->172.17.0.3:15973, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:14053") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:53308->172.17.0.3:14053, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:60763") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:39304->172.17.0.3:60763, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:8711") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:55644->172.17.0.3:8711, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:57391") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:48904->172.17.0.3:57391, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:49021") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:46966->172.17.0.3:49021, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:15592") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:34252->172.17.0.3:15592, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:14122") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:46540->172.17.0.3:14122, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:9458") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:42586->172.17.0.3:9458, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/09/19 01:24:15 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/09/19 01:24:15 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/19 01:24:15 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:15 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:15 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:15 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:15 DEBUG : TestFTPProftpd: detected overridden config - adding "{YtXpB}" suffix to name 2026/09/19 01:24:15 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:15 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:15 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:15 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:37776->172.17.0.3:21, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:5059") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:58952->172.17.0.3:5059, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:2856") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:48778->172.17.0.3:2856, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:39127") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:40740->172.17.0.3:39127, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:31641") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:48624->172.17.0.3:31641, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:37117") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:51492->172.17.0.3:37117, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:9873") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:46742->172.17.0.3:9873, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:3350") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:52792->172.17.0.3:3350, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:39121") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:55502->172.17.0.3:39121, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:46502") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:56286->172.17.0.3:46502, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:45492") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:43816->172.17.0.3:45492, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1152: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:12531") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:52326->172.17.0.3:12531, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:26071") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:37868->172.17.0.3:26071, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:29327") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:50276->172.17.0.3:29327, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:32410") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:34486->172.17.0.3:32410, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:3028") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:48008->172.17.0.3:3028, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1184: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1221: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/09/19 01:24:15 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-garonod4zopo/hello? sausage/êé" 2026/09/19 01:24:15 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/19 01:24:15 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:15 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:15 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:15 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:15 DEBUG : TestFTPProftpd: detected overridden config - adding "{YtXpB}" suffix to name 2026/09/19 01:24:15 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:15 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:15 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:15 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: Connecting to FTP server 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:37784->172.17.0.3:21, err= 2026/09/19 01:24:15 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-garonod4zopo/hello? sausage/êé" to be canonical "TestFTPProftpd{YtXpB}:rclone-test-garonod4zopo/hello? sausage/êé" 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:37405") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:44470->172.17.0.3:37405, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:47156") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:51870->172.17.0.3:47156, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: Connecting to FTP server 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:37796->172.17.0.3:21, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:20727") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:38780->172.17.0.3:20727, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:43449") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:58326->172.17.0.3:43449, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:18324") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:40014->172.17.0.3:18324, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:46489") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:49964->172.17.0.3:46489, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:23621") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:33868->172.17.0.3:23621, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:33423") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:38076->172.17.0.3:33423, err= 2026/09/19 01:24:15 DEBUG : Waiting for deletions to finish 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:45874") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:59904->172.17.0.3:45874, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:13423") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:46228->172.17.0.3:13423, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:59896") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:43492->172.17.0.3:59896, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:15880") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:36392->172.17.0.3:15880, err= 2026/09/19 01:24:15 INFO : a/b/c/d/e.txt: Deleted 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:55018") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:51376->172.17.0.3:55018, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:44211") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:35322->172.17.0.3:44211, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:44136") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:38574->172.17.0.3:44136, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: dial("tcp","172.17.0.3:41702") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé: > dial: conn=172.17.0.1:50268->172.17.0.3:41702, err= 2026/09/19 01:24:15 DEBUG : removing 1 level 4 directories 2026/09/19 01:24:15 INFO : a/b/c/d: Removing directory 2026/09/19 01:24:15 DEBUG : removing 1 level 3 directories 2026/09/19 01:24:15 INFO : a/b/c: Removing directory 2026/09/19 01:24:15 DEBUG : removing 1 level 2 directories 2026/09/19 01:24:15 INFO : a/b: Removing directory 2026/09/19 01:24:15 DEBUG : removing 1 level 1 directories 2026/09/19 01:24:15 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1285: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:36169") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:54082->172.17.0.3:36169, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:29901") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:44940->172.17.0.3:29901, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:60640") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:37954->172.17.0.3:60640, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:28677") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:56778->172.17.0.3:28677, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:36660") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:55562->172.17.0.3:36660, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:39674") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:58454->172.17.0.3:39674, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: Connecting to FTP server 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:21") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:37806->172.17.0.3:21, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:43447") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:50892->172.17.0.3:43447, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:43175") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:49722->172.17.0.3:43175, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:47594") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:47104->172.17.0.3:47594, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:14924") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:44860->172.17.0.3:14924, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:54623") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:53910->172.17.0.3:54623, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:1530") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:48944->172.17.0.3:1530, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:56476") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:55628->172.17.0.3:56476, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:4105") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:45374->172.17.0.3:4105, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:42822") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:58452->172.17.0.3:42822, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:14337") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:40330->172.17.0.3:14337, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:62311") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:37982->172.17.0.3:62311, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:38497") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:34758->172.17.0.3:38497, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:15996") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:48333") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:43124->172.17.0.3:48333, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:57038->172.17.0.3:15996, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:26308") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:55542->172.17.0.3:26308, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:35773") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:42468->172.17.0.3:35773, err= 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:12368") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:36048->172.17.0.3:12368, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1437: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/09/19 01:24:15 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-surawoc8cola" 2026/09/19 01:24:15 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/19 01:24:15 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:15 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:15 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:15 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:15 DEBUG : TestFTPProftpd: detected overridden config - adding "{YtXpB}" suffix to name 2026/09/19 01:24:15 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:15 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:15 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:15 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: Connecting to FTP server 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: dial("tcp","172.17.0.3:21") 2026/09/19 01:24:15 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: > dial: conn=172.17.0.1:37808->172.17.0.3:21, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:8742") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:60698->172.17.0.3:8742, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: dial("tcp","172.17.0.3:19839") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: > dial: conn=172.17.0.1:57776->172.17.0.3:19839, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: dial("tcp","172.17.0.3:60328") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: > dial: conn=172.17.0.1:55432->172.17.0.3:60328, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: dial("tcp","172.17.0.3:4137") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: > dial: conn=172.17.0.1:49292->172.17.0.3:4137, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: dial("tcp","172.17.0.3:37597") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: > dial: conn=172.17.0.1:60860->172.17.0.3:37597, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: dial("tcp","172.17.0.3:46957") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: > dial: conn=172.17.0.1:37288->172.17.0.3:46957, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: dial("tcp","172.17.0.3:28047") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: > dial: conn=172.17.0.1:51084->172.17.0.3:28047, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: dial("tcp","172.17.0.3:37276") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: > dial: conn=172.17.0.1:54914->172.17.0.3:37276, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:61431") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:35850->172.17.0.3:61431, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:6179") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:38636->172.17.0.3:6179, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:34743") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:41618->172.17.0.3:34743, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:15727") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:47412->172.17.0.3:15727, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:14201") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:45518->172.17.0.3:14201, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: dial("tcp","172.17.0.3:11674") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: > dial: conn=172.17.0.1:53550->172.17.0.3:11674, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: dial("tcp","172.17.0.3:65053") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: > dial: conn=172.17.0.1:39678->172.17.0.3:65053, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: dial("tcp","172.17.0.3:3467") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: > dial: conn=172.17.0.1:55448->172.17.0.3:3467, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: dial("tcp","172.17.0.3:57470") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: > dial: conn=172.17.0.1:53382->172.17.0.3:57470, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: Purge dir "new_name" 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-surawoc8cola: 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:1633: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1664: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1735: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:35024") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:32994->172.17.0.3:35024, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:65361") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:48838->172.17.0.3:65361, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:50294") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:57460->172.17.0.3:50294, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:14207") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:60388->172.17.0.3:14207, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:43874") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:39150->172.17.0.3:43874, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:58926") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:46344->172.17.0.3:58926, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:23025") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:44498->172.17.0.3:23025, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:45201") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:45780->172.17.0.3:45201, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:51733") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:53772->172.17.0.3:51733, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:3176") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:54504->172.17.0.3:3176, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:51363") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:56190->172.17.0.3:51363, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:23881") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:34552->172.17.0.3:23881, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:45465") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:57634->172.17.0.3:45465, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:16310") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:53460->172.17.0.3:16310, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:26944") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:49280->172.17.0.3:26944, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:4984") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:53952->172.17.0.3:4984, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/09/19 01:24:16 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-garonod4zopo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/09/19 01:24:16 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/19 01:24:16 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:16 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:16 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:16 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:16 DEBUG : TestFTPProftpd: detected overridden config - adding "{YtXpB}" suffix to name 2026/09/19 01:24:16 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:16 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:16 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:16 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:21") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:37816->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:44005") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:60492->172.17.0.3:44005, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/09/19 01:24:16 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-garonod4zopo/not found.txt" 2026/09/19 01:24:16 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/19 01:24:16 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:16 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:16 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:16 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:16 DEBUG : TestFTPProftpd: detected overridden config - adding "{YtXpB}" suffix to name 2026/09/19 01:24:16 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:16 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:16 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:16 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/not found.txt: Connecting to FTP server 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/not found.txt: dial("tcp","172.17.0.3:21") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/not found.txt: > dial: conn=172.17.0.1:37820->172.17.0.3:21, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/not found.txt: dial("tcp","172.17.0.3:39950") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/not found.txt: > dial: conn=172.17.0.1:59752->172.17.0.3:39950, err= 2026/09/19 01:24:16 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1994: Opening root remote "TestFTPProftpd:" path "rclone-test-garonod4zopo" from "TestFTPProftpd:rclone-test-garonod4zopo" 2026/09/19 01:24:16 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/09/19 01:24:16 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/19 01:24:16 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:16 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:16 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:16 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:16 DEBUG : TestFTPProftpd: detected overridden config - adding "{YtXpB}" suffix to name 2026/09/19 01:24:16 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:16 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:16 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:16 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:37824->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:1306") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:55164->172.17.0.3:1306, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:38652") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:53138->172.17.0.3:38652, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:39264") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:49374->172.17.0.3:39264, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:49099") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:55634->172.17.0.3:49099, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:41408") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:34752->172.17.0.3:41408, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:54808") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:58280->172.17.0.3:54808, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2031: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:15919") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:52164->172.17.0.3:15919, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:57682") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:42436->172.17.0.3:57682, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:45293") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:45956->172.17.0.3:45293, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:8306") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:33450->172.17.0.3:8306, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:43980") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:44462->172.17.0.3:43980, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:10491") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:40526->172.17.0.3:10491, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:41466") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:59004->172.17.0.3:41466, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:61125") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:36414->172.17.0.3:61125, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:40746") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:46786->172.17.0.3:40746, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:12103") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:46388->172.17.0.3:12103, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:47551") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:53838->172.17.0.3:47551, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2090: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:438: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2195: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2211: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:24841") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:36900->172.17.0.3:24841, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:55183") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:38214->172.17.0.3:55183, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:47644") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:32826->172.17.0.3:47644, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:3383") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:52788->172.17.0.3:3383, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:35388") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:56630->172.17.0.3:35388, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2367: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:49888") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:52230->172.17.0.3:49888, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:49071") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:43616->172.17.0.3:49071, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/09/19 01:24:16 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-garonod4zopo" 2026/09/19 01:24:16 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/19 01:24:16 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:16 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:16 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:16 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:16 DEBUG : TestFTPProftpd: detected overridden config - adding "{N8roY}" suffix to name 2026/09/19 01:24:16 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:16 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:16 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:16 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: Connecting to FTP server 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:21") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:37828->172.17.0.3:21, err= 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:62626") 2026/09/19 01:24:16 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:52098->172.17.0.3:62626, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2452: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutRetry === RUN TestIntegration/FsMkdir/FsPutRetry/Simple === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:11437") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:36228->172.17.0.3:11437, err= fstests.go:2655: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:3015") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:56218->172.17.0.3:3015, err= fstests.go:2655: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Chunked fstests.go:2697: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:2264") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:52694->172.17.0.3:2264, err= === RUN TestIntegration/FsMkdir/FsPutShortEOF/Chunked fstests.go:2828: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2870: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:46446") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:36390->172.17.0.3:46446, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:43569") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:34036->172.17.0.3:43569, err= 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:51893") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:43064->172.17.0.3:51893, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/09/19 01:24:17 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-garonod4zopo/deeper/nonexisting/directory" 2026/09/19 01:24:17 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/09/19 01:24:17 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:17 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:17 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:17 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:17 DEBUG : TestFTPProftpd: detected overridden config - adding "{YtXpB}" suffix to name 2026/09/19 01:24:17 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/09/19 01:24:17 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/09/19 01:24:17 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/09/19 01:24:17 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/deeper/nonexisting/directory: Connecting to FTP server 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/deeper/nonexisting/directory: dial("tcp","172.17.0.3:21") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo/deeper/nonexisting/directory: > dial: conn=172.17.0.1:37844->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:3019: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:3062: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:3119: FS has no Directory methods and doesn't Wrap 2026/09/19 01:24:17 DEBUG : Waiting for deletions to finish 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:3462") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:51650->172.17.0.3:3462, err= 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:46582") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:60986->172.17.0.3:46582, err= 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:64343") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:56000->172.17.0.3:64343, err= 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:31142") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:41758->172.17.0.3:31142, err= 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:59055") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:56732->172.17.0.3:59055, err= 2026/09/19 01:24:17 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:46999") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:53758->172.17.0.3:46999, err= 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:42315") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:36720->172.17.0.3:42315, err= 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:9724") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:39022->172.17.0.3:9724, err= 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:41983") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:48442->172.17.0.3:41983, err= 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:2267") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:41398->172.17.0.3:2267, err= 2026/09/19 01:24:17 DEBUG : removing 1 level 4 directories 2026/09/19 01:24:17 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/09/19 01:24:17 DEBUG : removing 1 level 3 directories 2026/09/19 01:24:17 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/09/19 01:24:17 DEBUG : removing 1 level 2 directories 2026/09/19 01:24:17 INFO : hello? sausage/êé: Removing directory 2026/09/19 01:24:17 DEBUG : removing 1 level 1 directories 2026/09/19 01:24:17 INFO : hello? sausage: Removing directory 2026/09/19 01:24:17 DEBUG : removing 1 level 0 directories 2026/09/19 01:24:17 INFO : ftp://172.17.0.3:21/rclone-test-garonod4zopo: Removing directory 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:21138") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:34164->172.17.0.3:21138, err= 2026/09/19 01:24:17 ERROR : error listing: directory not found 2026/09/19 01:24:17 DEBUG : Waiting for deletions to finish 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:8445") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:53082->172.17.0.3:8445, err= 2026/09/19 01:24:17 ERROR : error listing: directory not found 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: dial("tcp","172.17.0.3:52148") 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: > dial: conn=172.17.0.1:36480->172.17.0.3:52148, err= 2026/09/19 01:24:17 ERROR : ftp://172.17.0.3:21/rclone-test-garonod4zopo: Failed to list "": directory not found 2026/09/19 01:24:17 DEBUG : removing 1 level 0 directories 2026/09/19 01:24:17 INFO : ftp://172.17.0.3:21/rclone-test-garonod4zopo: Removing directory 2026/09/19 01:24:17 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/09/19 01:24:17 DEBUG : ftp://172.17.0.3:21/rclone-test-garonod4zopo: closing 2 unused connections 2026/09/19 01:24:17 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (4.20s) --- 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.89s) --- 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.26s) --- 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.02s) --- 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.50s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.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.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (0.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.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.01s) --- 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.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.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.89s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutRetry (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/NetError (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Chunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Simple (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutShortEOF/Chunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 4.227s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 5.294872001s (try 1/5)