"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/10/05 06:54:59 NOTICE: TestFTPProftpd: Starting server 2026/10/05 06:55:00 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.6:21" try 1/100 2026/10/05 06:55:00 DEBUG : TestFTPProftpd: Read 1, error: 2026/10/05 06:55:00 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.6:21" 2026/10/05 06:55:00 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pexaxan0quxu" 2026/10/05 06:55:00 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/10/05 06:55:00 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/05 06:55:00 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:00 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:00 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:00 DEBUG : TestFTPProftpd: detected overridden config - adding "{cBPqJ}" suffix to name 2026/10/05 06:55:00 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:00 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:00 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: Connecting to FTP server 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:21") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:51252->172.17.0.6:21, err= 2026/10/05 06:55:00 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/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:63216") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:36548->172.17.0.6:63216, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:15840") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:56882->172.17.0.6:15840, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/10/05 06:55:00 INFO : dir/subdir: Making directory 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:10210") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:56258->172.17.0.6:10210, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:10372") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:35412->172.17.0.6:10372, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:14831") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:40174->172.17.0.6:14831, err= 2026/10/05 06:55:00 INFO : dir/subdir: Removing directory 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:38619") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:53064->172.17.0.6:38619, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:42108") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:43694->172.17.0.6:42108, err= 2026/10/05 06:55:00 INFO : dir: Removing directory 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:55167") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34226->172.17.0.6:55167, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:53055") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:36566->172.17.0.6:53055, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:43654") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:42992->172.17.0.6:43654, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:20412") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:35872->172.17.0.6:20412, err= 2026/10/05 06:55:00 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/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:37086") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:57174->172.17.0.6:37086, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:734: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:30309") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:33410->172.17.0.6:30309, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:39733") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:33778->172.17.0.6:39733, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:63120") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:37086->172.17.0.6:63120, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:5173") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34402->172.17.0.6:5173, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:734: testing "．" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:16381") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:54604->172.17.0.6:16381, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:22038") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:49032->172.17.0.6:22038, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:23991") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:60968->172.17.0.6:23991, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:25890") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:54310->172.17.0.6:25890, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:734: testing "．．" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:32174") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:46124->172.17.0.6:32174, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:62505") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:51384->172.17.0.6:62505, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:50852") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:45728->172.17.0.6:50852, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:48458") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:33724->172.17.0.6:48458, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:734: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:5882") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:48866->172.17.0.6:5882, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:57443") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34404->172.17.0.6:57443, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:34127") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:59212->172.17.0.6:34127, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:16944") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:50220->172.17.0.6:16944, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:734: testing " leading space" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:2412") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:41710->172.17.0.6:2412, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:20475") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:56628->172.17.0.6:20475, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:10822") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:54774->172.17.0.6:10822, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:64605") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:43112->172.17.0.6:64605, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:734: testing "~leading tilde" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:35291") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:42612->172.17.0.6:35291, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:20008") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34988->172.17.0.6:20008, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:9442") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:55588->172.17.0.6:9442, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:49099") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:39482->172.17.0.6:49099, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:734: testing "␍leading CR" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:57604") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:57788->172.17.0.6:57604, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:50526") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:39306->172.17.0.6:50526, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:38732") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:35652->172.17.0.6:38732, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:45125") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:49514->172.17.0.6:45125, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:734: testing "␊leading LF" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:28646") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:52890->172.17.0.6:28646, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:58121") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:59724->172.17.0.6:58121, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:16676") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:41496->172.17.0.6:16676, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:57931") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:43174->172.17.0.6:57931, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:734: testing "␉leading HT" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:32319") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:35678->172.17.0.6:32319, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:14262") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:48924->172.17.0.6:14262, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:62081") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:54042->172.17.0.6:62081, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:47676") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:51018->172.17.0.6:47676, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:734: testing "␋leading VT" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:35276") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:42782->172.17.0.6:35276, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:20538") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:42408->172.17.0.6:20538, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:8032") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:45914->172.17.0.6:8032, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:1916") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:59346->172.17.0.6:1916, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:734: testing ".leading dot" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:17508") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:55312->172.17.0.6:17508, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:57860") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:53624->172.17.0.6:57860, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:49351") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:38642->172.17.0.6:49351, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:22367") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:46688->172.17.0.6:22367, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:734: testing "trailing space " 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:49768") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:55096->172.17.0.6:49768, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:17944") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:51772->172.17.0.6:17944, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:38287") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:40752->172.17.0.6:38287, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:51157") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:51964->172.17.0.6:51157, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:734: testing "trailing CR␍" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:37395") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:37222->172.17.0.6:37395, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:48086") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:60134->172.17.0.6:48086, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:50227") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:55852->172.17.0.6:50227, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:7151") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:45600->172.17.0.6:7151, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:734: testing "trailing LF␊" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:2559") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:47898->172.17.0.6:2559, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:58645") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:41894->172.17.0.6:58645, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:55227") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:43658->172.17.0.6:55227, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:59140") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:35062->172.17.0.6:59140, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:734: testing "trailing HT␉" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:43637") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:40710->172.17.0.6:43637, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:28424") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:53506->172.17.0.6:28424, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:38730") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:39906->172.17.0.6:38730, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:6748") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:56328->172.17.0.6:6748, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:734: testing "trailing VT␋" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:21010") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:33376->172.17.0.6:21010, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:54382") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:59150->172.17.0.6:54382, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:63656") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:45850->172.17.0.6:63656, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:52305") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:50106->172.17.0.6:52305, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:734: testing "trailing dot." 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:3110") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:60714->172.17.0.6:3110, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:60202") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:35096->172.17.0.6:60202, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:34447") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:55730->172.17.0.6:34447, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:37362") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34736->172.17.0.6:37362, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:734: testing "invalid utf-8\xfe" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:15205") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:38300->172.17.0.6:15205, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:41456") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:50892->172.17.0.6:41456, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:38255") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:55104->172.17.0.6:38255, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:31690") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:54076->172.17.0.6:31690, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:734: testing "test%46.txt" 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:33782") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:47868->172.17.0.6:33782, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:22071") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:52834->172.17.0.6:22071, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:53033") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:37534->172.17.0.6:53033, err= 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:18015") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34674->172.17.0.6:18015, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:38991") 2026/10/05 06:55:00 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:36936->172.17.0.6:38991, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: Connecting to FTP server 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:21") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34202->172.17.0.6:21, err= 2026/10/05 06:55:01 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:8643") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:52194->172.17.0.6:8643, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:44427") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:58706->172.17.0.6:44427, 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/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:55193") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34926->172.17.0.6:55193, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:64950") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:52968->172.17.0.6:64950, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:20690") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:35022->172.17.0.6:20690, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:55404") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:36644->172.17.0.6:55404, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:15959") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:42476->172.17.0.6:15959, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:32223") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:56402->172.17.0.6:32223, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:10931") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:37578->172.17.0.6:10931, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:21407") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:40580->172.17.0.6:21407, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:38605") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:42980->172.17.0.6:38605, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:60346") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:45474->172.17.0.6:60346, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:15270") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:46470->172.17.0.6:15270, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:16023") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34082->172.17.0.6:16023, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:34221") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:54452->172.17.0.6:34221, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:33201") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:53790->172.17.0.6:33201, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:28121") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:54056->172.17.0.6:28121, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:47825") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:40336->172.17.0.6:47825, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:9045") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:51618->172.17.0.6:9045, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/10/05 06:55:01 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/10/05 06:55:01 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/05 06:55:01 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:01 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:01 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:01 DEBUG : TestFTPProftpd: detected overridden config - adding "{cBPqJ}" suffix to name 2026/10/05 06:55:01 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:01 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:01 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21: Connecting to FTP server 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:21") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:34208->172.17.0.6:21, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:57833") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:41806->172.17.0.6:57833, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:37937") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:44990->172.17.0.6:37937, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:59296") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:45616->172.17.0.6:59296, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:7473") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:54476->172.17.0.6:7473, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:31433") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:51096->172.17.0.6:31433, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:19771") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:42666->172.17.0.6:19771, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:7318") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:47960->172.17.0.6:7318, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:10701") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:48778->172.17.0.6:10701, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:32933") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:52832->172.17.0.6:32933, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:48888") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:47274->172.17.0.6:48888, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1152: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:22721") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34280->172.17.0.6:22721, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:18107") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:60334->172.17.0.6:18107, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:15490") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:57556->172.17.0.6:15490, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:30341") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:46864->172.17.0.6:30341, err= 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:61510") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:37894->172.17.0.6:61510, 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/10/05 06:55:01 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pexaxan0quxu/hello? sausage/êé" 2026/10/05 06:55:01 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/05 06:55:01 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:01 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:01 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:01 DEBUG : TestFTPProftpd: detected overridden config - adding "{cBPqJ}" suffix to name 2026/10/05 06:55:01 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:01 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:01 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: Connecting to FTP server 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:21") 2026/10/05 06:55:01 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:34222->172.17.0.6:21, err= 2026/10/05 06:55:02 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-pexaxan0quxu/hello? sausage/êé" to be canonical "TestFTPProftpd{cBPqJ}:rclone-test-pexaxan0quxu/hello? sausage/êé" 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:43028") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:36788->172.17.0.6:43028, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:42505") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:56016->172.17.0.6:42505, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: Connecting to FTP server 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:21") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:34232->172.17.0.6:21, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:9352") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:37402->172.17.0.6:9352, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:36601") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:33008->172.17.0.6:36601, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:61478") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:39690->172.17.0.6:61478, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:14441") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:49468->172.17.0.6:14441, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:16049") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:52316->172.17.0.6:16049, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:4668") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:40104->172.17.0.6:4668, err= 2026/10/05 06:55:02 DEBUG : Waiting for deletions to finish 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:48390") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:59796->172.17.0.6:48390, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:58275") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:39660->172.17.0.6:58275, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:3248") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:46178->172.17.0.6:3248, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:10465") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:36486->172.17.0.6:10465, err= 2026/10/05 06:55:02 INFO : a/b/c/d/e.txt: Deleted 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:12073") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:46606->172.17.0.6:12073, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:3982") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:47354->172.17.0.6:3982, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:49967") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:45980->172.17.0.6:49967, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: dial("tcp","172.17.0.6:21772") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé: > dial: conn=172.17.0.1:56440->172.17.0.6:21772, err= 2026/10/05 06:55:02 DEBUG : removing 1 level 4 directories 2026/10/05 06:55:02 INFO : a/b/c/d: Removing directory 2026/10/05 06:55:02 DEBUG : removing 1 level 3 directories 2026/10/05 06:55:02 INFO : a/b/c: Removing directory 2026/10/05 06:55:02 DEBUG : removing 1 level 2 directories 2026/10/05 06:55:02 INFO : a/b: Removing directory 2026/10/05 06:55:02 DEBUG : removing 1 level 1 directories 2026/10/05 06:55:02 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1285: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:5149") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:38864->172.17.0.6:5149, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:29756") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:48490->172.17.0.6:29756, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:16665") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:47570->172.17.0.6:16665, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:59529") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:57194->172.17.0.6:59529, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:44691") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:46600->172.17.0.6:44691, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:47865") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:48970->172.17.0.6:47865, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:4926") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: Connecting to FTP server 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:21") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:51038->172.17.0.6:4926, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34246->172.17.0.6:21, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:58104") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:50996->172.17.0.6:58104, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:65075") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:41406->172.17.0.6:65075, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:64636") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:48570->172.17.0.6:64636, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:20936") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:45054->172.17.0.6:20936, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:2627") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:51240->172.17.0.6:2627, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:50155") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:64249") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:58744->172.17.0.6:50155, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:42362->172.17.0.6:64249, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:33724") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:43566->172.17.0.6:33724, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:8444") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:58100->172.17.0.6:8444, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:14810") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:52008->172.17.0.6:14810, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:46521") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:33080->172.17.0.6:46521, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:35935") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:18420") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:41734->172.17.0.6:18420, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:53008->172.17.0.6:35935, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:64597") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:36110->172.17.0.6:64597, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:32936") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:38024->172.17.0.6:32936, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:18168") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:59136->172.17.0.6:18168, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1437: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/10/05 06:55:02 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hozoyik1lowa" 2026/10/05 06:55:02 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/05 06:55:02 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:02 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:02 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:02 DEBUG : TestFTPProftpd: detected overridden config - adding "{cBPqJ}" suffix to name 2026/10/05 06:55:02 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:02 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:02 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: Connecting to FTP server 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: dial("tcp","172.17.0.6:21") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: > dial: conn=172.17.0.1:34248->172.17.0.6:21, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:46987") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:56190->172.17.0.6:46987, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: dial("tcp","172.17.0.6:14807") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: > dial: conn=172.17.0.1:56518->172.17.0.6:14807, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: dial("tcp","172.17.0.6:55063") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: > dial: conn=172.17.0.1:41982->172.17.0.6:55063, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: dial("tcp","172.17.0.6:49165") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: > dial: conn=172.17.0.1:43308->172.17.0.6:49165, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: dial("tcp","172.17.0.6:26955") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: > dial: conn=172.17.0.1:45358->172.17.0.6:26955, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: dial("tcp","172.17.0.6:15838") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: > dial: conn=172.17.0.1:47230->172.17.0.6:15838, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: dial("tcp","172.17.0.6:28766") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: > dial: conn=172.17.0.1:57358->172.17.0.6:28766, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: dial("tcp","172.17.0.6:8909") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: > dial: conn=172.17.0.1:58784->172.17.0.6:8909, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:21883") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:57508->172.17.0.6:21883, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:63033") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:42202->172.17.0.6:63033, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:11346") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:47046->172.17.0.6:11346, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:15227") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:39910->172.17.0.6:15227, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:8214") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:57936->172.17.0.6:8214, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: dial("tcp","172.17.0.6:47690") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: > dial: conn=172.17.0.1:42970->172.17.0.6:47690, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: dial("tcp","172.17.0.6:19217") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: > dial: conn=172.17.0.1:58836->172.17.0.6:19217, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: dial("tcp","172.17.0.6:26062") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: > dial: conn=172.17.0.1:52672->172.17.0.6:26062, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: dial("tcp","172.17.0.6:6612") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: > dial: conn=172.17.0.1:48626->172.17.0.6:6612, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: Purge dir "new_name" 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-hozoyik1lowa: 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/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:64478") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34084->172.17.0.6:64478, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:17881") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:38376->172.17.0.6:17881, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:19539") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:53778->172.17.0.6:19539, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:55009") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:36888->172.17.0.6:55009, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:43855") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:58368->172.17.0.6:43855, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:35435") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:47372->172.17.0.6:35435, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:8988") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:38190->172.17.0.6:8988, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:61458") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:33936->172.17.0.6:61458, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:1334") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:56222->172.17.0.6:1334, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:24313") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:50706->172.17.0.6:24313, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:27735") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:55258->172.17.0.6:27735, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:48025") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:44890->172.17.0.6:48025, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:3242") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:48192->172.17.0.6:3242, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:11011") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:58414->172.17.0.6:11011, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:59645") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:56936->172.17.0.6:59645, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:51107") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:50154->172.17.0.6:51107, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/10/05 06:55:02 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pexaxan0quxu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/10/05 06:55:02 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/05 06:55:02 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:02 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:02 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:02 DEBUG : TestFTPProftpd: detected overridden config - adding "{cBPqJ}" suffix to name 2026/10/05 06:55:02 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:02 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:02 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.6:21") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:34258->172.17.0.6:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.6:57015") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:49704->172.17.0.6:57015, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/10/05 06:55:02 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pexaxan0quxu/not found.txt" 2026/10/05 06:55:02 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/05 06:55:02 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:02 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:02 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:02 DEBUG : TestFTPProftpd: detected overridden config - adding "{cBPqJ}" suffix to name 2026/10/05 06:55:02 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:02 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:02 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/not found.txt: Connecting to FTP server 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/not found.txt: dial("tcp","172.17.0.6:21") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/not found.txt: > dial: conn=172.17.0.1:34262->172.17.0.6:21, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/not found.txt: dial("tcp","172.17.0.6:34845") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/not found.txt: > dial: conn=172.17.0.1:50194->172.17.0.6:34845, err= 2026/10/05 06:55:02 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1994: Opening root remote "TestFTPProftpd:" path "rclone-test-pexaxan0quxu" from "TestFTPProftpd:rclone-test-pexaxan0quxu" 2026/10/05 06:55:02 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/10/05 06:55:02 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/05 06:55:02 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:02 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:02 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:02 DEBUG : TestFTPProftpd: detected overridden config - adding "{cBPqJ}" suffix to name 2026/10/05 06:55:02 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:02 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:02 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: Connecting to FTP server 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:21") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:34274->172.17.0.6:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:23056") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:57576->172.17.0.6:23056, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:6641") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:37358->172.17.0.6:6641, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:43977") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:45204->172.17.0.6:43977, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:36202") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:34208->172.17.0.6:36202, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:50258") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:58894->172.17.0.6:50258, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:19679") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:59622->172.17.0.6:19679, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2031: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:3319") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:57608->172.17.0.6:3319, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:51742") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:43838->172.17.0.6:51742, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:63902") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:33770->172.17.0.6:63902, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:50743") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:47708->172.17.0.6:50743, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:33349") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:50350->172.17.0.6:33349, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:38995") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:39134->172.17.0.6:38995, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:31239") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:51082->172.17.0.6:31239, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:9692") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:36844->172.17.0.6:9692, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:23574") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:41642->172.17.0.6:23574, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:35728") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:50060->172.17.0.6:35728, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:54775") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:52536->172.17.0.6:54775, 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/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:6368") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:47086->172.17.0.6:6368, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:32709") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:49698->172.17.0.6:32709, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:58434") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:58886->172.17.0.6:58434, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:12217") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:39430->172.17.0.6:12217, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:1906") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:55360->172.17.0.6:1906, 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/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:3463") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34186->172.17.0.6:3463, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:1063") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:47310->172.17.0.6:1063, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/10/05 06:55:02 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-pexaxan0quxu" 2026/10/05 06:55:02 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/05 06:55:02 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:02 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:02 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:02 DEBUG : TestFTPProftpd: detected overridden config - adding "{mB4dp}" suffix to name 2026/10/05 06:55:02 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:02 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:02 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: Connecting to FTP server 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:21") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34278->172.17.0.6:21, err= 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:64947") 2026/10/05 06:55:02 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:34496->172.17.0.6:64947, 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/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:23618") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:36004->172.17.0.6:23618, err= fstests.go:2655: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:62026") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:50804->172.17.0.6:62026, 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/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:27464") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:40138->172.17.0.6:27464, 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/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:8193") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:59746->172.17.0.6:8193, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:5188") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:49214->172.17.0.6:5188, err= 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:25205") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:38648->172.17.0.6:25205, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/10/05 06:55:04 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pexaxan0quxu/deeper/nonexisting/directory" 2026/10/05 06:55:04 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/05 06:55:04 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:04 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:04 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{cBPqJ}" suffix to name 2026/10/05 06:55:04 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/05 06:55:04 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/05 06:55:04 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/05 06:55:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/deeper/nonexisting/directory: Connecting to FTP server 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/deeper/nonexisting/directory: dial("tcp","172.17.0.6:21") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:34290->172.17.0.6: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/10/05 06:55:04 DEBUG : Waiting for deletions to finish 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:26248") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:57990->172.17.0.6:26248, err= 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:47619") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:49262->172.17.0.6:47619, err= 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:23835") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:50768->172.17.0.6:23835, err= 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:13355") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:57710->172.17.0.6:13355, err= 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:63694") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:53596->172.17.0.6:63694, err= 2026/10/05 06:55:04 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:25414") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:49228->172.17.0.6:25414, err= 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:5405") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:36326->172.17.0.6:5405, err= 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:43611") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:43462->172.17.0.6:43611, err= 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:6166") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:35636->172.17.0.6:6166, err= 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:36602") 2026/10/05 06:55:04 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:46362->172.17.0.6:36602, err= 2026/10/05 06:55:04 DEBUG : removing 1 level 4 directories 2026/10/05 06:55:04 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/10/05 06:55:04 DEBUG : removing 1 level 3 directories 2026/10/05 06:55:04 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/10/05 06:55:04 DEBUG : removing 1 level 2 directories 2026/10/05 06:55:04 INFO : hello? sausage/êé: Removing directory 2026/10/05 06:55:04 DEBUG : removing 1 level 1 directories 2026/10/05 06:55:04 INFO : hello? sausage: Removing directory 2026/10/05 06:55:04 DEBUG : removing 1 level 0 directories 2026/10/05 06:55:04 INFO : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: Removing directory 2026/10/05 06:55:05 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:17983") 2026/10/05 06:55:05 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:33802->172.17.0.6:17983, err= 2026/10/05 06:55:05 ERROR : error listing: directory not found 2026/10/05 06:55:05 DEBUG : Waiting for deletions to finish 2026/10/05 06:55:05 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:3085") 2026/10/05 06:55:05 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:48442->172.17.0.6:3085, err= 2026/10/05 06:55:05 ERROR : error listing: directory not found 2026/10/05 06:55:05 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: dial("tcp","172.17.0.6:42712") 2026/10/05 06:55:05 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: > dial: conn=172.17.0.1:32874->172.17.0.6:42712, err= 2026/10/05 06:55:05 ERROR : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: Failed to list "": directory not found 2026/10/05 06:55:05 DEBUG : removing 1 level 0 directories 2026/10/05 06:55:05 INFO : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: Removing directory 2026/10/05 06:55:05 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/10/05 06:55:05 DEBUG : ftp://172.17.0.6:21/rclone-test-pexaxan0quxu: closing 2 unused connections 2026/10/05 06:55:05 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (5.78s) --- 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 (4.40s) --- 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.24s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.03s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.02s) --- 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 (2.99s) --- 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.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.10s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.06s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.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.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (2.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (2.29s) --- 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.02s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 5.825s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 7.551834956s (try 1/5)