"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/12/12 01:04:07 NOTICE: TestFTPProftpd: Starting server 2025/12/12 01:04:08 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.9:21" try 1/100 2025/12/12 01:04:08 DEBUG : TestFTPProftpd: Read 1, error: 2025/12/12 01:04:08 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.9:21" 2025/12/12 01:04:08 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-gafoxog4hazo" 2025/12/12 01:04:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/12 01:04:08 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/12 01:04:08 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:08 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:08 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:08 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:08 DEBUG : TestFTPProftpd: detected overridden config - adding "{EFPAF}" suffix to name 2025/12/12 01:04:08 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:08 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:08 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:08 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: Connecting to FTP server 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:21") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:60202->172.17.0.9:21, err= 2025/12/12 01:04:08 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:11871") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:34448->172.17.0.9:11871, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:26786") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:41380->172.17.0.9:26786, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/12/12 01:04:08 INFO : dir/subdir: Making directory 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:14901") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:56352->172.17.0.9:14901, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:57016") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:38216->172.17.0.9:57016, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:14614") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:41732->172.17.0.9:14614, err= 2025/12/12 01:04:08 INFO : dir/subdir: Removing directory 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:17575") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:53826->172.17.0.9:17575, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:48867") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:49934->172.17.0.9:48867, err= 2025/12/12 01:04:08 INFO : dir: Removing directory 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:61246") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:55566->172.17.0.9:61246, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:3069") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:59740->172.17.0.9:3069, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:42515") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:47936->172.17.0.9:42515, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:46919") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:42488->172.17.0.9:46919, err= 2025/12/12 01:04:08 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:12656") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:42912->172.17.0.9:12656, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:33666") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:52248->172.17.0.9:33666, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:18375") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:34670->172.17.0.9:18375, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:15541") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:46314->172.17.0.9:15541, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:56686") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:33514->172.17.0.9:56686, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:41729") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:42284->172.17.0.9:41729, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:15136") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:38728->172.17.0.9:15136, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:29033") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:59816->172.17.0.9:29033, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:2303") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:33658->172.17.0.9:2303, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:10505") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:50504->172.17.0.9:10505, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:60202") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:58796->172.17.0.9:60202, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:17052") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:58540->172.17.0.9:17052, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:35089") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:51716->172.17.0.9:35089, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:3620") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:52784->172.17.0.9:3620, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:9725") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:35524->172.17.0.9:9725, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:7071") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:43752->172.17.0.9:7071, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:64887") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:50224->172.17.0.9:64887, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:23254") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:49206->172.17.0.9:23254, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:45225") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:39592->172.17.0.9:45225, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:42421") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:58160->172.17.0.9:42421, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:34101") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:37460->172.17.0.9:34101, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:6477") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:38732->172.17.0.9:6477, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:56299") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:46318->172.17.0.9:56299, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:25583") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:50346->172.17.0.9:25583, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:20067") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:48476->172.17.0.9:20067, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:8339") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:58494->172.17.0.9:8339, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:8915") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:60472->172.17.0.9:8915, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:15778") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:53456->172.17.0.9:15778, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:10385") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:51490->172.17.0.9:10385, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:50406") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:47218->172.17.0.9:50406, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:61674") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:54984->172.17.0.9:61674, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:22018") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:44736->172.17.0.9:22018, err= 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:18537") 2025/12/12 01:04:08 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:34192->172.17.0.9:18537, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:14514") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:44244->172.17.0.9:14514, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:36535") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:53432->172.17.0.9:36535, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:9689") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:49558->172.17.0.9:9689, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:55220") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:35784->172.17.0.9:55220, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:50648") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:53074->172.17.0.9:50648, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:37699") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:35604->172.17.0.9:37699, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:56499") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:37560->172.17.0.9:56499, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:60129") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:39206->172.17.0.9:60129, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:32366") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:38538->172.17.0.9:32366, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:8017") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:59254->172.17.0.9:8017, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:29684") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:45740->172.17.0.9:29684, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:34963") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:36474->172.17.0.9:34963, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:16719") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:55960->172.17.0.9:16719, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:35731") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:40132->172.17.0.9:35731, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:34315") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:55990->172.17.0.9:34315, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:38949") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:54310->172.17.0.9:38949, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:15422") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:42608->172.17.0.9:15422, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:11202") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:52386->172.17.0.9:11202, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:7516") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:49952->172.17.0.9:7516, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:20875") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:35666->172.17.0.9:20875, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:1966") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:39110->172.17.0.9:1966, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:32075") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:58682->172.17.0.9:32075, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:39918") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:52240->172.17.0.9:39918, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:9282") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:42768->172.17.0.9:9282, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:39967") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:52252->172.17.0.9:39967, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:54673") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:60646->172.17.0.9:54673, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:18644") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:44700->172.17.0.9:18644, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:24838") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:35754->172.17.0.9:24838, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:50813") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:55024->172.17.0.9:50813, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:39638") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:45792->172.17.0.9:39638, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:42352") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:37878->172.17.0.9:42352, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:64303") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:59054->172.17.0.9:64303, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:10639") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:60930->172.17.0.9:10639, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:51017") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:59204->172.17.0.9:51017, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:53989") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:54318->172.17.0.9:53989, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:60263") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:49282->172.17.0.9:60263, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:23182") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:56290->172.17.0.9:23182, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:44954") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:43650->172.17.0.9:44954, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:54857") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:38440->172.17.0.9:54857, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:54524") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:54852->172.17.0.9:54524, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:51947") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:40518->172.17.0.9:51947, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:19007") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:59586->172.17.0.9:19007, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:23953") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:48950->172.17.0.9:23953, err= 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:3131") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:53906->172.17.0.9:3131, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:53715") 2025/12/12 01:04:09 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:42400->172.17.0.9:53715, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: Connecting to FTP server 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:21") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:60210->172.17.0.9:21, err= 2025/12/12 01:04:10 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:3690") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:42604->172.17.0.9:3690, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:45817") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:47452->172.17.0.9:45817, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:4541") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:54198->172.17.0.9:4541, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:1714") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:54574->172.17.0.9:1714, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:29478") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:60086->172.17.0.9:29478, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:14685") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:58794->172.17.0.9:14685, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:26491") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:60268->172.17.0.9:26491, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:46334") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:37036->172.17.0.9:46334, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:34387") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:33914->172.17.0.9:34387, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:22790") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:41388->172.17.0.9:22790, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:13404") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:36104->172.17.0.9:13404, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:29784") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:54390->172.17.0.9:29784, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:46193") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:38628->172.17.0.9:46193, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:7459") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:54726->172.17.0.9:7459, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:12389") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:47474->172.17.0.9:12389, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:54489") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:36172->172.17.0.9:54489, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:29774") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:41546->172.17.0.9:29774, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:24387") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:53582->172.17.0.9:24387, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:10178") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:52100->172.17.0.9:10178, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/12/12 01:04:10 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/12/12 01:04:10 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/12 01:04:10 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:10 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:10 DEBUG : TestFTPProftpd: detected overridden config - adding "{EFPAF}" suffix to name 2025/12/12 01:04:10 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:10 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: Connecting to FTP server 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:21") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:60218->172.17.0.9:21, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:62860") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:47996->172.17.0.9:62860, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:53982") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:33200->172.17.0.9:53982, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:4707") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:50072->172.17.0.9:4707, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:18653") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:54864->172.17.0.9:18653, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:50595") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:38528->172.17.0.9:50595, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:59506") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:57312->172.17.0.9:59506, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:18131") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:41158->172.17.0.9:18131, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:29399") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:41892->172.17.0.9:29399, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:53314") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:60064->172.17.0.9:53314, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:54521") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:36704->172.17.0.9:54521, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:43955") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:37750->172.17.0.9:43955, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:16964") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:49478->172.17.0.9:16964, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:18682") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:36406->172.17.0.9:18682, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:46622") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:55358->172.17.0.9:46622, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:61757") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:48172->172.17.0.9:61757, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1153: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1190: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/12/12 01:04:10 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-gafoxog4hazo/hello? sausage/êé" 2025/12/12 01:04:10 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/12 01:04:10 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:10 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:10 DEBUG : TestFTPProftpd: detected overridden config - adding "{EFPAF}" suffix to name 2025/12/12 01:04:10 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:10 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: Connecting to FTP server 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:21") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:60224->172.17.0.9:21, err= 2025/12/12 01:04:10 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-gafoxog4hazo/hello? sausage/êé" to be canonical "TestFTPProftpd{EFPAF}:rclone-test-gafoxog4hazo/hello? sausage/êé" 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:43690") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:58484->172.17.0.9:43690, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:36310") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:43226->172.17.0.9:36310, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: Connecting to FTP server 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:21") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:60228->172.17.0.9:21, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:19369") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:38594->172.17.0.9:19369, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:13979") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:45814->172.17.0.9:13979, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:19536") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:57102->172.17.0.9:19536, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:6077") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:39156->172.17.0.9:6077, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:9650") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:44524->172.17.0.9:9650, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:59816") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:42220->172.17.0.9:59816, err= 2025/12/12 01:04:10 DEBUG : Waiting for deletions to finish 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:29751") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:42548->172.17.0.9:29751, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:20750") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:34604->172.17.0.9:20750, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:8073") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:43298->172.17.0.9:8073, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:24354") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:54916->172.17.0.9:24354, err= 2025/12/12 01:04:10 INFO : a/b/c/d/e.txt: Deleted 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:42358") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:42830->172.17.0.9:42358, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:12761") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:35410->172.17.0.9:12761, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:63915") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:35900->172.17.0.9:63915, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: dial("tcp","172.17.0.9:5727") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé: > dial: conn=172.17.0.1:34848->172.17.0.9:5727, err= 2025/12/12 01:04:10 DEBUG : removing 1 level 4 directories 2025/12/12 01:04:10 INFO : a/b/c/d: Removing directory 2025/12/12 01:04:10 DEBUG : removing 1 level 3 directories 2025/12/12 01:04:10 INFO : a/b/c: Removing directory 2025/12/12 01:04:10 DEBUG : removing 1 level 2 directories 2025/12/12 01:04:10 INFO : a/b: Removing directory 2025/12/12 01:04:10 DEBUG : removing 1 level 1 directories 2025/12/12 01:04:10 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:22199") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:39324->172.17.0.9:22199, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:47312") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:54832->172.17.0.9:47312, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:25701") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:54492->172.17.0.9:25701, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:35861") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:42478->172.17.0.9:35861, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:8269") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:59000->172.17.0.9:8269, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:6500") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:43102->172.17.0.9:6500, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: Connecting to FTP server 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:21") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:60236->172.17.0.9:21, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:4713") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:52198->172.17.0.9:4713, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:58862") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:52098->172.17.0.9:58862, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:30036") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:50146->172.17.0.9:30036, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:33834") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:59958->172.17.0.9:33834, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:18880") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:53374->172.17.0.9:18880, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:58163") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:38938->172.17.0.9:58163, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:33474") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:45156->172.17.0.9:33474, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:41616") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:52998->172.17.0.9:41616, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:10694") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:42474->172.17.0.9:10694, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:61560") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:48054->172.17.0.9:61560, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:25316") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:45378->172.17.0.9:25316, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:28215") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:34644->172.17.0.9:28215, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:44839") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:47058->172.17.0.9:44839, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:59400") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:57464->172.17.0.9:59400, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:64159") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:46292->172.17.0.9:64159, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:13837") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:43450->172.17.0.9:13837, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:54067") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:39914->172.17.0.9:54067, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/12/12 01:04:10 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-gociyef5vune" 2025/12/12 01:04:10 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/12 01:04:10 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:10 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:10 DEBUG : TestFTPProftpd: detected overridden config - adding "{EFPAF}" suffix to name 2025/12/12 01:04:10 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:10 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: Connecting to FTP server 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: dial("tcp","172.17.0.9:21") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: > dial: conn=172.17.0.1:60240->172.17.0.9:21, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:2222") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:50460->172.17.0.9:2222, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: dial("tcp","172.17.0.9:32663") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: > dial: conn=172.17.0.1:42752->172.17.0.9:32663, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: dial("tcp","172.17.0.9:44783") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: > dial: conn=172.17.0.1:41114->172.17.0.9:44783, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: dial("tcp","172.17.0.9:20565") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: > dial: conn=172.17.0.1:33974->172.17.0.9:20565, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: dial("tcp","172.17.0.9:32731") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: > dial: conn=172.17.0.1:33216->172.17.0.9:32731, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: dial("tcp","172.17.0.9:23302") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: > dial: conn=172.17.0.1:48440->172.17.0.9:23302, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: dial("tcp","172.17.0.9:36054") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: > dial: conn=172.17.0.1:45580->172.17.0.9:36054, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: dial("tcp","172.17.0.9:17658") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: > dial: conn=172.17.0.1:36766->172.17.0.9:17658, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:3692") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:48920->172.17.0.9:3692, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:29974") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:42692->172.17.0.9:29974, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:8803") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:55662->172.17.0.9:8803, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:47064") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:38156->172.17.0.9:47064, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:42514") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:53186->172.17.0.9:42514, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: dial("tcp","172.17.0.9:61025") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: > dial: conn=172.17.0.1:44320->172.17.0.9:61025, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: dial("tcp","172.17.0.9:35082") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: > dial: conn=172.17.0.1:55472->172.17.0.9:35082, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: dial("tcp","172.17.0.9:11084") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: > dial: conn=172.17.0.1:51462->172.17.0.9:11084, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: dial("tcp","172.17.0.9:54219") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: > dial: conn=172.17.0.1:49762->172.17.0.9:54219, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: Purge dir "new_name" 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gociyef5vune: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:7399") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:47310->172.17.0.9:7399, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:45547") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:58554->172.17.0.9:45547, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:12601") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:49304->172.17.0.9:12601, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:7375") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:51570->172.17.0.9:7375, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:41756") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:40458->172.17.0.9:41756, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:26432") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:51508->172.17.0.9:26432, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:27575") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:38452->172.17.0.9:27575, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:1346") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:38916->172.17.0.9:1346, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:43540") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:38180->172.17.0.9:43540, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/12/12 01:04:10 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-gafoxog4hazo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/12/12 01:04:10 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/12 01:04:10 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:10 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:10 DEBUG : TestFTPProftpd: detected overridden config - adding "{EFPAF}" suffix to name 2025/12/12 01:04:10 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:10 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.9:21") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:60242->172.17.0.9:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.9:37829") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:34520->172.17.0.9:37829, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/12/12 01:04:10 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-gafoxog4hazo/not found.txt" 2025/12/12 01:04:10 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/12 01:04:10 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:10 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:10 DEBUG : TestFTPProftpd: detected overridden config - adding "{EFPAF}" suffix to name 2025/12/12 01:04:10 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:10 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/not found.txt: Connecting to FTP server 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/not found.txt: dial("tcp","172.17.0.9:21") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/not found.txt: > dial: conn=172.17.0.1:60248->172.17.0.9:21, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/not found.txt: dial("tcp","172.17.0.9:55251") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/not found.txt: > dial: conn=172.17.0.1:35824->172.17.0.9:55251, err= 2025/12/12 01:04:10 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-gafoxog4hazo" from "TestFTPProftpd:rclone-test-gafoxog4hazo" 2025/12/12 01:04:10 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/12/12 01:04:10 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/12 01:04:10 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:10 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:10 DEBUG : TestFTPProftpd: detected overridden config - adding "{EFPAF}" suffix to name 2025/12/12 01:04:10 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:10 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: Connecting to FTP server 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:21") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:60258->172.17.0.9:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:60465") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:55928->172.17.0.9:60465, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:37261") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:50502->172.17.0.9:37261, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:26188") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:35972->172.17.0.9:26188, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:44945") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:49800->172.17.0.9:44945, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:39715") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:41214->172.17.0.9:39715, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:11163") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:32784->172.17.0.9:11163, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:45630") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:35848->172.17.0.9:45630, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:32212") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:37706->172.17.0.9:32212, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:23828") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:45530->172.17.0.9:23828, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:14998") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:52944->172.17.0.9:14998, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:20183") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:60698->172.17.0.9:20183, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:19192") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:42922->172.17.0.9:19192, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:25137") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:41142->172.17.0.9:25137, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:11135") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:43120->172.17.0.9:11135, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:54670") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:53206->172.17.0.9:54670, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:40346") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:60262->172.17.0.9:40346, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:31810") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:37598->172.17.0.9:31810, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2004: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2109: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:23777") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:46492->172.17.0.9:23777, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:55950") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:42880->172.17.0.9:55950, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:43638") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:35584->172.17.0.9:43638, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:53636") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:33982->172.17.0.9:53636, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:6975") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:47146->172.17.0.9:6975, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2281: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:20689") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:44388->172.17.0.9:20689, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:32527") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:47374->172.17.0.9:32527, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/12/12 01:04:10 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-gafoxog4hazo" 2025/12/12 01:04:10 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/12 01:04:10 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:10 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:10 DEBUG : TestFTPProftpd: detected overridden config - adding "{WQ6FR}" suffix to name 2025/12/12 01:04:10 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:10 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:10 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:10 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: Connecting to FTP server 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:21") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:60268->172.17.0.9:21, err= 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:13133") 2025/12/12 01:04:10 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:56664->172.17.0.9:13133, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2476: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:51039") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:44242->172.17.0.9:51039, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:12661") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:59536->172.17.0.9:12661, err= 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:34371") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:46786->172.17.0.9:34371, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/12/12 01:04:11 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-gafoxog4hazo/deeper/nonexisting/directory" 2025/12/12 01:04:11 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/12 01:04:11 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:11 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:11 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:11 DEBUG : TestFTPProftpd: detected overridden config - adding "{EFPAF}" suffix to name 2025/12/12 01:04:11 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/12 01:04:11 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/12 01:04:11 DEBUG : Setting pass="z8PMLkwYMbHFmjp013Urw-Zm2-sqqclpBAMR5-xIytSLEA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/12 01:04:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/deeper/nonexisting/directory: Connecting to FTP server 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/deeper/nonexisting/directory: dial("tcp","172.17.0.9:21") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo/deeper/nonexisting/directory: > dial: conn=172.17.0.1:60284->172.17.0.9:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/12/12 01:04:11 DEBUG : Waiting for deletions to finish 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:49108") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:42540->172.17.0.9:49108, err= 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:5065") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:39282->172.17.0.9:5065, err= 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:6711") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:40656->172.17.0.9:6711, err= 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:50185") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:36474->172.17.0.9:50185, err= 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:2451") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:44718->172.17.0.9:2451, err= 2025/12/12 01:04:11 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:15458") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:35960->172.17.0.9:15458, err= 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:39177") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:55698->172.17.0.9:39177, err= 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:1288") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:51838->172.17.0.9:1288, err= 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:12402") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:34690->172.17.0.9:12402, err= 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:6850") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:56250->172.17.0.9:6850, err= 2025/12/12 01:04:11 DEBUG : removing 1 level 4 directories 2025/12/12 01:04:11 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/12/12 01:04:11 DEBUG : removing 1 level 3 directories 2025/12/12 01:04:11 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/12/12 01:04:11 DEBUG : removing 1 level 2 directories 2025/12/12 01:04:11 INFO : hello? sausage/êé: Removing directory 2025/12/12 01:04:11 DEBUG : removing 1 level 1 directories 2025/12/12 01:04:11 INFO : hello? sausage: Removing directory 2025/12/12 01:04:11 DEBUG : removing 1 level 0 directories 2025/12/12 01:04:11 INFO : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: Removing directory 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:61747") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:52786->172.17.0.9:61747, err= 2025/12/12 01:04:11 ERROR : error listing: directory not found 2025/12/12 01:04:11 DEBUG : Waiting for deletions to finish 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:5686") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:51382->172.17.0.9:5686, err= 2025/12/12 01:04:11 ERROR : error listing: directory not found 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: dial("tcp","172.17.0.9:25966") 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: > dial: conn=172.17.0.1:49094->172.17.0.9:25966, err= 2025/12/12 01:04:11 ERROR : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: Failed to list "": directory not found 2025/12/12 01:04:11 DEBUG : removing 1 level 0 directories 2025/12/12 01:04:11 INFO : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: Removing directory 2025/12/12 01:04:11 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/12/12 01:04:11 DEBUG : ftp://172.17.0.9:21/rclone-test-gafoxog4hazo: closing 2 unused connections 2025/12/12 01:04:11 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (3.76s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.00s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (2.45s) --- 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.02s) --- 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.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.12s) --- 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.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.76s) --- 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.01s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 3.787s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 4.825139862s (try 1/5)