"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/10/27 01:01:51 NOTICE: TestFTPProftpd: Stopping server 2025/10/27 01:01:52 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 2/10 2025/10/27 01:01:52 NOTICE: TestFTPProftpd: Stopping server 2025/10/27 01:01:53 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 3/10 2025/10/27 01:01:53 NOTICE: TestFTPProftpd: Stopping server 2025/10/27 01:01:54 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 4/10 2025/10/27 01:01:54 NOTICE: TestFTPProftpd: Stopping server 2025/10/27 01:01:55 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 5/10 2025/10/27 01:01:55 NOTICE: TestFTPProftpd: Stopping server 2025/10/27 01:01:56 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 6/10 2025/10/27 01:01:56 NOTICE: TestFTPProftpd: Stopping server 2025/10/27 01:01:57 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 7/10 2025/10/27 01:01:57 NOTICE: TestFTPProftpd: Stopping server 2025/10/27 01:01:58 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 8/10 2025/10/27 01:01:59 NOTICE: TestFTPProftpd: Stopping server 2025/10/27 01:02:00 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 9/10 2025/10/27 01:02:00 NOTICE: TestFTPProftpd: Stopping server 2025/10/27 01:02:01 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 10/10 2025/10/27 01:02:01 NOTICE: TestFTPProftpd: Stopping server 2025/10/27 01:02:01 NOTICE: TestFTPProftpd: Starting server 2025/10/27 01:02:02 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.3:21" try 1/100 2025/10/27 01:02:02 DEBUG : TestFTPProftpd: Read 1, error: 2025/10/27 01:02:02 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.3:21" 2025/10/27 01:02:02 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pepovef6gava" 2025/10/27 01:02:02 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/27 01:02:02 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/27 01:02:02 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:02 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:02 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:02 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Yy1l}" suffix to name 2025/10/27 01:02:02 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:02 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:02 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: Connecting to FTP server 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:21") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:49962->172.17.0.3:21, err= 2025/10/27 01:02:02 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:30635") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:55172->172.17.0.3:30635, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:15483") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:41382->172.17.0.3:15483, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/10/27 01:02:02 INFO : dir/subdir: Making directory 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:52067") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:43718->172.17.0.3:52067, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:13449") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:41922->172.17.0.3:13449, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:23999") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:33060->172.17.0.3:23999, err= 2025/10/27 01:02:02 INFO : dir/subdir: Removing directory 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:4601") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:54744->172.17.0.3:4601, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:17408") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:37070->172.17.0.3:17408, err= 2025/10/27 01:02:02 INFO : dir: Removing directory 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:7732") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:43792->172.17.0.3:7732, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:38240") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:42692->172.17.0.3:38240, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:56264") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:50268->172.17.0.3:56264, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:49851") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:58856->172.17.0.3:49851, err= 2025/10/27 01:02:02 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:38977") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:48160->172.17.0.3:38977, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:1549") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:40540->172.17.0.3:1549, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:41032") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:55092->172.17.0.3:41032, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:52220") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:37762->172.17.0.3:52220, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:6978") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:39756->172.17.0.3:6978, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:2580") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:60234->172.17.0.3:2580, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:11810") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:34938->172.17.0.3:11810, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:24165") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:40186->172.17.0.3:24165, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:15632") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:54984->172.17.0.3:15632, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:5214") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:42702->172.17.0.3:5214, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:13725") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:51100->172.17.0.3:13725, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:7920") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:51562->172.17.0.3:7920, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:41785") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:46378->172.17.0.3:41785, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:65499") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:44994->172.17.0.3:65499, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:9846") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:43370->172.17.0.3:9846, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:26675") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:51274->172.17.0.3:26675, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:33458") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:40400->172.17.0.3:33458, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:9773") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:46948->172.17.0.3:9773, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:55619") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:36794->172.17.0.3:55619, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:61514") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:33888->172.17.0.3:61514, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:39385") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:57060->172.17.0.3:39385, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:5568") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:48730->172.17.0.3:5568, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:48046") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:34028->172.17.0.3:48046, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:51810") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:36640->172.17.0.3:51810, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:28543") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:56124->172.17.0.3:28543, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:51624") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:47870->172.17.0.3:51624, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:3684") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:36544->172.17.0.3:3684, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:35251") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:55736->172.17.0.3:35251, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:24329") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:48898->172.17.0.3:24329, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:58925") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:47022->172.17.0.3:58925, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:19568") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:35340->172.17.0.3:19568, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:62283") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:58054->172.17.0.3:62283, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:59450") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:34970->172.17.0.3:59450, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:59576") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:60772->172.17.0.3:59576, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:48969") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:39734->172.17.0.3:48969, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:65405") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:59768->172.17.0.3:65405, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:61133") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:33296->172.17.0.3:61133, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:59756") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:38156->172.17.0.3:59756, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:24036") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:40380->172.17.0.3:24036, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:11230") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:41546->172.17.0.3:11230, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:63946") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:58640->172.17.0.3:63946, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:36737") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:56292->172.17.0.3:36737, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:18127") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:33862->172.17.0.3:18127, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:40196") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:56546->172.17.0.3:40196, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:36702") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:39734->172.17.0.3:36702, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:26949") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:50956->172.17.0.3:26949, err= 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:1337") 2025/10/27 01:02:02 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:52808->172.17.0.3:1337, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:4625") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:39180->172.17.0.3:4625, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:35699") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:37986->172.17.0.3:35699, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:55932") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:40166->172.17.0.3:55932, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:65115") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:35794->172.17.0.3:65115, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:9550") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:43358->172.17.0.3:9550, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:60476") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:39740->172.17.0.3:60476, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:47627") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:60350->172.17.0.3:47627, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:60337") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:46598->172.17.0.3:60337, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:23484") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:40386->172.17.0.3:23484, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:33716") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:40786->172.17.0.3:33716, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:62998") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:35632->172.17.0.3:62998, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:57712") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:50850->172.17.0.3:57712, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:57022") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:43092->172.17.0.3:57022, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:56388") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:48532->172.17.0.3:56388, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:11745") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:60602->172.17.0.3:11745, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:53770") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:56368->172.17.0.3:53770, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:50304") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:59476->172.17.0.3:50304, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:5786") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:47694->172.17.0.3:5786, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:37205") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:50914->172.17.0.3:37205, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:50175") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:40866->172.17.0.3:50175, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:1384") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:36612->172.17.0.3:1384, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:31427") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:50590->172.17.0.3:31427, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:8676") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:48102->172.17.0.3:8676, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:11591") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:49644->172.17.0.3:11591, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:29838") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:33442->172.17.0.3:29838, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:44390") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:44784->172.17.0.3:44390, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:28694") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:56178->172.17.0.3:28694, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:4500") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:50054->172.17.0.3:4500, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:15557") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:59938->172.17.0.3:15557, err= 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:54620") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:43756->172.17.0.3:54620, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:4813") 2025/10/27 01:02:03 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:60158->172.17.0.3:4813, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: Connecting to FTP server 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:21") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:49968->172.17.0.3:21, err= 2025/10/27 01:02:04 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:23961") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:51142->172.17.0.3:23961, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:22144") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:35992->172.17.0.3:22144, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:6029") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:58680->172.17.0.3:6029, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:46528") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:47882->172.17.0.3:46528, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:15777") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:60336->172.17.0.3:15777, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:43608") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:34230->172.17.0.3:43608, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:29800") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:39654->172.17.0.3:29800, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:14288") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:35690->172.17.0.3:14288, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:60118") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:43736->172.17.0.3:60118, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:29850") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:41782->172.17.0.3:29850, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:47499") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:38628->172.17.0.3:47499, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:5901") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:60296->172.17.0.3:5901, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:46938") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:41038->172.17.0.3:46938, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:42492") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:36470->172.17.0.3:42492, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:35930") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:37896->172.17.0.3:35930, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:64863") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:36988->172.17.0.3:64863, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:43652") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:51082->172.17.0.3:43652, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:49937") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:60262->172.17.0.3:49937, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:1784") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:37734->172.17.0.3:1784, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/10/27 01:02:04 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/10/27 01:02:04 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/27 01:02:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:04 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Yy1l}" suffix to name 2025/10/27 01:02:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:04 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:49970->172.17.0.3:21, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:19766") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:45600->172.17.0.3:19766, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:57278") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:56642->172.17.0.3:57278, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:4175") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:39424->172.17.0.3:4175, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:18602") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:46398->172.17.0.3:18602, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:64515") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:34576->172.17.0.3:64515, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:61873") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:59806->172.17.0.3:61873, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:2339") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:38750->172.17.0.3:2339, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:63481") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:39690->172.17.0.3:63481, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:9214") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:54214->172.17.0.3:9214, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:44623") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:35472->172.17.0.3:44623, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:51780") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:52320->172.17.0.3:51780, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:50123") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:42984->172.17.0.3:50123, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:50615") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:39696->172.17.0.3:50615, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:10206") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:38356->172.17.0.3:10206, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:6733") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:39718->172.17.0.3:6733, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1153: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1190: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/10/27 01:02:04 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pepovef6gava/hello? sausage/êé" 2025/10/27 01:02:04 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/27 01:02:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:04 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Yy1l}" suffix to name 2025/10/27 01:02:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:04 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: Connecting to FTP server 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:49984->172.17.0.3:21, err= 2025/10/27 01:02:04 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-pepovef6gava/hello? sausage/êé" to be canonical "TestFTPProftpd{4Yy1l}:rclone-test-pepovef6gava/hello? sausage/êé" 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:2151") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:37550->172.17.0.3:2151, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:51884") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:49130->172.17.0.3:51884, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: Connecting to FTP server 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:49994->172.17.0.3:21, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:13802") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:53534->172.17.0.3:13802, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:9422") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:39422->172.17.0.3:9422, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:55798") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:54534->172.17.0.3:55798, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:54006") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:54150->172.17.0.3:54006, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:62181") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:39646->172.17.0.3:62181, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:3257") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:41372->172.17.0.3:3257, err= 2025/10/27 01:02:04 DEBUG : Waiting for deletions to finish 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:12466") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:35702->172.17.0.3:12466, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:30885") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:40996->172.17.0.3:30885, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:20440") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:57330->172.17.0.3:20440, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:30844") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:53984->172.17.0.3:30844, err= 2025/10/27 01:02:04 INFO : a/b/c/d/e.txt: Deleted 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:59200") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:55772->172.17.0.3:59200, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:38281") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:60098->172.17.0.3:38281, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:22809") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:37110->172.17.0.3:22809, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: dial("tcp","172.17.0.3:36742") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé: > dial: conn=172.17.0.1:53796->172.17.0.3:36742, err= 2025/10/27 01:02:04 DEBUG : removing 1 level 4 directories 2025/10/27 01:02:04 INFO : a/b/c/d: Removing directory 2025/10/27 01:02:04 DEBUG : removing 1 level 3 directories 2025/10/27 01:02:04 INFO : a/b/c: Removing directory 2025/10/27 01:02:04 DEBUG : removing 1 level 2 directories 2025/10/27 01:02:04 INFO : a/b: Removing directory 2025/10/27 01:02:04 DEBUG : removing 1 level 1 directories 2025/10/27 01:02:04 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:55621") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:44720->172.17.0.3:55621, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:55711") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:33696->172.17.0.3:55711, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:21487") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:52888->172.17.0.3:21487, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:33694") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:43402->172.17.0.3:33694, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:19976") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:56220->172.17.0.3:19976, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:34751") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:54010->172.17.0.3:34751, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: Connecting to FTP server 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:21") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:28278") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:50008->172.17.0.3:21, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:47300->172.17.0.3:28278, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:48851") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:34038->172.17.0.3:48851, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:48802") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:43226->172.17.0.3:48802, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:53011") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:36096->172.17.0.3:53011, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:16716") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:42532->172.17.0.3:16716, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:35995") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:38916->172.17.0.3:35995, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:33155") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:53924->172.17.0.3:33155, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:62946") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:35872->172.17.0.3:62946, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:30205") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:41092->172.17.0.3:30205, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:63450") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:57178->172.17.0.3:63450, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:58185") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:38124->172.17.0.3:58185, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:40208") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:42956->172.17.0.3:40208, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:46742") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:55084->172.17.0.3:46742, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:3550") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:48752->172.17.0.3:3550, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:64975") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:48210->172.17.0.3:64975, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:29534") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:38458->172.17.0.3:29534, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:45473") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:46830->172.17.0.3:45473, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/10/27 01:02:04 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-wolutuv6kiri" 2025/10/27 01:02:04 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/27 01:02:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:04 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Yy1l}" suffix to name 2025/10/27 01:02:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:04 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: Connecting to FTP server 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: dial("tcp","172.17.0.3:21") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: > dial: conn=172.17.0.1:50018->172.17.0.3:21, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:36302") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:40604->172.17.0.3:36302, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: dial("tcp","172.17.0.3:9396") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: > dial: conn=172.17.0.1:55024->172.17.0.3:9396, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: dial("tcp","172.17.0.3:27626") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: > dial: conn=172.17.0.1:45092->172.17.0.3:27626, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: dial("tcp","172.17.0.3:53635") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: > dial: conn=172.17.0.1:41784->172.17.0.3:53635, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: dial("tcp","172.17.0.3:29905") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: > dial: conn=172.17.0.1:37912->172.17.0.3:29905, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: dial("tcp","172.17.0.3:34036") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: > dial: conn=172.17.0.1:55252->172.17.0.3:34036, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: dial("tcp","172.17.0.3:49528") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: > dial: conn=172.17.0.1:56590->172.17.0.3:49528, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: dial("tcp","172.17.0.3:57435") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: > dial: conn=172.17.0.1:37736->172.17.0.3:57435, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:25090") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:59964->172.17.0.3:25090, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:52464") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:39776->172.17.0.3:52464, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:14220") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:37664->172.17.0.3:14220, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:30295") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:42874->172.17.0.3:30295, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:41024") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:51748->172.17.0.3:41024, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: dial("tcp","172.17.0.3:37240") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: > dial: conn=172.17.0.1:38330->172.17.0.3:37240, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: dial("tcp","172.17.0.3:38193") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: > dial: conn=172.17.0.1:42912->172.17.0.3:38193, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: dial("tcp","172.17.0.3:35817") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: > dial: conn=172.17.0.1:43176->172.17.0.3:35817, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: dial("tcp","172.17.0.3:2238") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: > dial: conn=172.17.0.1:47918->172.17.0.3:2238, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: Purge dir "new_name" 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-wolutuv6kiri: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:28046") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:54968->172.17.0.3:28046, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:55615") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:44640->172.17.0.3:55615, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:47874") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:46484->172.17.0.3:47874, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:30519") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:50666->172.17.0.3:30519, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:27026") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:50298->172.17.0.3:27026, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:13765") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:35360->172.17.0.3:13765, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:64595") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:46730->172.17.0.3:64595, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:52914") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:46156->172.17.0.3:52914, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:53082") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:37518->172.17.0.3:53082, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/10/27 01:02:04 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pepovef6gava/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/10/27 01:02:04 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/27 01:02:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:04 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Yy1l}" suffix to name 2025/10/27 01:02:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:04 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:21") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:50026->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:34496") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:54130->172.17.0.3:34496, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/10/27 01:02:04 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pepovef6gava/not found.txt" 2025/10/27 01:02:04 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/27 01:02:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:04 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Yy1l}" suffix to name 2025/10/27 01:02:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:04 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/not found.txt: Connecting to FTP server 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/not found.txt: dial("tcp","172.17.0.3:21") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/not found.txt: > dial: conn=172.17.0.1:50042->172.17.0.3:21, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/not found.txt: dial("tcp","172.17.0.3:38777") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/not found.txt: > dial: conn=172.17.0.1:46480->172.17.0.3:38777, err= 2025/10/27 01:02:04 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-pepovef6gava" from "TestFTPProftpd:rclone-test-pepovef6gava" 2025/10/27 01:02:04 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/10/27 01:02:04 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/27 01:02:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:04 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Yy1l}" suffix to name 2025/10/27 01:02:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:04 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:50050->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:13034") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:41068->172.17.0.3:13034, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:31637") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:33444->172.17.0.3:31637, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:9290") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:42952->172.17.0.3:9290, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33509") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:34072->172.17.0.3:33509, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:36532") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:53768->172.17.0.3:36532, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:46446") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:49090->172.17.0.3:46446, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:31480") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:39446->172.17.0.3:31480, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:52047") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:38334->172.17.0.3:52047, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:43796") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:34936->172.17.0.3:43796, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:6063") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:45470->172.17.0.3:6063, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:3019") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:46850->172.17.0.3:3019, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:10107") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:53504->172.17.0.3:10107, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:52906") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:54848->172.17.0.3:52906, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:24114") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:40868->172.17.0.3:24114, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:53816") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:42166->172.17.0.3:53816, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:57067") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:36196->172.17.0.3:57067, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:19700") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:33608->172.17.0.3:19700, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2004: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2109: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:51954") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:48408->172.17.0.3:51954, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:14322") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:57422->172.17.0.3:14322, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:49189") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:44050->172.17.0.3:49189, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:12203") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:48250->172.17.0.3:12203, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:24972") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:49832->172.17.0.3:24972, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2281: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:60144") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:47062->172.17.0.3:60144, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:34086") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:37468->172.17.0.3:34086, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/10/27 01:02:04 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-pepovef6gava" 2025/10/27 01:02:04 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/27 01:02:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:04 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{LEjVY}" suffix to name 2025/10/27 01:02:04 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:04 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: Connecting to FTP server 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:21") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:50058->172.17.0.3:21, err= 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:3622") 2025/10/27 01:02:04 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:44534->172.17.0.3:3622, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2476: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:28278") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:47314->172.17.0.3:28278, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:11217") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:53292->172.17.0.3:11217, err= 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:34234") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:46716->172.17.0.3:34234, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/27 01:02:05 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pepovef6gava/deeper/nonexisting/directory" 2025/10/27 01:02:05 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/27 01:02:05 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:05 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{4Yy1l}" suffix to name 2025/10/27 01:02:05 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/27 01:02:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/27 01:02:05 DEBUG : Setting pass="pmZD3QY8-4gjkeD_IiHNarHEofi3tPZD_Hhh_hC2vZy-Kw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/27 01:02:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/deeper/nonexisting/directory: Connecting to FTP server 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/deeper/nonexisting/directory: dial("tcp","172.17.0.3:21") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava/deeper/nonexisting/directory: > dial: conn=172.17.0.1:50070->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/10/27 01:02:05 DEBUG : Waiting for deletions to finish 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:44732") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:43466->172.17.0.3:44732, err= 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:21625") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:40334->172.17.0.3:21625, err= 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:13358") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:39444->172.17.0.3:13358, err= 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:52311") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:57630->172.17.0.3:52311, err= 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:20400") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:46746->172.17.0.3:20400, err= 2025/10/27 01:02:05 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:27497") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:37626->172.17.0.3:27497, err= 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:50441") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:37998->172.17.0.3:50441, err= 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:42451") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:55892->172.17.0.3:42451, err= 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:3444") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:33796->172.17.0.3:3444, err= 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:31142") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:32824->172.17.0.3:31142, err= 2025/10/27 01:02:05 DEBUG : removing 1 level 4 directories 2025/10/27 01:02:05 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/10/27 01:02:05 DEBUG : removing 1 level 3 directories 2025/10/27 01:02:05 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/10/27 01:02:05 DEBUG : removing 1 level 2 directories 2025/10/27 01:02:05 INFO : hello? sausage/êé: Removing directory 2025/10/27 01:02:05 DEBUG : removing 1 level 1 directories 2025/10/27 01:02:05 INFO : hello? sausage: Removing directory 2025/10/27 01:02:05 DEBUG : removing 1 level 0 directories 2025/10/27 01:02:05 INFO : ftp://172.17.0.3:21/rclone-test-pepovef6gava: Removing directory 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:13529") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:48288->172.17.0.3:13529, err= 2025/10/27 01:02:05 ERROR : error listing: directory not found 2025/10/27 01:02:05 DEBUG : Waiting for deletions to finish 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:10576") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:58098->172.17.0.3:10576, err= 2025/10/27 01:02:05 ERROR : error listing: directory not found 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: dial("tcp","172.17.0.3:53848") 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: > dial: conn=172.17.0.1:57238->172.17.0.3:53848, err= 2025/10/27 01:02:05 ERROR : ftp://172.17.0.3:21/rclone-test-pepovef6gava: Failed to list "": directory not found 2025/10/27 01:02:05 DEBUG : removing 1 level 0 directories 2025/10/27 01:02:05 INFO : ftp://172.17.0.3:21/rclone-test-pepovef6gava: Removing directory 2025/10/27 01:02:05 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/10/27 01:02:05 DEBUG : ftp://172.17.0.3:21/rclone-test-pepovef6gava: closing 2 unused connections 2025/10/27 01:02:05 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (14.92s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.00s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (2.68s) --- 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.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 14.936s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 16.17937131s (try 1/5)