"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestCommandEncodingNeutralisesCRLF --- PASS: TestCommandEncodingNeutralisesCRLF (0.00s) === RUN TestIntegration fstests.go:464: Using remote "TestFTPProftpd:" 2026/10/08 01:07:48 NOTICE: TestFTPProftpd: Starting server 2026/10/08 01:07:50 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.4:21" try 1/100 2026/10/08 01:07:50 DEBUG : TestFTPProftpd: Read 1, error: 2026/10/08 01:07:50 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.4:21" 2026/10/08 01:07:50 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-keviteq3dage" 2026/10/08 01:07:50 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/10/08 01:07:50 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/08 01:07:50 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:50 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:50 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:50 DEBUG : TestFTPProftpd: detected overridden config - adding "{xki--}" suffix to name 2026/10/08 01:07:50 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:50 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:50 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: Connecting to FTP server 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:21") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:40120->172.17.0.4:21, err= 2026/10/08 01:07:50 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:505: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:533: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:32487") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:54062->172.17.0.4:32487, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:23828") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:56054->172.17.0.4:23828, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/10/08 01:07:50 INFO : dir/subdir: Making directory 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:53628") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:59214->172.17.0.4:53628, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:12153") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:36426->172.17.0.4:12153, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:59317") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:36462->172.17.0.4:59317, err= 2026/10/08 01:07:50 INFO : dir/subdir: Removing directory 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:42992") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:43396->172.17.0.4:42992, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:35637") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:50416->172.17.0.4:35637, err= 2026/10/08 01:07:50 INFO : dir: Removing directory 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:20440") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:51372->172.17.0.4:20440, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:38500") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:50410->172.17.0.4:38500, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:26503") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:60066->172.17.0.4:26503, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:47995") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:33894->172.17.0.4:47995, err= 2026/10/08 01:07:50 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:65418") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:36164->172.17.0.4:65418, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:734: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:63881") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:52416->172.17.0.4:63881, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:11717") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:56192->172.17.0.4:11717, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:50702") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:60342->172.17.0.4:50702, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:29502") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:46170->172.17.0.4:29502, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:734: testing "." 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:4417") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:54116->172.17.0.4:4417, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:27654") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:60278->172.17.0.4:27654, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:60993") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:40260->172.17.0.4:60993, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:45068") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:56818->172.17.0.4:45068, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:734: testing ".." 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:12173") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:39648->172.17.0.4:12173, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:4627") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:58468->172.17.0.4:4627, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:23293") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:45888->172.17.0.4:23293, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:55811") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:56538->172.17.0.4:55811, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:734: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:7894") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:44188->172.17.0.4:7894, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:33605") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:48586->172.17.0.4:33605, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:63916") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:33078->172.17.0.4:63916, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:47236") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:46472->172.17.0.4:47236, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:734: testing " leading space" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:26526") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:60758->172.17.0.4:26526, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:61249") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:51274->172.17.0.4:61249, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:36065") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:56904->172.17.0.4:36065, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:57989") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:50086->172.17.0.4:57989, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:734: testing "~leading tilde" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:19543") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:49454->172.17.0.4:19543, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:24158") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:56122->172.17.0.4:24158, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:4608") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:38208->172.17.0.4:4608, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:13325") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:50718->172.17.0.4:13325, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:734: testing "␍leading CR" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:1616") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:43732->172.17.0.4:1616, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:39222") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:47890->172.17.0.4:39222, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:32742") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:39196->172.17.0.4:32742, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:39092") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:41118->172.17.0.4:39092, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:734: testing "␊leading LF" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:64701") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:35910->172.17.0.4:64701, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:15202") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:51110->172.17.0.4:15202, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:38975") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:32904->172.17.0.4:38975, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:63048") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:43756->172.17.0.4:63048, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:734: testing "␉leading HT" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:25896") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:40454->172.17.0.4:25896, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:24143") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:44044->172.17.0.4:24143, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:27015") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:47832->172.17.0.4:27015, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:29290") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:48654->172.17.0.4:29290, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:734: testing "␋leading VT" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:50774") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:43164->172.17.0.4:50774, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:22473") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:59010->172.17.0.4:22473, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:8824") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:55176->172.17.0.4:8824, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:61923") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:48034->172.17.0.4:61923, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:734: testing ".leading dot" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:26076") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:41366->172.17.0.4:26076, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:31093") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:38326->172.17.0.4:31093, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:52200") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:44490->172.17.0.4:52200, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:32947") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:58750->172.17.0.4:32947, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:734: testing "trailing space " 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:63675") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:40414->172.17.0.4:63675, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:50582") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:49436->172.17.0.4:50582, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:14649") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:36520->172.17.0.4:14649, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:24667") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:54686->172.17.0.4:24667, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:734: testing "trailing CR␍" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:46296") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:59132->172.17.0.4:46296, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:49691") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:55560->172.17.0.4:49691, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:17122") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:60120->172.17.0.4:17122, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:64815") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:52308->172.17.0.4:64815, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:734: testing "trailing LF␊" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:8315") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:43434->172.17.0.4:8315, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:20706") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:55564->172.17.0.4:20706, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:12606") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:51008->172.17.0.4:12606, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:8907") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:50020->172.17.0.4:8907, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:734: testing "trailing HT␉" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:58904") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:53732->172.17.0.4:58904, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:44324") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:52804->172.17.0.4:44324, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:46976") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:50092->172.17.0.4:46976, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:58071") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:44448->172.17.0.4:58071, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:734: testing "trailing VT␋" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:58503") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:37664->172.17.0.4:58503, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:20416") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:37426->172.17.0.4:20416, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:55584") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:60360->172.17.0.4:55584, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:18865") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:55858->172.17.0.4:18865, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:734: testing "trailing dot." 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:43536") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:42032->172.17.0.4:43536, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:17065") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:44482->172.17.0.4:17065, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:47131") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:52868->172.17.0.4:47131, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:28775") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:56024->172.17.0.4:28775, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:734: testing "invalid utf-8\xfe" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:38514") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:59084->172.17.0.4:38514, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:54931") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:59234->172.17.0.4:54931, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:25164") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:60004->172.17.0.4:25164, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:63567") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:53044->172.17.0.4:63567, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:734: testing "test%46.txt" 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:20490") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:32982->172.17.0.4:20490, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:11830") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:59542->172.17.0.4:11830, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:30980") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:45296->172.17.0.4:30980, err= 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:18631") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:43900->172.17.0.4:18631, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:61388") 2026/10/08 01:07:50 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:58520->172.17.0.4:61388, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: Connecting to FTP server 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:21") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:55714->172.17.0.4:21, err= 2026/10/08 01:07:51 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:8238") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:41852->172.17.0.4:8238, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:10740") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:55754->172.17.0.4:10740, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:813: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:846: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:899: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:46001") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:36584->172.17.0.4:46001, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:45840") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:41580->172.17.0.4:45840, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:29370") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:37498->172.17.0.4:29370, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:57938") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:45960->172.17.0.4:57938, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:12776") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:43410->172.17.0.4:12776, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:59410") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:49786->172.17.0.4:59410, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:38884") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:46974->172.17.0.4:38884, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:58146") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:35558->172.17.0.4:58146, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:50092") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:57144->172.17.0.4:50092, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:31152") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:59368->172.17.0.4:31152, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:12741") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:56358->172.17.0.4:12741, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:29262") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:55536->172.17.0.4:29262, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:35755") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:34168->172.17.0.4:35755, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:56929") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:50110->172.17.0.4:56929, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:56357") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:45230->172.17.0.4:56357, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:60708") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:33354->172.17.0.4:60708, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:46180") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:48754->172.17.0.4:46180, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/10/08 01:07:51 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/10/08 01:07:51 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/08 01:07:51 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:51 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:51 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:51 DEBUG : TestFTPProftpd: detected overridden config - adding "{xki--}" suffix to name 2026/10/08 01:07:51 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:51 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:51 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:55718->172.17.0.4:21, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:23809") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:57404->172.17.0.4:23809, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:15553") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:44350->172.17.0.4:15553, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:27787") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:54142->172.17.0.4:27787, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:37094") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:34798->172.17.0.4:37094, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:29652") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:60794->172.17.0.4:29652, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:425: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:13196") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:45472->172.17.0.4:13196, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:14932") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:52552->172.17.0.4:14932, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:1357") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:60108->172.17.0.4:1357, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:44138") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:48934->172.17.0.4:44138, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:18076") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:44868->172.17.0.4:18076, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1152: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:9003") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:42046->172.17.0.4:9003, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:8348") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:37556->172.17.0.4:8348, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:5799") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:57248->172.17.0.4:5799, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:16217") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:53698->172.17.0.4:16217, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:18064") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:34098->172.17.0.4:18064, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1184: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1221: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/10/08 01:07:51 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-keviteq3dage/hello? sausage/êé" 2026/10/08 01:07:51 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/08 01:07:51 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:51 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:51 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:51 DEBUG : TestFTPProftpd: detected overridden config - adding "{xki--}" suffix to name 2026/10/08 01:07:51 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:51 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:51 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: Connecting to FTP server 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:55732->172.17.0.4:21, err= 2026/10/08 01:07:51 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-keviteq3dage/hello? sausage/êé" to be canonical "TestFTPProftpd{xki--}:rclone-test-keviteq3dage/hello? sausage/êé" 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:23191") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:41804->172.17.0.4:23191, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:56583") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:51846->172.17.0.4:56583, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: Connecting to FTP server 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:55736->172.17.0.4:21, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:8142") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:47544->172.17.0.4:8142, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:64172") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:47962->172.17.0.4:64172, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:8821") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:52020->172.17.0.4:8821, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:13817") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:42988->172.17.0.4:13817, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:39754") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:45208->172.17.0.4:39754, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:40482") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:47904->172.17.0.4:40482, err= 2026/10/08 01:07:51 DEBUG : Waiting for deletions to finish 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:13410") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:54854->172.17.0.4:13410, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:17041") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:42530->172.17.0.4:17041, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:42243") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:44740->172.17.0.4:42243, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:59642") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:44008->172.17.0.4:59642, err= 2026/10/08 01:07:51 INFO : a/b/c/d/e.txt: Deleted 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:44821") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:33686->172.17.0.4:44821, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:19627") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:50170->172.17.0.4:19627, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:41118") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:49874->172.17.0.4:41118, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: dial("tcp","172.17.0.4:2535") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé: > dial: conn=172.17.0.1:52524->172.17.0.4:2535, err= 2026/10/08 01:07:51 DEBUG : removing 1 level 4 directories 2026/10/08 01:07:51 INFO : a/b/c/d: Removing directory 2026/10/08 01:07:51 DEBUG : removing 1 level 3 directories 2026/10/08 01:07:51 INFO : a/b/c: Removing directory 2026/10/08 01:07:51 DEBUG : removing 1 level 2 directories 2026/10/08 01:07:51 INFO : a/b: Removing directory 2026/10/08 01:07:51 DEBUG : removing 1 level 1 directories 2026/10/08 01:07:51 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1285: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:50776") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:54408->172.17.0.4:50776, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:61034") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:54172->172.17.0.4:61034, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:46410") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:35372->172.17.0.4:46410, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:43180") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:36804->172.17.0.4:43180, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:8276") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:53032->172.17.0.4:8276, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:40286") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:59466->172.17.0.4:40286, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: Connecting to FTP server 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:21") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:55746->172.17.0.4:21, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:16529") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:44502->172.17.0.4:16529, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:23973") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:47462->172.17.0.4:23973, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:65398") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:33734->172.17.0.4:65398, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:47024") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:55048->172.17.0.4:47024, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:24843") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:50072->172.17.0.4:24843, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:60972") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:49180->172.17.0.4:60972, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:58850") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:46658") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:53154->172.17.0.4:46658, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:42670->172.17.0.4:58850, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:12605") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:52440->172.17.0.4:12605, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:10929") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:52350->172.17.0.4:10929, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:53082") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:35952->172.17.0.4:53082, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:38640") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:55638->172.17.0.4:38640, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:16878") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:22457") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:59958->172.17.0.4:22457, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:54498->172.17.0.4:16878, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:1389") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:41898->172.17.0.4:1389, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:4000") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:60958->172.17.0.4:4000, err= 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:41725") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:38250->172.17.0.4:41725, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1437: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/10/08 01:07:51 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-vaxuhoh9lubu" 2026/10/08 01:07:51 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/08 01:07:51 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:51 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:51 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:51 DEBUG : TestFTPProftpd: detected overridden config - adding "{xki--}" suffix to name 2026/10/08 01:07:51 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:51 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:51 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: Connecting to FTP server 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: dial("tcp","172.17.0.4:21") 2026/10/08 01:07:51 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: > dial: conn=172.17.0.1:55754->172.17.0.4:21, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:43904") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:47898->172.17.0.4:43904, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: dial("tcp","172.17.0.4:25929") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: > dial: conn=172.17.0.1:36538->172.17.0.4:25929, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: dial("tcp","172.17.0.4:64846") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: > dial: conn=172.17.0.1:38580->172.17.0.4:64846, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: dial("tcp","172.17.0.4:43942") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: > dial: conn=172.17.0.1:42832->172.17.0.4:43942, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: dial("tcp","172.17.0.4:63920") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: > dial: conn=172.17.0.1:56352->172.17.0.4:63920, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: dial("tcp","172.17.0.4:53435") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: > dial: conn=172.17.0.1:57280->172.17.0.4:53435, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: dial("tcp","172.17.0.4:37161") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: > dial: conn=172.17.0.1:54112->172.17.0.4:37161, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: dial("tcp","172.17.0.4:22845") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: > dial: conn=172.17.0.1:39648->172.17.0.4:22845, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:35739") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:52496->172.17.0.4:35739, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:12052") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:51414->172.17.0.4:12052, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:18621") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:60462->172.17.0.4:18621, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:49156") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:49510->172.17.0.4:49156, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:17817") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:36822->172.17.0.4:17817, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: dial("tcp","172.17.0.4:7220") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: > dial: conn=172.17.0.1:58346->172.17.0.4:7220, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: dial("tcp","172.17.0.4:61865") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: > dial: conn=172.17.0.1:37420->172.17.0.4:61865, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: dial("tcp","172.17.0.4:38848") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: > dial: conn=172.17.0.1:36596->172.17.0.4:38848, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: dial("tcp","172.17.0.4:42705") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: > dial: conn=172.17.0.1:49968->172.17.0.4:42705, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: Purge dir "new_name" 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-vaxuhoh9lubu: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1633: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1664: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1735: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:4733") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:45004->172.17.0.4:4733, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:51082") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:47952->172.17.0.4:51082, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:6299") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:55260->172.17.0.4:6299, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:58433") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:37118->172.17.0.4:58433, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:64455") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:46624->172.17.0.4:64455, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:38816") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:33910->172.17.0.4:38816, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:20715") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:51076->172.17.0.4:20715, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:22551") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:58332->172.17.0.4:22551, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:50988") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:43058->172.17.0.4:50988, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:50528") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:39076->172.17.0.4:50528, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:34624") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:50168->172.17.0.4:34624, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:35426") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:50238->172.17.0.4:35426, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:22884") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:44282->172.17.0.4:22884, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:29591") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:38314->172.17.0.4:29591, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:51676") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:50720->172.17.0.4:51676, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:30863") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:48242->172.17.0.4:30863, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/10/08 01:07:52 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-keviteq3dage/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/10/08 01:07:52 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/08 01:07:52 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:52 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:52 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:52 DEBUG : TestFTPProftpd: detected overridden config - adding "{xki--}" suffix to name 2026/10/08 01:07:52 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:52 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:52 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:55758->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:33274") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:35846->172.17.0.4:33274, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/10/08 01:07:52 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-keviteq3dage/not found.txt" 2026/10/08 01:07:52 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/08 01:07:52 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:52 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:52 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:52 DEBUG : TestFTPProftpd: detected overridden config - adding "{xki--}" suffix to name 2026/10/08 01:07:52 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:52 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:52 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/not found.txt: Connecting to FTP server 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/not found.txt: dial("tcp","172.17.0.4:21") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/not found.txt: > dial: conn=172.17.0.1:55764->172.17.0.4:21, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/not found.txt: dial("tcp","172.17.0.4:34148") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/not found.txt: > dial: conn=172.17.0.1:43936->172.17.0.4:34148, err= 2026/10/08 01:07:52 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1994: Opening root remote "TestFTPProftpd:" path "rclone-test-keviteq3dage" from "TestFTPProftpd:rclone-test-keviteq3dage" 2026/10/08 01:07:52 DEBUG : Creating backend with remote "TestFTPProftpd:" 2026/10/08 01:07:52 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/08 01:07:52 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:52 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:52 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:52 DEBUG : TestFTPProftpd: detected overridden config - adding "{xki--}" suffix to name 2026/10/08 01:07:52 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:52 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:52 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:55774->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:13970") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:39452->172.17.0.4:13970, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:61607") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:35336->172.17.0.4:61607, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:20140") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:55706->172.17.0.4:20140, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:52506") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:55582->172.17.0.4:52506, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:7503") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:38412->172.17.0.4:7503, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:11713") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:38624->172.17.0.4:11713, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2031: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:46392") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:57184->172.17.0.4:46392, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:2730") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:51516->172.17.0.4:2730, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:16873") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:38180->172.17.0.4:16873, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35345") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56388->172.17.0.4:35345, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30853") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:36368->172.17.0.4:30853, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:6970") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:33184->172.17.0.4:6970, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:25594") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:60118->172.17.0.4:25594, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30126") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:43166->172.17.0.4:30126, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:11610") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:50086->172.17.0.4:11610, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:5216") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:57400->172.17.0.4:5216, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:34319") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:57538->172.17.0.4:34319, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2090: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:438: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2195: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2211: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:45930") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:53278->172.17.0.4:45930, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:36916") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:33596->172.17.0.4:36916, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:20042") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:45396->172.17.0.4:20042, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:56451") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:54146->172.17.0.4:56451, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:54704") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:59812->172.17.0.4:54704, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2367: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:38618") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:49058->172.17.0.4:38618, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:46057") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:40198->172.17.0.4:46057, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/10/08 01:07:52 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-keviteq3dage" 2026/10/08 01:07:52 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/08 01:07:52 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:52 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:52 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:52 DEBUG : TestFTPProftpd: detected overridden config - adding "{viJg4}" suffix to name 2026/10/08 01:07:52 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:52 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:52 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: Connecting to FTP server 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:21") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:55782->172.17.0.4:21, err= 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:14631") 2026/10/08 01:07:52 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:55618->172.17.0.4:14631, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2452: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutRetry === RUN TestIntegration/FsMkdir/FsPutRetry/Simple === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:44800") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:60436->172.17.0.4:44800, err= fstests.go:2655: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:53956") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:48162->172.17.0.4:53956, err= fstests.go:2655: no upload request could be faulted === RUN TestIntegration/FsMkdir/FsPutRetry/Chunked fstests.go:2697: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:63181") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:60650->172.17.0.4:63181, err= === RUN TestIntegration/FsMkdir/FsPutShortEOF/Chunked fstests.go:2828: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2870: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:41693") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:41070->172.17.0.4:41693, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:41557") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:50438->172.17.0.4:41557, err= 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:18170") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:45284->172.17.0.4:18170, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/10/08 01:07:53 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-keviteq3dage/deeper/nonexisting/directory" 2026/10/08 01:07:53 DEBUG : Setting type=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2026/10/08 01:07:53 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:53 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:53 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:53 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:53 DEBUG : TestFTPProftpd: detected overridden config - adding "{xki--}" suffix to name 2026/10/08 01:07:53 DEBUG : Setting host=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2026/10/08 01:07:53 DEBUG : Setting user=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2026/10/08 01:07:53 DEBUG : Setting pass=XXX for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2026/10/08 01:07:53 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/deeper/nonexisting/directory: Connecting to FTP server 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage/deeper/nonexisting/directory: > dial: conn=172.17.0.1:55792->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:3019: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:3062: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:3119: FS has no Directory methods and doesn't Wrap 2026/10/08 01:07:53 DEBUG : Waiting for deletions to finish 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:34832") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:57068->172.17.0.4:34832, err= 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:12664") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:54310->172.17.0.4:12664, err= 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:19338") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:51740->172.17.0.4:19338, err= 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:23775") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:46128->172.17.0.4:23775, err= 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:48809") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:38516->172.17.0.4:48809, err= 2026/10/08 01:07:53 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:11187") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:55648->172.17.0.4:11187, err= 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:9583") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:44476->172.17.0.4:9583, err= 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:43859") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:56304->172.17.0.4:43859, err= 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:34844") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:56396->172.17.0.4:34844, err= 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:19018") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:42536->172.17.0.4:19018, err= 2026/10/08 01:07:53 DEBUG : removing 1 level 4 directories 2026/10/08 01:07:53 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/10/08 01:07:53 DEBUG : removing 1 level 3 directories 2026/10/08 01:07:53 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/10/08 01:07:53 DEBUG : removing 1 level 2 directories 2026/10/08 01:07:53 INFO : hello? sausage/êé: Removing directory 2026/10/08 01:07:53 DEBUG : removing 1 level 1 directories 2026/10/08 01:07:53 INFO : hello? sausage: Removing directory 2026/10/08 01:07:53 DEBUG : removing 1 level 0 directories 2026/10/08 01:07:53 INFO : ftp://172.17.0.4:21/rclone-test-keviteq3dage: Removing directory 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:20193") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:49500->172.17.0.4:20193, err= 2026/10/08 01:07:53 ERROR : error listing: directory not found 2026/10/08 01:07:53 DEBUG : Waiting for deletions to finish 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:48673") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:44298->172.17.0.4:48673, err= 2026/10/08 01:07:53 ERROR : error listing: directory not found 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: dial("tcp","172.17.0.4:2298") 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: > dial: conn=172.17.0.1:34708->172.17.0.4:2298, err= 2026/10/08 01:07:53 ERROR : ftp://172.17.0.4:21/rclone-test-keviteq3dage: Failed to list "": directory not found 2026/10/08 01:07:53 DEBUG : removing 1 level 0 directories 2026/10/08 01:07:53 INFO : ftp://172.17.0.4:21/rclone-test-keviteq3dage: Removing directory 2026/10/08 01:07:53 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/10/08 01:07:53 DEBUG : ftp://172.17.0.4:21/rclone-test-keviteq3dage: closing 2 unused connections 2026/10/08 01:07:53 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (5.07s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.00s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (3.62s) --- 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.31s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.03s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.03s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.02s) --- 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 (2.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.11s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.11s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (0.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.03s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (1.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (1.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutRetry (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Simple/NetError (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Chunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Simple (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutShortEOF/Chunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.02s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.02s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.03s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 5.120s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 8.433246294s (try 1/5)