"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestCommandEncodingNeutralisesCRLF --- PASS: TestCommandEncodingNeutralisesCRLF (0.00s) === RUN TestIntegration fstests.go:457: Using remote "TestFTPProftpd:" 2026/08/27 05:02:20 NOTICE: TestFTPProftpd: Starting server 2026/08/27 05:02:21 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.5:21" try 1/100 2026/08/27 05:02:21 DEBUG : TestFTPProftpd: Read 1, error: 2026/08/27 05:02:21 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.5:21" 2026/08/27 05:02:21 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-juquvit5xaca" 2026/08/27 05:02:21 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/27 05:02:21 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/27 05:02:21 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:21 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:21 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:21 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:21 DEBUG : TestFTPProftpd: detected overridden config - adding "{Apwg_}" suffix to name 2026/08/27 05:02:21 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:21 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:21 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:21 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: Connecting to FTP server 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:21") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:36202->172.17.0.5:21, err= 2026/08/27 05:02:21 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:498: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:526: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:57172") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:43276->172.17.0.5:57172, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:58066") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:39000->172.17.0.5:58066, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/08/27 05:02:21 INFO : dir/subdir: Making directory 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:15283") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:46756->172.17.0.5:15283, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:33874") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:48836->172.17.0.5:33874, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:52186") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:47234->172.17.0.5:52186, err= 2026/08/27 05:02:21 INFO : dir/subdir: Removing directory 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:63017") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:57074->172.17.0.5:63017, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:9880") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:43408->172.17.0.5:9880, err= 2026/08/27 05:02:21 INFO : dir: Removing directory 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:36397") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:36172->172.17.0.5:36397, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:22142") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:53054->172.17.0.5:22142, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:9760") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:34154->172.17.0.5:9760, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:53331") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:57928->172.17.0.5:53331, err= 2026/08/27 05:02:21 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:1802") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:51040->172.17.0.5:1802, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:727: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:21298") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:58530->172.17.0.5:21298, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:10371") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:40690->172.17.0.5:10371, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:5460") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:48420->172.17.0.5:5460, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:36787") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:37466->172.17.0.5:36787, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:727: testing "．" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:35915") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:38124->172.17.0.5:35915, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:30852") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:51666->172.17.0.5:30852, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:47551") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:39794->172.17.0.5:47551, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:26471") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:38418->172.17.0.5:26471, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:727: testing "．．" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:14542") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:50242->172.17.0.5:14542, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:9376") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:49148->172.17.0.5:9376, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:3427") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:58380->172.17.0.5:3427, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:49359") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:43236->172.17.0.5:49359, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:727: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:40762") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:42462->172.17.0.5:40762, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:22861") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:38014->172.17.0.5:22861, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:36324") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:48836->172.17.0.5:36324, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:8653") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:34396->172.17.0.5:8653, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:727: testing " leading space" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:15976") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:38362->172.17.0.5:15976, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:18610") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:57402->172.17.0.5:18610, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:9645") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:55110->172.17.0.5:9645, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:7614") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:42906->172.17.0.5:7614, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:727: testing "~leading tilde" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:11142") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:47930->172.17.0.5:11142, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:23904") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:52790->172.17.0.5:23904, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:40465") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:40530->172.17.0.5:40465, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:62304") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:48190->172.17.0.5:62304, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:727: testing "␍leading CR" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:21387") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:41856->172.17.0.5:21387, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:49321") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:43000->172.17.0.5:49321, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:33167") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:53366->172.17.0.5:33167, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:42505") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:58964->172.17.0.5:42505, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:727: testing "␊leading LF" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:58058") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:35766->172.17.0.5:58058, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:20964") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:49376->172.17.0.5:20964, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:43283") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:47824->172.17.0.5:43283, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:13822") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:49724->172.17.0.5:13822, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:727: testing "␉leading HT" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:30311") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:35138->172.17.0.5:30311, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:47720") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:37942->172.17.0.5:47720, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:49585") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:44538->172.17.0.5:49585, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:65203") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:43136->172.17.0.5:65203, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:727: testing "␋leading VT" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:13038") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:49280->172.17.0.5:13038, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:31602") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:39080->172.17.0.5:31602, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:26139") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:49870->172.17.0.5:26139, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:26556") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:51950->172.17.0.5:26556, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:727: testing ".leading dot" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:39954") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:37194->172.17.0.5:39954, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:28543") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:53032->172.17.0.5:28543, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:10381") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:60566->172.17.0.5:10381, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:15182") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:49800->172.17.0.5:15182, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:727: testing "trailing space " 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:50380") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:51214->172.17.0.5:50380, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:45681") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:48534->172.17.0.5:45681, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:22811") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:54354->172.17.0.5:22811, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:65333") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:50904->172.17.0.5:65333, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:727: testing "trailing CR␍" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:63268") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:39780->172.17.0.5:63268, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:31432") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:41168->172.17.0.5:31432, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:7412") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:38336->172.17.0.5:7412, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:8875") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:37118->172.17.0.5:8875, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:727: testing "trailing LF␊" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:54313") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:58558->172.17.0.5:54313, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:46854") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:49286->172.17.0.5:46854, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:5644") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:42430->172.17.0.5:5644, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:10165") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:42684->172.17.0.5:10165, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:727: testing "trailing HT␉" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:30640") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:38538->172.17.0.5:30640, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:37787") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:58546->172.17.0.5:37787, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:51647") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:51706->172.17.0.5:51647, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:23163") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:35032->172.17.0.5:23163, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:727: testing "trailing VT␋" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:57727") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:33596->172.17.0.5:57727, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:29395") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:58276->172.17.0.5:29395, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:35961") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:37702->172.17.0.5:35961, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:22504") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:41296->172.17.0.5:22504, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:727: testing "trailing dot." 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:11581") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:43260->172.17.0.5:11581, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:20012") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:37666->172.17.0.5:20012, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:22173") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:38126->172.17.0.5:22173, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:23595") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:48686->172.17.0.5:23595, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:727: testing "invalid utf-8\xfe" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:50590") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:39892->172.17.0.5:50590, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:47288") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:48152->172.17.0.5:47288, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:49128") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:59992->172.17.0.5:49128, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:25010") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:45396->172.17.0.5:25010, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:727: testing "test%46.txt" 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:10297") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:38622->172.17.0.5:10297, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:58485") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:56482->172.17.0.5:58485, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:39168") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:44478->172.17.0.5:39168, err= 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:59654") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:51604->172.17.0.5:59654, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:38632") 2026/08/27 05:02:21 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:44318->172.17.0.5:38632, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: Connecting to FTP server 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:21") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:39666->172.17.0.5:21, err= 2026/08/27 05:02:22 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:43847") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:39248->172.17.0.5:43847, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:14392") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:46770->172.17.0.5:14392, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:806: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:839: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:892: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:30375") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:38358->172.17.0.5:30375, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:31473") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:59362->172.17.0.5:31473, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:39253") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:35114->172.17.0.5:39253, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:21333") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:34246->172.17.0.5:21333, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:49995") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:58170->172.17.0.5:49995, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:62392") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:44914->172.17.0.5:62392, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:29562") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:39846->172.17.0.5:29562, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:17800") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:60778->172.17.0.5:17800, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:61745") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:33388->172.17.0.5:61745, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:11921") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:49664->172.17.0.5:11921, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:63417") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:44412->172.17.0.5:63417, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:33403") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:51992->172.17.0.5:33403, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:42278") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:40958->172.17.0.5:42278, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:53775") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:41848->172.17.0.5:53775, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:43470") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:59616->172.17.0.5:43470, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:58612") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:53834->172.17.0.5:58612, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:41368") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:54836->172.17.0.5:41368, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/08/27 05:02:22 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/08/27 05:02:22 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/27 05:02:22 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:22 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:22 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:22 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:22 DEBUG : TestFTPProftpd: detected overridden config - adding "{Apwg_}" suffix to name 2026/08/27 05:02:22 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:22 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:22 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:22 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: Connecting to FTP server 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:21") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:39676->172.17.0.5:21, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:11203") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:49190->172.17.0.5:11203, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:20761") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:59772->172.17.0.5:20761, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:13076") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:52546->172.17.0.5:13076, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:2826") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:44992->172.17.0.5:2826, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:38421") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:50240->172.17.0.5:38421, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:36876") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:37218->172.17.0.5:36876, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:59126") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:57692->172.17.0.5:59126, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:45498") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:33196->172.17.0.5:45498, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:56514") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:41822->172.17.0.5:56514, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:10094") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:59484->172.17.0.5:10094, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1145: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:50301") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:37090->172.17.0.5:50301, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:31075") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:36120->172.17.0.5:31075, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:37710") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:48910->172.17.0.5:37710, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:28613") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:37722->172.17.0.5:28613, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:44444") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:41984->172.17.0.5:44444, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1177: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1214: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/08/27 05:02:22 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-juquvit5xaca/hello? sausage/êé" 2026/08/27 05:02:22 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/27 05:02:22 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:22 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:22 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:22 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:22 DEBUG : TestFTPProftpd: detected overridden config - adding "{Apwg_}" suffix to name 2026/08/27 05:02:22 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:22 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:22 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:22 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: Connecting to FTP server 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:21") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:39692->172.17.0.5:21, err= 2026/08/27 05:02:22 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-juquvit5xaca/hello? sausage/êé" to be canonical "TestFTPProftpd{Apwg_}:rclone-test-juquvit5xaca/hello? sausage/êé" 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:56543") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:57288->172.17.0.5:56543, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:65283") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:45170->172.17.0.5:65283, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: Connecting to FTP server 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:21") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:3873") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:57512->172.17.0.5:3873, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:39696->172.17.0.5:21, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:26035") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:57202->172.17.0.5:26035, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:6346") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:46834->172.17.0.5:6346, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:7004") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:55064->172.17.0.5:7004, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:31896") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:58318->172.17.0.5:31896, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:2512") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:44106->172.17.0.5:2512, err= 2026/08/27 05:02:22 DEBUG : Waiting for deletions to finish 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:35673") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:42006->172.17.0.5:35673, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:43275") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:45730->172.17.0.5:43275, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:51341") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:52988->172.17.0.5:51341, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:46067") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:59632->172.17.0.5:46067, err= 2026/08/27 05:02:22 INFO : a/b/c/d/e.txt: Deleted 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:10381") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:56842->172.17.0.5:10381, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:32100") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:45966->172.17.0.5:32100, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:17909") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:52362->172.17.0.5:17909, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: dial("tcp","172.17.0.5:25734") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé: > dial: conn=172.17.0.1:36764->172.17.0.5:25734, err= 2026/08/27 05:02:22 DEBUG : removing 1 level 4 directories 2026/08/27 05:02:22 INFO : a/b/c/d: Removing directory 2026/08/27 05:02:22 DEBUG : removing 1 level 3 directories 2026/08/27 05:02:22 INFO : a/b/c: Removing directory 2026/08/27 05:02:22 DEBUG : removing 1 level 2 directories 2026/08/27 05:02:22 INFO : a/b: Removing directory 2026/08/27 05:02:22 DEBUG : removing 1 level 1 directories 2026/08/27 05:02:22 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1278: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:2551") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:40686->172.17.0.5:2551, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:59063") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:38650->172.17.0.5:59063, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:18162") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:43302->172.17.0.5:18162, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:22860") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:42722->172.17.0.5:22860, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:43524") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:53712->172.17.0.5:43524, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:15020") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:39858->172.17.0.5:15020, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: Connecting to FTP server 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:21") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:39698->172.17.0.5:21, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:51399") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:33694->172.17.0.5:51399, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:51392") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:40412->172.17.0.5:51392, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:60300") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:55506->172.17.0.5:60300, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:41447") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:56824->172.17.0.5:41447, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:11230") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:43994->172.17.0.5:11230, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:20359") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:57662->172.17.0.5:20359, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:62296") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:5389") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:47994->172.17.0.5:62296, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:46266->172.17.0.5:5389, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:58183") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:47584->172.17.0.5:58183, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:24408") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:54484->172.17.0.5:24408, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:43610") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:60512->172.17.0.5:43610, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:51493") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:42136->172.17.0.5:51493, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:39039") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:56070") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:53248->172.17.0.5:56070, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:55876->172.17.0.5:39039, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:61953") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:36636->172.17.0.5:61953, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:46423") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:39390->172.17.0.5:46423, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:13761") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:53632->172.17.0.5:13761, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1430: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/08/27 05:02:22 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-dafadoj6xame" 2026/08/27 05:02:22 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/27 05:02:22 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:22 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:22 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:22 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:22 DEBUG : TestFTPProftpd: detected overridden config - adding "{Apwg_}" suffix to name 2026/08/27 05:02:22 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:22 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:22 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:22 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: Connecting to FTP server 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: dial("tcp","172.17.0.5:21") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: > dial: conn=172.17.0.1:39704->172.17.0.5:21, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:21545") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:49964->172.17.0.5:21545, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: dial("tcp","172.17.0.5:4287") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: > dial: conn=172.17.0.1:51900->172.17.0.5:4287, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: dial("tcp","172.17.0.5:18167") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: > dial: conn=172.17.0.1:50154->172.17.0.5:18167, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: dial("tcp","172.17.0.5:41276") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: > dial: conn=172.17.0.1:37130->172.17.0.5:41276, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: dial("tcp","172.17.0.5:45847") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: > dial: conn=172.17.0.1:44114->172.17.0.5:45847, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: dial("tcp","172.17.0.5:41864") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: > dial: conn=172.17.0.1:60514->172.17.0.5:41864, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: dial("tcp","172.17.0.5:3396") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: > dial: conn=172.17.0.1:38866->172.17.0.5:3396, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: dial("tcp","172.17.0.5:37288") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: > dial: conn=172.17.0.1:51742->172.17.0.5:37288, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:21589") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:47510->172.17.0.5:21589, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:32116") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:50826->172.17.0.5:32116, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:12890") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:46662->172.17.0.5:12890, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:22257") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:42018->172.17.0.5:22257, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:15644") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:37762->172.17.0.5:15644, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: dial("tcp","172.17.0.5:11712") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: > dial: conn=172.17.0.1:49980->172.17.0.5:11712, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: dial("tcp","172.17.0.5:18696") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: > dial: conn=172.17.0.1:53058->172.17.0.5:18696, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: dial("tcp","172.17.0.5:48389") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: > dial: conn=172.17.0.1:52402->172.17.0.5:48389, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: dial("tcp","172.17.0.5:19550") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: > dial: conn=172.17.0.1:52584->172.17.0.5:19550, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: Purge dir "new_name" 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-dafadoj6xame: 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:1626: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1657: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1728: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:49168") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:33218->172.17.0.5:49168, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:38378") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:40484->172.17.0.5:38378, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:22166") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:57210->172.17.0.5:22166, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:41282") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:57734->172.17.0.5:41282, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:39852") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:54442->172.17.0.5:39852, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:44169") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:45216->172.17.0.5:44169, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:24060") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:50990->172.17.0.5:24060, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:14169") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:53840->172.17.0.5:14169, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:15511") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:41658->172.17.0.5:15511, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:42854") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:37228->172.17.0.5:42854, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:17651") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:55228->172.17.0.5:17651, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:26035") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:57212->172.17.0.5:26035, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:58644") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:51722->172.17.0.5:58644, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:6490") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:32924->172.17.0.5:6490, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:26721") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:55712->172.17.0.5:26721, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:43410") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:49744->172.17.0.5:43410, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/08/27 05:02:22 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-juquvit5xaca/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/08/27 05:02:22 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/27 05:02:22 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:22 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:22 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:22 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:22 DEBUG : TestFTPProftpd: detected overridden config - adding "{Apwg_}" suffix to name 2026/08/27 05:02:22 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:22 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:22 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:22 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.5:21") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:39706->172.17.0.5:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.5:37853") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:36258->172.17.0.5:37853, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/08/27 05:02:22 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-juquvit5xaca/not found.txt" 2026/08/27 05:02:22 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/27 05:02:22 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:22 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:22 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:22 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:22 DEBUG : TestFTPProftpd: detected overridden config - adding "{Apwg_}" suffix to name 2026/08/27 05:02:22 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:22 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:22 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:22 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/not found.txt: Connecting to FTP server 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/not found.txt: dial("tcp","172.17.0.5:21") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/not found.txt: > dial: conn=172.17.0.1:39716->172.17.0.5:21, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/not found.txt: dial("tcp","172.17.0.5:30031") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/not found.txt: > dial: conn=172.17.0.1:39562->172.17.0.5:30031, err= 2026/08/27 05:02:22 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1987: Opening root remote "TestFTPProftpd:" path "rclone-test-juquvit5xaca" from "TestFTPProftpd:rclone-test-juquvit5xaca" 2026/08/27 05:02:22 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/08/27 05:02:22 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/27 05:02:22 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:22 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:22 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:22 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:22 DEBUG : TestFTPProftpd: detected overridden config - adding "{Apwg_}" suffix to name 2026/08/27 05:02:22 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:22 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:22 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:22 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: Connecting to FTP server 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:21") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:39732->172.17.0.5:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:23772") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:52026->172.17.0.5:23772, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:20355") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:35624->172.17.0.5:20355, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:9135") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:37620->172.17.0.5:9135, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:3635") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:46202->172.17.0.5:3635, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:59843") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:47040->172.17.0.5:59843, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:52883") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:47582->172.17.0.5:52883, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2024: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:49558") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:57868->172.17.0.5:49558, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:62202") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:56930->172.17.0.5:62202, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:41877") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:45106->172.17.0.5:41877, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:13447") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:51060->172.17.0.5:13447, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:13979") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:45494->172.17.0.5:13979, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:32295") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:33446->172.17.0.5:32295, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:32376") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:37804->172.17.0.5:32376, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:34598") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:40526->172.17.0.5:34598, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:22747") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:41282->172.17.0.5:22747, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:3606") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:45108->172.17.0.5:3606, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:59465") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:60762->172.17.0.5:59465, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2083: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:431: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2188: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2204: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:56430") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:50696->172.17.0.5:56430, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:36542") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:40844->172.17.0.5:36542, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:30637") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:55374->172.17.0.5:30637, err= 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:63407") 2026/08/27 05:02:22 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:59288->172.17.0.5:63407, err= 2026/08/27 05:02:23 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:19357") 2026/08/27 05:02:23 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:55812->172.17.0.5:19357, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2360: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/08/27 05:02:23 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:14970") 2026/08/27 05:02:23 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:46438->172.17.0.5:14970, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/08/27 05:02:23 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:6488") 2026/08/27 05:02:23 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:46702->172.17.0.5:6488, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/08/27 05:02:23 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-juquvit5xaca" 2026/08/27 05:02:23 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/27 05:02:23 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:23 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:23 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:23 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:23 DEBUG : TestFTPProftpd: detected overridden config - adding "{g4lr9}" suffix to name 2026/08/27 05:02:23 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:23 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:23 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:23 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:23 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: Connecting to FTP server 2026/08/27 05:02:23 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:21") 2026/08/27 05:02:23 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:39742->172.17.0.5:21, err= 2026/08/27 05:02:23 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:54460") 2026/08/27 05:02:23 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:42454->172.17.0.5:54460, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2445: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:42808") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:55506->172.17.0.5:42808, err= === RUN TestIntegration/FsMkdir/FsPutShortEOF/Chunked fstests.go:2640: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2682: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:15452") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:34766->172.17.0.5:15452, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:64935") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:56082->172.17.0.5:64935, err= 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:38929") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:58070->172.17.0.5:38929, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/08/27 05:02:24 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-juquvit5xaca/deeper/nonexisting/directory" 2026/08/27 05:02:24 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/27 05:02:24 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:24 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:24 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:24 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:24 DEBUG : TestFTPProftpd: detected overridden config - adding "{Apwg_}" suffix to name 2026/08/27 05:02:24 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/27 05:02:24 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/27 05:02:24 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/27 05:02:24 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/deeper/nonexisting/directory: Connecting to FTP server 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/deeper/nonexisting/directory: dial("tcp","172.17.0.5:21") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca/deeper/nonexisting/directory: > dial: conn=172.17.0.1:39754->172.17.0.5:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2831: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2874: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2931: FS has no Directory methods and doesn't Wrap 2026/08/27 05:02:24 DEBUG : Waiting for deletions to finish 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:64528") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:36168->172.17.0.5:64528, err= 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:43882") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:55416->172.17.0.5:43882, err= 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:32591") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:47886->172.17.0.5:32591, err= 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:8224") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:49112->172.17.0.5:8224, err= 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:22260") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:43602->172.17.0.5:22260, err= 2026/08/27 05:02:24 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:49336") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:35928->172.17.0.5:49336, err= 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:42517") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:36898->172.17.0.5:42517, err= 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:22088") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:45404->172.17.0.5:22088, err= 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:46587") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:48246->172.17.0.5:46587, err= 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:18065") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:40630->172.17.0.5:18065, err= 2026/08/27 05:02:24 DEBUG : removing 1 level 4 directories 2026/08/27 05:02:24 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/08/27 05:02:24 DEBUG : removing 1 level 3 directories 2026/08/27 05:02:24 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/08/27 05:02:24 DEBUG : removing 1 level 2 directories 2026/08/27 05:02:24 INFO : hello? sausage/êé: Removing directory 2026/08/27 05:02:24 DEBUG : removing 1 level 1 directories 2026/08/27 05:02:24 INFO : hello? sausage: Removing directory 2026/08/27 05:02:24 DEBUG : removing 1 level 0 directories 2026/08/27 05:02:24 INFO : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: Removing directory 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:5552") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:34926->172.17.0.5:5552, err= 2026/08/27 05:02:24 ERROR : error listing: directory not found 2026/08/27 05:02:24 DEBUG : Waiting for deletions to finish 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:8124") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:37264->172.17.0.5:8124, err= 2026/08/27 05:02:24 ERROR : error listing: directory not found 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: dial("tcp","172.17.0.5:57859") 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: > dial: conn=172.17.0.1:53364->172.17.0.5:57859, err= 2026/08/27 05:02:24 ERROR : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: Failed to list "": directory not found 2026/08/27 05:02:24 DEBUG : removing 1 level 0 directories 2026/08/27 05:02:24 INFO : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: Removing directory 2026/08/27 05:02:24 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/08/27 05:02:24 DEBUG : ftp://172.17.0.5:21/rclone-test-juquvit5xaca: closing 2 unused connections 2026/08/27 05:02:24 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (4.17s) --- 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 (3.06s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.20s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.04s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.74s) --- 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.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.07s) --- 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.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (0.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.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.01s) --- 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.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (1.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (1.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Simple (0.01s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 4.196s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 6.012239085s (try 1/5)