"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/03 02:01:58 NOTICE: TestFTPProftpd: Starting server 2026/08/03 02:01:59 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.3:21" try 1/100 2026/08/03 02:01:59 DEBUG : TestFTPProftpd: Read 1, error: 2026/08/03 02:01:59 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.3:21" 2026/08/03 02:01:59 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-qahuquj6mupu" 2026/08/03 02:01:59 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/03 02:01:59 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/03 02:01:59 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:01:59 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:01:59 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:01:59 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:01:59 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Ori3}" suffix to name 2026/08/03 02:01:59 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:01:59 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:01:59 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:01:59 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: Connecting to FTP server 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:21") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:51434->172.17.0.3:21, err= 2026/08/03 02:01:59 DEBUG : Setting type="ftp" 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/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:28939") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:53978->172.17.0.3:28939, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:52037") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:58864->172.17.0.3:52037, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/08/03 02:01:59 INFO : dir/subdir: Making directory 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:48831") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:44286->172.17.0.3:48831, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:18891") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:52110->172.17.0.3:18891, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:47327") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:54358->172.17.0.3:47327, err= 2026/08/03 02:01:59 INFO : dir/subdir: Removing directory 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:12552") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:53404->172.17.0.3:12552, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:7684") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:43882->172.17.0.3:7684, err= 2026/08/03 02:01:59 INFO : dir: Removing directory 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:55964") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:34266->172.17.0.3:55964, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:52683") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:55992->172.17.0.3:52683, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:31750") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:41212->172.17.0.3:31750, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:11860") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:40442->172.17.0.3:11860, err= 2026/08/03 02:01:59 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/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:60767") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:52332->172.17.0.3:60767, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:727: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:50354") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:45742->172.17.0.3:50354, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:4112") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:58456->172.17.0.3:4112, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:15520") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:59568->172.17.0.3:15520, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:53332") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:46880->172.17.0.3:53332, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:727: testing "." 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:55865") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:37648->172.17.0.3:55865, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:12292") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:57616->172.17.0.3:12292, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:56204") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:39724->172.17.0.3:56204, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:35737") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:35270->172.17.0.3:35737, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:727: testing ".." 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:43013") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:37954->172.17.0.3:43013, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:19009") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:56864->172.17.0.3:19009, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:4439") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:49350->172.17.0.3:4439, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:31387") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:37548->172.17.0.3:31387, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:727: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:11101") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:44810->172.17.0.3:11101, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:4169") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:50500->172.17.0.3:4169, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:29871") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:47974->172.17.0.3:29871, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:19631") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:54092->172.17.0.3:19631, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:727: testing " leading space" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:53038") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:36876->172.17.0.3:53038, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:34149") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:43756->172.17.0.3:34149, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:25784") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:40620->172.17.0.3:25784, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:16443") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:41174->172.17.0.3:16443, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:727: testing "~leading tilde" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:20651") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:44952->172.17.0.3:20651, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:9081") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:58140->172.17.0.3:9081, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:34311") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:49138->172.17.0.3:34311, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:2443") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:60698->172.17.0.3:2443, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:727: testing "␍leading CR" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:20610") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:58242->172.17.0.3:20610, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:40971") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:54068->172.17.0.3:40971, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:57384") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:45810->172.17.0.3:57384, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:7758") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:58812->172.17.0.3:7758, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:727: testing "␊leading LF" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:7187") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:42796->172.17.0.3:7187, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:3709") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:37636->172.17.0.3:3709, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:2991") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:49878->172.17.0.3:2991, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:56517") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:51640->172.17.0.3:56517, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:727: testing "␉leading HT" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:6797") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:34636->172.17.0.3:6797, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:17488") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:47600->172.17.0.3:17488, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:44315") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:32880->172.17.0.3:44315, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:61638") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:42430->172.17.0.3:61638, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:727: testing "␋leading VT" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:28756") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:58168->172.17.0.3:28756, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:34984") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:50336->172.17.0.3:34984, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:31840") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:33528->172.17.0.3:31840, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:6234") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:34014->172.17.0.3:6234, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:727: testing ".leading dot" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:52970") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:40424->172.17.0.3:52970, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:35256") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:52914->172.17.0.3:35256, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:36598") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:50760->172.17.0.3:36598, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:63047") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:41502->172.17.0.3:63047, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:727: testing "trailing space " 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:38402") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:41572->172.17.0.3:38402, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:65445") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:51858->172.17.0.3:65445, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:17143") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:46654->172.17.0.3:17143, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:25905") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:33318->172.17.0.3:25905, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:727: testing "trailing CR␍" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:34060") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:46706->172.17.0.3:34060, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:41904") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:38592->172.17.0.3:41904, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:41324") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:42158->172.17.0.3:41324, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:53687") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:34446->172.17.0.3:53687, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:727: testing "trailing LF␊" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:49962") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:52764->172.17.0.3:49962, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:10101") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:48980->172.17.0.3:10101, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:55107") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:60544->172.17.0.3:55107, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:5037") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:45406->172.17.0.3:5037, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:727: testing "trailing HT␉" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:50048") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:42836->172.17.0.3:50048, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:46956") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:57040->172.17.0.3:46956, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:11772") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:33172->172.17.0.3:11772, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:56212") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:36920->172.17.0.3:56212, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:727: testing "trailing VT␋" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:49641") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:48892->172.17.0.3:49641, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:13739") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:58874->172.17.0.3:13739, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:47194") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:37996->172.17.0.3:47194, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:55415") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:41890->172.17.0.3:55415, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:727: testing "trailing dot." 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:30204") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:55178->172.17.0.3:30204, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:25975") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:51902->172.17.0.3:25975, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:51518") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:51250->172.17.0.3:51518, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:57937") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:32982->172.17.0.3:57937, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:727: testing "invalid utf-8\xfe" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:59935") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:33248->172.17.0.3:59935, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:17824") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:59920->172.17.0.3:17824, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:63147") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:42648->172.17.0.3:63147, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:47371") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:52894->172.17.0.3:47371, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:727: testing "test%46.txt" 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:52057") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:33840->172.17.0.3:52057, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:34211") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:53660->172.17.0.3:34211, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:44884") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:39920->172.17.0.3:44884, err= 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:24924") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:57070->172.17.0.3:24924, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:34122") 2026/08/03 02:01:59 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:58330->172.17.0.3:34122, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: Connecting to FTP server 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:21") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:51446->172.17.0.3:21, err= 2026/08/03 02:02:00 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:12255") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:53818->172.17.0.3:12255, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:32915") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:59944->172.17.0.3:32915, 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/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:64302") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:41246->172.17.0.3:64302, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:19646") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:43988->172.17.0.3:19646, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:19209") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:36100->172.17.0.3:19209, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:49850") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:43718->172.17.0.3:49850, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:21402") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:60302->172.17.0.3:21402, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:26515") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:44726->172.17.0.3:26515, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:41461") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:45044->172.17.0.3:41461, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:60418") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:59256->172.17.0.3:60418, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:48572") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:41758->172.17.0.3:48572, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:6564") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:54634->172.17.0.3:6564, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:24419") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:48392->172.17.0.3:24419, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:63271") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:60764->172.17.0.3:63271, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:38361") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:56506->172.17.0.3:38361, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:37679") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:45110->172.17.0.3:37679, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:55628") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:55976->172.17.0.3:55628, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:39683") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:38838->172.17.0.3:39683, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:49288") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:34282->172.17.0.3:49288, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/08/03 02:02:00 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/08/03 02:02:00 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/03 02:02:00 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:00 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:00 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Ori3}" suffix to name 2026/08/03 02:02:00 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:00 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:51460->172.17.0.3:21, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:8146") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:46604->172.17.0.3:8146, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:36879") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:44460->172.17.0.3:36879, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:38384") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:60096->172.17.0.3:38384, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:51774") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:58790->172.17.0.3:51774, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:32630") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:53656->172.17.0.3:32630, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:20752") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:33384->172.17.0.3:20752, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:51462") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:34134->172.17.0.3:51462, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:37952") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:35468->172.17.0.3:37952, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:1535") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:49642->172.17.0.3:1535, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:34285") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:33338->172.17.0.3:34285, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1145: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:29851") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:38436->172.17.0.3:29851, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:35639") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:53762->172.17.0.3:35639, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:22082") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:37000->172.17.0.3:22082, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:41082") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:39228->172.17.0.3:41082, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:3019") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:42876->172.17.0.3:3019, 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/03 02:02:00 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-qahuquj6mupu/hello? sausage/êé" 2026/08/03 02:02:00 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/03 02:02:00 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:00 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:00 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Ori3}" suffix to name 2026/08/03 02:02:00 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:00 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: Connecting to FTP server 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:51468->172.17.0.3:21, err= 2026/08/03 02:02:00 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-qahuquj6mupu/hello? sausage/êé" to be canonical "TestFTPProftpd{4Ori3}:rclone-test-qahuquj6mupu/hello? sausage/êé" 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:35630") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:38358->172.17.0.3:35630, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:5689") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:42092->172.17.0.3:5689, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: Connecting to FTP server 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:51474->172.17.0.3:21, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:52317") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:51048->172.17.0.3:52317, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:19849") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:50100->172.17.0.3:19849, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:31466") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:39954->172.17.0.3:31466, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:49590") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:55180->172.17.0.3:49590, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:58656") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:33624->172.17.0.3:58656, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:24843") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:49130->172.17.0.3:24843, err= 2026/08/03 02:02:00 DEBUG : Waiting for deletions to finish 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:37284") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:56498->172.17.0.3:37284, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:52049") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:35320->172.17.0.3:52049, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:47890") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:60716->172.17.0.3:47890, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:50783") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:39242->172.17.0.3:50783, err= 2026/08/03 02:02:00 INFO : a/b/c/d/e.txt: Deleted 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:40481") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:46036->172.17.0.3:40481, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:36107") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:37258->172.17.0.3:36107, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:56163") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:52480->172.17.0.3:56163, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: dial("tcp","172.17.0.3:6728") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé: > dial: conn=172.17.0.1:49374->172.17.0.3:6728, err= 2026/08/03 02:02:00 DEBUG : removing 1 level 4 directories 2026/08/03 02:02:00 INFO : a/b/c/d: Removing directory 2026/08/03 02:02:00 DEBUG : removing 1 level 3 directories 2026/08/03 02:02:00 INFO : a/b/c: Removing directory 2026/08/03 02:02:00 DEBUG : removing 1 level 2 directories 2026/08/03 02:02:00 INFO : a/b: Removing directory 2026/08/03 02:02:00 DEBUG : removing 1 level 1 directories 2026/08/03 02:02:00 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1278: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:20849") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:56284->172.17.0.3:20849, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:59704") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:51882->172.17.0.3:59704, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:21204") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:46624->172.17.0.3:21204, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:5164") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:49104->172.17.0.3:5164, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:15572") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:39780->172.17.0.3:15572, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:46696") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:38628->172.17.0.3:46696, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: Connecting to FTP server 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:21") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:45602") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:57088->172.17.0.3:45602, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:51478->172.17.0.3:21, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:38115") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:57582->172.17.0.3:38115, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:10455") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:47896->172.17.0.3:10455, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:43598") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:48248->172.17.0.3:43598, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:29733") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:51744->172.17.0.3:29733, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:52496") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:60288->172.17.0.3:52496, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:51142") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:39158->172.17.0.3:51142, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:20216") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:32780->172.17.0.3:20216, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:33851") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:46910->172.17.0.3:33851, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:45044") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:58040->172.17.0.3:45044, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:27470") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:39838->172.17.0.3:27470, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:12983") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:47922->172.17.0.3:12983, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:23969") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:55104") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:44750->172.17.0.3:23969, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:34994->172.17.0.3:55104, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:5995") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:45458->172.17.0.3:5995, err= 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:30030") 2026/08/03 02:02:00 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:37646->172.17.0.3:30030, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:17564") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:46098->172.17.0.3:17564, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1430: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/08/03 02:02:01 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-bukapad4boni" 2026/08/03 02:02:01 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/03 02:02:01 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:01 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:01 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Ori3}" suffix to name 2026/08/03 02:02:01 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:01 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: Connecting to FTP server 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: dial("tcp","172.17.0.3:21") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: > dial: conn=172.17.0.1:51486->172.17.0.3:21, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:8553") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:56466->172.17.0.3:8553, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: dial("tcp","172.17.0.3:61488") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: > dial: conn=172.17.0.1:45898->172.17.0.3:61488, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: dial("tcp","172.17.0.3:40910") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: > dial: conn=172.17.0.1:35230->172.17.0.3:40910, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: dial("tcp","172.17.0.3:39787") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: > dial: conn=172.17.0.1:35980->172.17.0.3:39787, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: dial("tcp","172.17.0.3:7840") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: > dial: conn=172.17.0.1:38102->172.17.0.3:7840, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: dial("tcp","172.17.0.3:43148") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: > dial: conn=172.17.0.1:50224->172.17.0.3:43148, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: dial("tcp","172.17.0.3:56186") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: > dial: conn=172.17.0.1:40976->172.17.0.3:56186, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: dial("tcp","172.17.0.3:37901") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: > dial: conn=172.17.0.1:50608->172.17.0.3:37901, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:62628") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:53126->172.17.0.3:62628, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:55514") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:51244->172.17.0.3:55514, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:54260") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:59188->172.17.0.3:54260, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:38726") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:47622->172.17.0.3:38726, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:53420") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:50502->172.17.0.3:53420, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: dial("tcp","172.17.0.3:33811") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: > dial: conn=172.17.0.1:36304->172.17.0.3:33811, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: dial("tcp","172.17.0.3:60066") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: > dial: conn=172.17.0.1:37226->172.17.0.3:60066, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: dial("tcp","172.17.0.3:30934") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: > dial: conn=172.17.0.1:37456->172.17.0.3:30934, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: dial("tcp","172.17.0.3:59350") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: > dial: conn=172.17.0.1:46402->172.17.0.3:59350, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: Purge dir "new_name" 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-bukapad4boni: 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/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:35478") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:35744->172.17.0.3:35478, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:40499") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:42292->172.17.0.3:40499, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:20515") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:49386->172.17.0.3:20515, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:25403") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:41448->172.17.0.3:25403, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:55206") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:58438->172.17.0.3:55206, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:60406") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:35938->172.17.0.3:60406, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:40886") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:52070->172.17.0.3:40886, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:34871") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:48530->172.17.0.3:34871, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:50918") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:57978->172.17.0.3:50918, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:26427") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:40082->172.17.0.3:26427, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:52093") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:36330->172.17.0.3:52093, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:57443") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:43402->172.17.0.3:57443, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:60977") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:49900->172.17.0.3:60977, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:65136") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:58396->172.17.0.3:65136, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:40167") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:59398->172.17.0.3:40167, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:29244") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:37914->172.17.0.3:29244, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/08/03 02:02:01 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-qahuquj6mupu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/08/03 02:02:01 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/03 02:02:01 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:01 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:01 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Ori3}" suffix to name 2026/08/03 02:02:01 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:01 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:21") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:51488->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:2918") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:37090->172.17.0.3:2918, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/08/03 02:02:01 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-qahuquj6mupu/not found.txt" 2026/08/03 02:02:01 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/03 02:02:01 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:01 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:01 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Ori3}" suffix to name 2026/08/03 02:02:01 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:01 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/not found.txt: Connecting to FTP server 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/not found.txt: dial("tcp","172.17.0.3:21") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/not found.txt: > dial: conn=172.17.0.1:51492->172.17.0.3:21, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/not found.txt: dial("tcp","172.17.0.3:41077") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/not found.txt: > dial: conn=172.17.0.1:58038->172.17.0.3:41077, err= 2026/08/03 02:02:01 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1987: Opening root remote "TestFTPProftpd:" path "rclone-test-qahuquj6mupu" from "TestFTPProftpd:rclone-test-qahuquj6mupu" 2026/08/03 02:02:01 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/08/03 02:02:01 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/03 02:02:01 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:01 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:01 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Ori3}" suffix to name 2026/08/03 02:02:01 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:01 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:51506->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:22337") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:35082->172.17.0.3:22337, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:26440") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:42150->172.17.0.3:26440, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:46425") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56760->172.17.0.3:46425, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:41439") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56156->172.17.0.3:41439, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:39476") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:40238->172.17.0.3:39476, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:23257") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:49830->172.17.0.3:23257, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2024: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:61478") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:43570->172.17.0.3:61478, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:62307") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:54304->172.17.0.3:62307, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:14572") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:39634->172.17.0.3:14572, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:1597") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:58862->172.17.0.3:1597, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:45917") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:57918->172.17.0.3:45917, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:19509") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:57376->172.17.0.3:19509, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:53968") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:41038->172.17.0.3:53968, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:15167") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:50192->172.17.0.3:15167, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:61173") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:38098->172.17.0.3:61173, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:60620") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:55712->172.17.0.3:60620, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:60296") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:34730->172.17.0.3:60296, 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/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:55718") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:54688->172.17.0.3:55718, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:11203") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:56454->172.17.0.3:11203, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:59688") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:49510->172.17.0.3:59688, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:62596") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:39030->172.17.0.3:62596, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:21759") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:34918->172.17.0.3:21759, 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/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:25822") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:50490->172.17.0.3:25822, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:19121") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:33772->172.17.0.3:19121, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/08/03 02:02:01 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-qahuquj6mupu" 2026/08/03 02:02:01 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/03 02:02:01 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:01 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:01 DEBUG : TestFTPProftpd: detected overridden config - adding "{HFRxu}" suffix to name 2026/08/03 02:02:01 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:01 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: Connecting to FTP server 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:21") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:51518->172.17.0.3:21, err= 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:32406") 2026/08/03 02:02:01 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:48846->172.17.0.3:32406, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2445: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2557: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:16235") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:54166->172.17.0.3:16235, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:61818") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:56348->172.17.0.3:61818, err= 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:45109") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:52970->172.17.0.3:45109, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/08/03 02:02:02 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-qahuquj6mupu/deeper/nonexisting/directory" 2026/08/03 02:02:02 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/08/03 02:02:02 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:02 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:02 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:02 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Ori3}" suffix to name 2026/08/03 02:02:02 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/08/03 02:02:02 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/08/03 02:02:02 DEBUG : Setting pass="mPS7ZfGu6IjIr-dOn8-bqv5Rs2RtOjIvrmkwKz7C2rRC7w" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/08/03 02:02:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/deeper/nonexisting/directory: Connecting to FTP server 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/deeper/nonexisting/directory: dial("tcp","172.17.0.3:21") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:43114->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2706: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2749: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2806: FS has no Directory methods and doesn't Wrap 2026/08/03 02:02:02 DEBUG : Waiting for deletions to finish 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:27818") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:56836->172.17.0.3:27818, err= 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:44993") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:60926->172.17.0.3:44993, err= 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:36061") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:42168->172.17.0.3:36061, err= 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:25540") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:46456->172.17.0.3:25540, err= 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:55987") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:33402->172.17.0.3:55987, err= 2026/08/03 02:02:02 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:57698") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:40058->172.17.0.3:57698, err= 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:47999") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:44992->172.17.0.3:47999, err= 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:37951") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:43522->172.17.0.3:37951, err= 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:40202") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:43734->172.17.0.3:40202, err= 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:51457") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:55802->172.17.0.3:51457, err= 2026/08/03 02:02:02 DEBUG : removing 1 level 4 directories 2026/08/03 02:02:02 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/08/03 02:02:02 DEBUG : removing 1 level 3 directories 2026/08/03 02:02:02 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/08/03 02:02:02 DEBUG : removing 1 level 2 directories 2026/08/03 02:02:02 INFO : hello? sausage/êé: Removing directory 2026/08/03 02:02:02 DEBUG : removing 1 level 1 directories 2026/08/03 02:02:02 INFO : hello? sausage: Removing directory 2026/08/03 02:02:02 DEBUG : removing 1 level 0 directories 2026/08/03 02:02:02 INFO : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: Removing directory 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:47677") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:49020->172.17.0.3:47677, err= 2026/08/03 02:02:02 ERROR : error listing: directory not found 2026/08/03 02:02:02 DEBUG : Waiting for deletions to finish 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:6025") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:56652->172.17.0.3:6025, err= 2026/08/03 02:02:02 ERROR : error listing: directory not found 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: dial("tcp","172.17.0.3:10531") 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: > dial: conn=172.17.0.1:53234->172.17.0.3:10531, err= 2026/08/03 02:02:02 ERROR : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: Failed to list "": directory not found 2026/08/03 02:02:02 DEBUG : removing 1 level 0 directories 2026/08/03 02:02:02 INFO : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: Removing directory 2026/08/03 02:02:02 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/08/03 02:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-qahuquj6mupu: closing 2 unused connections 2026/08/03 02:02:02 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (4.49s) --- 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.20s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.02s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.22s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.26s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (0.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (1.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (1.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.02s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 4.514s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 5.840583977s (try 1/5)