"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/12/24 02:28:49 NOTICE: TestFTPProftpd: Starting server 2025/12/24 02:28:50 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.7:21" try 1/100 2025/12/24 02:28:50 DEBUG : TestFTPProftpd: Read 1, error: 2025/12/24 02:28:50 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.7:21" 2025/12/24 02:28:50 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-gamoguv9hicu" 2025/12/24 02:28:50 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/24 02:28:50 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/24 02:28:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:50 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:50 DEBUG : TestFTPProftpd: detected overridden config - adding "{xvORY}" suffix to name 2025/12/24 02:28:50 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:50 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: Connecting to FTP server 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:21") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:52252->172.17.0.7:21, err= 2025/12/24 02:28:50 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/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:11486") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:45060->172.17.0.7:11486, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:57056") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:43182->172.17.0.7:57056, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/12/24 02:28:50 INFO : dir/subdir: Making directory 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:36403") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:36736->172.17.0.7:36403, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:9653") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:54752->172.17.0.7:9653, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:46446") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:49990->172.17.0.7:46446, err= 2025/12/24 02:28:50 INFO : dir/subdir: Removing directory 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:51153") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:33348->172.17.0.7:51153, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:46411") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:55194->172.17.0.7:46411, err= 2025/12/24 02:28:50 INFO : dir: Removing directory 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:14258") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:60822->172.17.0.7:14258, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:1538") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:44226->172.17.0.7:1538, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:30800") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:36990->172.17.0.7:30800, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:16269") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:34580->172.17.0.7:16269, err= 2025/12/24 02:28:50 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/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:45315") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:38238->172.17.0.7:45315, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:34743") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:38172->172.17.0.7:34743, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:3207") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:44760->172.17.0.7:3207, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:16656") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:32804->172.17.0.7:16656, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:49721") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:44734->172.17.0.7:49721, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:35407") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:40452->172.17.0.7:35407, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:22732") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:43570->172.17.0.7:22732, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:31990") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:36724->172.17.0.7:31990, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:39867") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:47052->172.17.0.7:39867, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:48147") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:50338->172.17.0.7:48147, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:28978") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:46934->172.17.0.7:28978, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:43755") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:47420->172.17.0.7:43755, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:35434") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:52218->172.17.0.7:35434, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:14309") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:39372->172.17.0.7:14309, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:50548") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:37654->172.17.0.7:50548, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:49889") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:39984->172.17.0.7:49889, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:56190") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:39496->172.17.0.7:56190, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:5812") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:35786->172.17.0.7:5812, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:57915") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:54000->172.17.0.7:57915, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:37692") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:42570->172.17.0.7:37692, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:16274") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:46924->172.17.0.7:16274, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:49437") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:46632->172.17.0.7:49437, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:8560") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:59512->172.17.0.7:8560, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:24904") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:33546->172.17.0.7:24904, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:30348") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:36258->172.17.0.7:30348, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:58690") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:34770->172.17.0.7:58690, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:5780") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:54188->172.17.0.7:5780, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:43583") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:46902->172.17.0.7:43583, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:59204") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:50680->172.17.0.7:59204, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:35556") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:51854->172.17.0.7:35556, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:58828") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:46824->172.17.0.7:58828, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:38985") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:54578->172.17.0.7:38985, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:4765") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:60566->172.17.0.7:4765, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:61011") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:60692->172.17.0.7:61011, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:54618") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:56786->172.17.0.7:54618, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:53463") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:36646->172.17.0.7:53463, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:30884") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:35482->172.17.0.7:30884, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:11815") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:43850->172.17.0.7:11815, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:19918") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:41310->172.17.0.7:19918, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:5217") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:49250->172.17.0.7:5217, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:58938") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:33992->172.17.0.7:58938, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:47873") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:39102->172.17.0.7:47873, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:47949") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:32938->172.17.0.7:47949, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:28837") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:54860->172.17.0.7:28837, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:61159") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:49890->172.17.0.7:61159, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:32962") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:52006->172.17.0.7:32962, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:13191") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:50856->172.17.0.7:13191, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:51815") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:55724->172.17.0.7:51815, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:37751") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:52680->172.17.0.7:37751, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:5572") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:37388->172.17.0.7:5572, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:23972") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:37028->172.17.0.7:23972, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:53001") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:51380->172.17.0.7:53001, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:53986") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:47470->172.17.0.7:53986, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:31509") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:48050->172.17.0.7:31509, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:12371") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:51794->172.17.0.7:12371, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:18799") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:51612->172.17.0.7:18799, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:24665") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:33510->172.17.0.7:24665, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:17128") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:44552->172.17.0.7:17128, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:61359") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:37270->172.17.0.7:61359, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:18334") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:42216->172.17.0.7:18334, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:51661") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:33236->172.17.0.7:51661, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:54652") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:40764->172.17.0.7:54652, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:56296") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:57894->172.17.0.7:56296, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:55402") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:37144->172.17.0.7:55402, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:50129") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:46964->172.17.0.7:50129, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:45379") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:48628->172.17.0.7:45379, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:43331") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:43560->172.17.0.7:43331, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:15478") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:33240->172.17.0.7:15478, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:56171") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:57846->172.17.0.7:56171, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:62225") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:59748->172.17.0.7:62225, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:19672") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:43838->172.17.0.7:19672, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:49574") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:59790->172.17.0.7:49574, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:44564") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:49846->172.17.0.7:44564, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:2086") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:35726->172.17.0.7:2086, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:12877") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:48198->172.17.0.7:12877, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:40188") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:33936->172.17.0.7:40188, err= 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:34025") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:55888->172.17.0.7:34025, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:25045") 2025/12/24 02:28:50 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:35394->172.17.0.7:25045, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: Connecting to FTP server 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:21") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:52266->172.17.0.7:21, err= 2025/12/24 02:28:51 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:12464") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:42302->172.17.0.7:12464, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:47503") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:41742->172.17.0.7:47503, 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/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:31861") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:44496->172.17.0.7:31861, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:5724") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:48244->172.17.0.7:5724, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:54068") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:53734->172.17.0.7:54068, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:61904") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:59730->172.17.0.7:61904, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:50605") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:40508->172.17.0.7:50605, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:57938") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:60490->172.17.0.7:57938, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:17251") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:56560->172.17.0.7:17251, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:36139") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:38386->172.17.0.7:36139, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:49065") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:52344->172.17.0.7:49065, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:23875") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:52380->172.17.0.7:23875, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:20565") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:44528->172.17.0.7:20565, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:16311") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:56324->172.17.0.7:16311, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:46595") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:36606->172.17.0.7:46595, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:59691") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:38686->172.17.0.7:59691, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:50476") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:56234->172.17.0.7:50476, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:21628") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:60414->172.17.0.7:21628, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:18986") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:35658->172.17.0.7:18986, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/12/24 02:28:51 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/12/24 02:28:51 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/24 02:28:51 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:51 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:51 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:51 DEBUG : TestFTPProftpd: detected overridden config - adding "{xvORY}" suffix to name 2025/12/24 02:28:51 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:51 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:51 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21: Connecting to FTP server 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:21") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:52270->172.17.0.7:21, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:58412") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:53620->172.17.0.7:58412, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:2610") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:44050->172.17.0.7:2610, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:46860") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:52496->172.17.0.7:46860, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:17654") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:55668->172.17.0.7:17654, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:50639") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:57876->172.17.0.7:50639, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:41233") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:33452->172.17.0.7:41233, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:34656") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:49560->172.17.0.7:34656, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:25300") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:53904->172.17.0.7:25300, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:33085") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:51636->172.17.0.7:33085, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:56359") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:50208->172.17.0.7:56359, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:27903") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:38892->172.17.0.7:27903, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:34929") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:59872->172.17.0.7:34929, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:57635") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:49326->172.17.0.7:57635, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:39343") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:46672->172.17.0.7:39343, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:16897") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:32980->172.17.0.7:16897, 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/24 02:28:51 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-gamoguv9hicu/hello? sausage/êé" 2025/12/24 02:28:51 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/24 02:28:51 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:51 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:51 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:51 DEBUG : TestFTPProftpd: detected overridden config - adding "{xvORY}" suffix to name 2025/12/24 02:28:51 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:51 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:51 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: Connecting to FTP server 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:52274->172.17.0.7:21, err= 2025/12/24 02:28:51 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-gamoguv9hicu/hello? sausage/êé" to be canonical "TestFTPProftpd{xvORY}:rclone-test-gamoguv9hicu/hello? sausage/êé" 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:21635") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:34694->172.17.0.7:21635, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:5255") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:56322->172.17.0.7:5255, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: Connecting to FTP server 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:52290->172.17.0.7:21, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:62799") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:48484->172.17.0.7:62799, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:29634") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:56460->172.17.0.7:29634, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:29916") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:52114->172.17.0.7:29916, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:23328") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:50376->172.17.0.7:23328, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:38355") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:58976->172.17.0.7:38355, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:28220") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:60000->172.17.0.7:28220, err= 2025/12/24 02:28:51 DEBUG : Waiting for deletions to finish 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:10606") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:36864->172.17.0.7:10606, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:9587") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:60632->172.17.0.7:9587, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:21320") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:47100->172.17.0.7:21320, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:17954") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:40282->172.17.0.7:17954, err= 2025/12/24 02:28:51 INFO : a/b/c/d/e.txt: Deleted 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:22386") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:59228->172.17.0.7:22386, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:12983") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:48462->172.17.0.7:12983, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:54589") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:39770->172.17.0.7:54589, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: dial("tcp","172.17.0.7:29487") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé: > dial: conn=172.17.0.1:56886->172.17.0.7:29487, err= 2025/12/24 02:28:51 DEBUG : removing 1 level 4 directories 2025/12/24 02:28:51 INFO : a/b/c/d: Removing directory 2025/12/24 02:28:51 DEBUG : removing 1 level 3 directories 2025/12/24 02:28:51 INFO : a/b/c: Removing directory 2025/12/24 02:28:51 DEBUG : removing 1 level 2 directories 2025/12/24 02:28:51 INFO : a/b: Removing directory 2025/12/24 02:28:51 DEBUG : removing 1 level 1 directories 2025/12/24 02:28:51 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:23962") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:41364->172.17.0.7:23962, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:44043") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:49334->172.17.0.7:44043, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:5430") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:39416->172.17.0.7:5430, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:20331") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:54410->172.17.0.7:20331, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:29113") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:34640->172.17.0.7:29113, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:62344") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:54004->172.17.0.7:62344, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: Connecting to FTP server 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:21") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:52302->172.17.0.7:21, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:36559") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:51458->172.17.0.7:36559, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:27318") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:46210->172.17.0.7:27318, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:64229") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:34020->172.17.0.7:64229, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:61194") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:50036->172.17.0.7:61194, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:45875") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:32824->172.17.0.7:45875, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:21197") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:45974->172.17.0.7:21197, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:59410") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:33774->172.17.0.7:59410, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:5544") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:36800->172.17.0.7:5544, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:19260") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:41374->172.17.0.7:19260, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:16656") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:32810->172.17.0.7:16656, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:61162") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:35620->172.17.0.7:61162, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:5713") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:38222->172.17.0.7:5713, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:40471") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:36124->172.17.0.7:40471, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:25506") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:54884->172.17.0.7:25506, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:13416") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:56676->172.17.0.7:13416, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:18231") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:42474->172.17.0.7:18231, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:46104") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:33852->172.17.0.7:46104, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/12/24 02:28:51 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-raliyab7mewa" 2025/12/24 02:28:51 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/24 02:28:51 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:51 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:51 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:51 DEBUG : TestFTPProftpd: detected overridden config - adding "{xvORY}" suffix to name 2025/12/24 02:28:51 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:51 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:51 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: Connecting to FTP server 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: dial("tcp","172.17.0.7:21") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: > dial: conn=172.17.0.1:52306->172.17.0.7:21, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:54176") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:55828->172.17.0.7:54176, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: dial("tcp","172.17.0.7:26068") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: > dial: conn=172.17.0.1:48548->172.17.0.7:26068, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: dial("tcp","172.17.0.7:49061") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: > dial: conn=172.17.0.1:40586->172.17.0.7:49061, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: dial("tcp","172.17.0.7:47833") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: > dial: conn=172.17.0.1:57036->172.17.0.7:47833, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: dial("tcp","172.17.0.7:53659") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: > dial: conn=172.17.0.1:50634->172.17.0.7:53659, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: dial("tcp","172.17.0.7:21559") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: > dial: conn=172.17.0.1:34816->172.17.0.7:21559, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: dial("tcp","172.17.0.7:11669") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: > dial: conn=172.17.0.1:45278->172.17.0.7:11669, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: dial("tcp","172.17.0.7:1512") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: > dial: conn=172.17.0.1:57932->172.17.0.7:1512, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:61076") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:50796->172.17.0.7:61076, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:41901") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:45430->172.17.0.7:41901, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:31379") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:37962->172.17.0.7:31379, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:59742") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:44360->172.17.0.7:59742, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:47690") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:38410->172.17.0.7:47690, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: dial("tcp","172.17.0.7:4322") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: > dial: conn=172.17.0.1:57760->172.17.0.7:4322, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: dial("tcp","172.17.0.7:54506") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: > dial: conn=172.17.0.1:55288->172.17.0.7:54506, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: dial("tcp","172.17.0.7:31731") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: > dial: conn=172.17.0.1:42076->172.17.0.7:31731, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: dial("tcp","172.17.0.7:65055") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: > dial: conn=172.17.0.1:46184->172.17.0.7:65055, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: Purge dir "new_name" 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-raliyab7mewa: 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/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:38630") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:36928->172.17.0.7:38630, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:24669") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:40834->172.17.0.7:24669, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:47211") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:36832->172.17.0.7:47211, err= 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:42402") 2025/12/24 02:28:51 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:59028->172.17.0.7:42402, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:65352") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:34792->172.17.0.7:65352, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:48010") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:51500->172.17.0.7:48010, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:32794") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:38406->172.17.0.7:32794, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:18100") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:38982->172.17.0.7:18100, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:17131") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:51816->172.17.0.7:17131, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/12/24 02:28:52 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-gamoguv9hicu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/12/24 02:28:52 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/24 02:28:52 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:52 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:52 DEBUG : TestFTPProftpd: detected overridden config - adding "{xvORY}" suffix to name 2025/12/24 02:28:52 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:52 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.7:21") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:52322->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.7:11967") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:47984->172.17.0.7:11967, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/12/24 02:28:52 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-gamoguv9hicu/not found.txt" 2025/12/24 02:28:52 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/24 02:28:52 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:52 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:52 DEBUG : TestFTPProftpd: detected overridden config - adding "{xvORY}" suffix to name 2025/12/24 02:28:52 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:52 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/not found.txt: Connecting to FTP server 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/not found.txt: dial("tcp","172.17.0.7:21") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/not found.txt: > dial: conn=172.17.0.1:52332->172.17.0.7:21, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/not found.txt: dial("tcp","172.17.0.7:60198") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/not found.txt: > dial: conn=172.17.0.1:52122->172.17.0.7:60198, err= 2025/12/24 02:28:52 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-gamoguv9hicu" from "TestFTPProftpd:rclone-test-gamoguv9hicu" 2025/12/24 02:28:52 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/12/24 02:28:52 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/24 02:28:52 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:52 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:52 DEBUG : TestFTPProftpd: detected overridden config - adding "{xvORY}" suffix to name 2025/12/24 02:28:52 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:52 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: Connecting to FTP server 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:21") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:52336->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:55469") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:39660->172.17.0.7:55469, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:50385") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:46888->172.17.0.7:50385, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:25795") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:41022->172.17.0.7:25795, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:40610") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:53032->172.17.0.7:40610, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:19937") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:49832->172.17.0.7:19937, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:50929") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:52982->172.17.0.7:50929, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:4919") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:58310->172.17.0.7:4919, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:16371") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:46782->172.17.0.7:16371, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:53743") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:35542->172.17.0.7:53743, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:19353") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:41950->172.17.0.7:19353, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:13383") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:39742->172.17.0.7:13383, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:53388") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:34920->172.17.0.7:53388, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:24278") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:52696->172.17.0.7:24278, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:2749") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:35898->172.17.0.7:2749, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:36709") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:32904->172.17.0.7:36709, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:22613") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:33448->172.17.0.7:22613, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:42049") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:47056->172.17.0.7:42049, 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/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:44815") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:46490->172.17.0.7:44815, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:57071") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:60422->172.17.0.7:57071, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:51367") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:49298->172.17.0.7:51367, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:50162") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:54478->172.17.0.7:50162, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:41820") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:55064->172.17.0.7:41820, 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/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:9155") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:38226->172.17.0.7:9155, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:7956") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:45334->172.17.0.7:7956, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/12/24 02:28:52 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-gamoguv9hicu" 2025/12/24 02:28:52 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/24 02:28:52 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:52 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:52 DEBUG : TestFTPProftpd: detected overridden config - adding "{PPNhG}" suffix to name 2025/12/24 02:28:52 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:52 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: Connecting to FTP server 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:21") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:52350->172.17.0.7:21, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:6570") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:49866->172.17.0.7:6570, 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/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:64697") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:56460->172.17.0.7:64697, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:48386") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:50642->172.17.0.7:48386, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:19439") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:55788->172.17.0.7:19439, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/12/24 02:28:52 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-gamoguv9hicu/deeper/nonexisting/directory" 2025/12/24 02:28:52 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/24 02:28:52 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:52 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:52 DEBUG : TestFTPProftpd: detected overridden config - adding "{xvORY}" suffix to name 2025/12/24 02:28:52 DEBUG : Setting host="172.17.0.7" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/24 02:28:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/24 02:28:52 DEBUG : Setting pass="I6JGrprwV7XI3X5-z1nr-houQ7oRHmMdW_Yzz3_9-Q-Irw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/24 02:28:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/deeper/nonexisting/directory: Connecting to FTP server 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/deeper/nonexisting/directory: dial("tcp","172.17.0.7:21") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:52358->172.17.0.7: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/24 02:28:52 DEBUG : Waiting for deletions to finish 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:44253") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:46794->172.17.0.7:44253, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:19557") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:60438->172.17.0.7:19557, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:22958") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:57498->172.17.0.7:22958, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:64567") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:54058->172.17.0.7:64567, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:23529") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:56488->172.17.0.7:23529, err= 2025/12/24 02:28:52 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:57758") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:54178->172.17.0.7:57758, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:58658") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:50056->172.17.0.7:58658, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:35431") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:56752->172.17.0.7:35431, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:61907") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:55552->172.17.0.7:61907, err= 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:22994") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:55658->172.17.0.7:22994, err= 2025/12/24 02:28:52 DEBUG : removing 1 level 4 directories 2025/12/24 02:28:52 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/12/24 02:28:52 DEBUG : removing 1 level 3 directories 2025/12/24 02:28:52 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/12/24 02:28:52 DEBUG : removing 1 level 2 directories 2025/12/24 02:28:52 INFO : hello? sausage/êé: Removing directory 2025/12/24 02:28:52 DEBUG : removing 1 level 1 directories 2025/12/24 02:28:52 INFO : hello? sausage: Removing directory 2025/12/24 02:28:52 DEBUG : removing 1 level 0 directories 2025/12/24 02:28:52 INFO : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: Removing directory 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:36267") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:54348->172.17.0.7:36267, err= 2025/12/24 02:28:52 ERROR : error listing: directory not found 2025/12/24 02:28:52 DEBUG : Waiting for deletions to finish 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:27225") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:40306->172.17.0.7:27225, err= 2025/12/24 02:28:52 ERROR : error listing: directory not found 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: dial("tcp","172.17.0.7:39837") 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: > dial: conn=172.17.0.1:57108->172.17.0.7:39837, err= 2025/12/24 02:28:52 ERROR : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: Failed to list "": directory not found 2025/12/24 02:28:52 DEBUG : removing 1 level 0 directories 2025/12/24 02:28:52 INFO : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: Removing directory 2025/12/24 02:28:52 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/12/24 02:28:52 DEBUG : ftp://172.17.0.7:21/rclone-test-gamoguv9hicu: closing 2 unused connections 2025/12/24 02:28:52 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.48s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.16s) --- 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.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.01s) --- 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.05s) --- 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.05s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.74s) --- 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.770s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 4.457249701s (try 1/5)