"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/08/22 02:39:50 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-duyequc2kuqu" 2025/08/22 02:39:50 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/08/22 02:39:50 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/08/22 02:39:50 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:50 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:50 DEBUG : TestFTPProftpd: detected overridden config - adding "{Op6rd}" suffix to name 2025/08/22 02:39:50 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:50 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:50 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:50 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: Connecting to FTP server 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:21") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:38598->172.17.0.2:21, err= 2025/08/22 02:39:50 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:3541") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:32986->172.17.0.2:3541, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:7571") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:49944->172.17.0.2:7571, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/08/22 02:39:50 INFO : dir/subdir: Making directory 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:8376") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:34526->172.17.0.2:8376, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:17125") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:33144->172.17.0.2:17125, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:4146") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:38042->172.17.0.2:4146, err= 2025/08/22 02:39:50 INFO : dir/subdir: Removing directory 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:40062") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:54514->172.17.0.2:40062, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:45127") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:54334->172.17.0.2:45127, err= 2025/08/22 02:39:50 INFO : dir: Removing directory 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:33355") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:53564->172.17.0.2:33355, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:39389") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:41478->172.17.0.2:39389, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:22607") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:47148->172.17.0.2:22607, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:64454") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:45118->172.17.0.2:64454, err= 2025/08/22 02:39:50 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:16953") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:60388->172.17.0.2:16953, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:32103") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:58562->172.17.0.2:32103, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:20457") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:42480->172.17.0.2:20457, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:8082") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:47508->172.17.0.2:8082, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:48763") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:56940->172.17.0.2:48763, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:60047") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:60280->172.17.0.2:60047, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:64222") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:39072->172.17.0.2:64222, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:57632") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:33524->172.17.0.2:57632, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:28598") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:57642->172.17.0.2:28598, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:41580") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:59042->172.17.0.2:41580, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:8442") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:56708->172.17.0.2:8442, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:27934") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:60840->172.17.0.2:27934, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:41971") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:33384->172.17.0.2:41971, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:27725") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:43208->172.17.0.2:27725, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:26609") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:60626->172.17.0.2:26609, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:60327") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:38596->172.17.0.2:60327, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:34133") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:59252->172.17.0.2:34133, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:39543") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:39862->172.17.0.2:39543, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:31829") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:44602->172.17.0.2:31829, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:8481") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:56792->172.17.0.2:8481, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:42060") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:56954->172.17.0.2:42060, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:38377") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:37072->172.17.0.2:38377, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:15833") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:49726->172.17.0.2:15833, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:58162") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:37098->172.17.0.2:58162, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:41500") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:59170->172.17.0.2:41500, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:54872") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:49762->172.17.0.2:54872, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:37755") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:41322->172.17.0.2:37755, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:9320") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:46854->172.17.0.2:9320, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:28727") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:34746->172.17.0.2:28727, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:59339") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:44058->172.17.0.2:59339, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:8240") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:43942->172.17.0.2:8240, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:44656") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:49302->172.17.0.2:44656, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:25907") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:56900->172.17.0.2:25907, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:27674") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:37710->172.17.0.2:27674, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:51715") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:46930->172.17.0.2:51715, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:9135") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:55006->172.17.0.2:9135, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:22186") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:35846->172.17.0.2:22186, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:50403") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:33584->172.17.0.2:50403, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:1233") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:48890->172.17.0.2:1233, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:49760") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:47330->172.17.0.2:49760, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:26449") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:40512->172.17.0.2:26449, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:8652") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:41034->172.17.0.2:8652, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:12159") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:45068->172.17.0.2:12159, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:2886") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:55186->172.17.0.2:2886, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:35353") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:41098->172.17.0.2:35353, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:37745") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:41336->172.17.0.2:37745, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:62189") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:40580->172.17.0.2:62189, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:3951") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:57002->172.17.0.2:3951, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:11753") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:45662->172.17.0.2:11753, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:28484") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:32854->172.17.0.2:28484, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:11408") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:49316->172.17.0.2:11408, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:52790") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:48204->172.17.0.2:52790, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:1327") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:39708->172.17.0.2:1327, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:26218") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:58326->172.17.0.2:26218, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:45418") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:38006->172.17.0.2:45418, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:41803") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:40496->172.17.0.2:41803, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:15555") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:43168->172.17.0.2:15555, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:17638") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:56064->172.17.0.2:17638, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:50099") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:40690->172.17.0.2:50099, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:43258") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:54564->172.17.0.2:43258, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:11442") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:47390->172.17.0.2:11442, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:57316") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:60630->172.17.0.2:57316, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:22380") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:48318->172.17.0.2:22380, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:36326") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:47422->172.17.0.2:36326, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:19455") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:56966->172.17.0.2:19455, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:8561") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:34640->172.17.0.2:8561, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:44437") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:58256->172.17.0.2:44437, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:40617") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:39644->172.17.0.2:40617, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:57941") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:51088->172.17.0.2:57941, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:44646") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:33066->172.17.0.2:44646, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:24843") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:34228->172.17.0.2:24843, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:18855") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:41254->172.17.0.2:18855, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:52274") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:32946->172.17.0.2:52274, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:35979") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:43050->172.17.0.2:35979, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:20717") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:44706->172.17.0.2:20717, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:22092") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:51616->172.17.0.2:22092, err= 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:8189") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:54760->172.17.0.2:8189, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:17372") 2025/08/22 02:39:50 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:43320->172.17.0.2:17372, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: Connecting to FTP server 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:21") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:38612->172.17.0.2:21, err= 2025/08/22 02:39:51 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:55771") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:54694->172.17.0.2:55771, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:40501") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:51548->172.17.0.2:40501, 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/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:42982") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:39478->172.17.0.2:42982, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:3831") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:51972->172.17.0.2:3831, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:28708") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:50908->172.17.0.2:28708, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:46744") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:35498->172.17.0.2:46744, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:8108") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:46460->172.17.0.2:8108, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:8241") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:38096->172.17.0.2:8241, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:36746") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:57070->172.17.0.2:36746, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:4106") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:39336->172.17.0.2:4106, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:40516") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:57320->172.17.0.2:40516, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:58921") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:35450->172.17.0.2:58921, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:34484") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:47104->172.17.0.2:34484, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:8181") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:49744->172.17.0.2:8181, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:12292") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:41006->172.17.0.2:12292, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:38682") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:48488->172.17.0.2:38682, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:32521") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:52626->172.17.0.2:32521, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:43529") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:60906->172.17.0.2:43529, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:47220") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:54694->172.17.0.2:47220, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/08/22 02:39:51 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/08/22 02:39:51 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/08/22 02:39:51 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:51 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:51 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:51 DEBUG : TestFTPProftpd: detected overridden config - adding "{Op6rd}" suffix to name 2025/08/22 02:39:51 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:51 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:51 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:38624->172.17.0.2:21, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:60897") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50128->172.17.0.2:60897, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:62868") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:34726->172.17.0.2:62868, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:3671") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:34926->172.17.0.2:3671, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:34134") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:51482->172.17.0.2:34134, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:42725") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:57870->172.17.0.2:42725, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:31924") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:53554->172.17.0.2:31924, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:55077") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:59030->172.17.0.2:55077, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:47479") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:60972->172.17.0.2:47479, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:36521") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:41386->172.17.0.2:36521, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:14292") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:41836->172.17.0.2:14292, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:6068") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:49212->172.17.0.2:6068, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:57466") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:51818->172.17.0.2:57466, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:10030") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:57640->172.17.0.2:10030, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:60816") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:42390->172.17.0.2:60816, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:32433") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:36922->172.17.0.2:32433, 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/08/22 02:39:51 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-duyequc2kuqu/hello? sausage/êé" 2025/08/22 02:39:51 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/08/22 02:39:51 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:51 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:51 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:51 DEBUG : TestFTPProftpd: detected overridden config - adding "{Op6rd}" suffix to name 2025/08/22 02:39:51 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:51 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:51 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: Connecting to FTP server 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:38634->172.17.0.2:21, err= 2025/08/22 02:39:51 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-duyequc2kuqu/hello? sausage/êé" to be canonical "TestFTPProftpd{Op6rd}:rclone-test-duyequc2kuqu/hello? sausage/êé" 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:20117") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:60304->172.17.0.2:20117, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:39836") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:51412->172.17.0.2:39836, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: Connecting to FTP server 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:38650->172.17.0.2:21, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:30034") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:47774->172.17.0.2:30034, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:50266") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:48968->172.17.0.2:50266, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:30019") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:35252->172.17.0.2:30019, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:57721") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:53858->172.17.0.2:57721, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:60846") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:46340->172.17.0.2:60846, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:34016") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:41238->172.17.0.2:34016, err= 2025/08/22 02:39:51 DEBUG : Waiting for deletions to finish 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:14331") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:40198->172.17.0.2:14331, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:10870") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:57212->172.17.0.2:10870, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:21746") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:37574->172.17.0.2:21746, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:29683") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:34228->172.17.0.2:29683, err= 2025/08/22 02:39:51 INFO : a/b/c/d/e.txt: Deleted 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:7992") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:40666->172.17.0.2:7992, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:26562") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:51316->172.17.0.2:26562, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:8637") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:54128->172.17.0.2:8637, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: dial("tcp","172.17.0.2:33816") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé: > dial: conn=172.17.0.1:49498->172.17.0.2:33816, err= 2025/08/22 02:39:51 DEBUG : removing 1 level 4 directories 2025/08/22 02:39:51 INFO : a/b/c/d: Removing directory 2025/08/22 02:39:51 DEBUG : removing 1 level 3 directories 2025/08/22 02:39:51 INFO : a/b/c: Removing directory 2025/08/22 02:39:51 DEBUG : removing 1 level 2 directories 2025/08/22 02:39:51 INFO : a/b: Removing directory 2025/08/22 02:39:51 DEBUG : removing 1 level 1 directories 2025/08/22 02:39:51 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:51989") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:49492->172.17.0.2:51989, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:63624") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:57058->172.17.0.2:63624, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:60117") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:46784->172.17.0.2:60117, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:33198") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:53088->172.17.0.2:33198, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:6197") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:59766->172.17.0.2:6197, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:2824") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:38814->172.17.0.2:2824, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: Connecting to FTP server 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:21") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:38654->172.17.0.2:21, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:4410") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:42084->172.17.0.2:4410, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:7039") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:34998->172.17.0.2:7039, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:9279") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:49046->172.17.0.2:9279, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:17109") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:43804->172.17.0.2:17109, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:42316") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:45306->172.17.0.2:42316, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:32380") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:42280->172.17.0.2:32380, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:62308") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:63746") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:58454->172.17.0.2:62308, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:55410->172.17.0.2:63746, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:42740") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:49218->172.17.0.2:42740, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:42719") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:42628->172.17.0.2:42719, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:49474") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:51450->172.17.0.2:49474, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:53023") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:52290->172.17.0.2:53023, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:3202") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:9066") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:55216->172.17.0.2:9066, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:39334->172.17.0.2:3202, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:15887") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:60028->172.17.0.2:15887, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:43781") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:43882->172.17.0.2:43781, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:16460") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:36432->172.17.0.2:16460, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/08/22 02:39:51 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-tilobuy6fuko" 2025/08/22 02:39:51 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/08/22 02:39:51 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:51 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:51 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:51 DEBUG : TestFTPProftpd: detected overridden config - adding "{Op6rd}" suffix to name 2025/08/22 02:39:51 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:51 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:51 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:51 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: Connecting to FTP server 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: dial("tcp","172.17.0.2:21") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: > dial: conn=172.17.0.1:38670->172.17.0.2:21, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:13406") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:45556->172.17.0.2:13406, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: dial("tcp","172.17.0.2:33292") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: > dial: conn=172.17.0.1:57518->172.17.0.2:33292, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: dial("tcp","172.17.0.2:30061") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: > dial: conn=172.17.0.1:57434->172.17.0.2:30061, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: dial("tcp","172.17.0.2:11700") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: > dial: conn=172.17.0.1:51368->172.17.0.2:11700, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: dial("tcp","172.17.0.2:27821") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: > dial: conn=172.17.0.1:57122->172.17.0.2:27821, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: dial("tcp","172.17.0.2:47770") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: > dial: conn=172.17.0.1:44458->172.17.0.2:47770, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: dial("tcp","172.17.0.2:30992") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: > dial: conn=172.17.0.1:51434->172.17.0.2:30992, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: dial("tcp","172.17.0.2:61166") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: > dial: conn=172.17.0.1:37998->172.17.0.2:61166, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:51572") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:46300->172.17.0.2:51572, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:35382") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:35060->172.17.0.2:35382, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:62084") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:59440->172.17.0.2:62084, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:3942") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:39470->172.17.0.2:3942, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:13793") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:57352->172.17.0.2:13793, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: dial("tcp","172.17.0.2:48970") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: > dial: conn=172.17.0.1:46964->172.17.0.2:48970, err= 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: dial("tcp","172.17.0.2:37196") 2025/08/22 02:39:51 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: > dial: conn=172.17.0.1:52006->172.17.0.2:37196, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: dial("tcp","172.17.0.2:2304") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: > dial: conn=172.17.0.1:40084->172.17.0.2:2304, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: dial("tcp","172.17.0.2:40781") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: > dial: conn=172.17.0.1:50076->172.17.0.2:40781, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: Purge dir "new_name" 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-tilobuy6fuko: 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/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:29139") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:48548->172.17.0.2:29139, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:58235") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:49338->172.17.0.2:58235, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:37849") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:36400->172.17.0.2:37849, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:54219") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:33136->172.17.0.2:54219, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:18647") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:48868->172.17.0.2:18647, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:30683") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:57482->172.17.0.2:30683, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:55495") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:44916->172.17.0.2:55495, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:20608") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:48752->172.17.0.2:20608, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:20226") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:42004->172.17.0.2:20226, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/08/22 02:39:52 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-duyequc2kuqu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/08/22 02:39:52 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/08/22 02:39:52 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:52 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:52 DEBUG : TestFTPProftpd: detected overridden config - adding "{Op6rd}" suffix to name 2025/08/22 02:39:52 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:52 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:21") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:38682->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:59554") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:38726->172.17.0.2:59554, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/08/22 02:39:52 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-duyequc2kuqu/not found.txt" 2025/08/22 02:39:52 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/08/22 02:39:52 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:52 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:52 DEBUG : TestFTPProftpd: detected overridden config - adding "{Op6rd}" suffix to name 2025/08/22 02:39:52 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:52 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/not found.txt: Connecting to FTP server 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/not found.txt: dial("tcp","172.17.0.2:21") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/not found.txt: > dial: conn=172.17.0.1:38688->172.17.0.2:21, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/not found.txt: dial("tcp","172.17.0.2:57432") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/not found.txt: > dial: conn=172.17.0.1:55278->172.17.0.2:57432, err= 2025/08/22 02:39:52 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-duyequc2kuqu" from "TestFTPProftpd:rclone-test-duyequc2kuqu" 2025/08/22 02:39:52 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/08/22 02:39:52 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/08/22 02:39:52 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:52 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:52 DEBUG : TestFTPProftpd: detected overridden config - adding "{Op6rd}" suffix to name 2025/08/22 02:39:52 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:52 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:38696->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:47453") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:46702->172.17.0.2:47453, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:1796") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:35242->172.17.0.2:1796, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:5159") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:53974->172.17.0.2:5159, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:15531") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:46596->172.17.0.2:15531, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:3398") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:53656->172.17.0.2:3398, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:16572") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:56116->172.17.0.2:16572, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:27493") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:41826->172.17.0.2:27493, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:1597") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:41520->172.17.0.2:1597, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:8234") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:42608->172.17.0.2:8234, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:45904") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:35700->172.17.0.2:45904, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:36558") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:57458->172.17.0.2:36558, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:12372") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:56510->172.17.0.2:12372, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:3960") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:60128->172.17.0.2:3960, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:47753") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:35166->172.17.0.2:47753, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:24125") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:60410->172.17.0.2:24125, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:26731") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:52544->172.17.0.2:26731, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:28126") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:49436->172.17.0.2:28126, 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/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:33307") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:42328->172.17.0.2:33307, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:37439") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:40098->172.17.0.2:37439, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:64337") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:32820->172.17.0.2:64337, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:56106") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:55596->172.17.0.2:56106, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:1796") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:35250->172.17.0.2:1796, 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/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:11273") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:32896->172.17.0.2:11273, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:33494") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:40388->172.17.0.2:33494, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/08/22 02:39:52 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-duyequc2kuqu" 2025/08/22 02:39:52 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/08/22 02:39:52 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:52 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:52 DEBUG : TestFTPProftpd: detected overridden config - adding "{U-Ch5}" suffix to name 2025/08/22 02:39:52 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:52 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:52 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:52 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: Connecting to FTP server 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:21") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:38710->172.17.0.2:21, err= 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:15248") 2025/08/22 02:39:52 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:37146->172.17.0.2:15248, 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/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:56470") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:43308->172.17.0.2:56470, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:34081") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:35720->172.17.0.2:34081, err= 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:42484") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:34634->172.17.0.2:42484, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/08/22 02:39:53 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-duyequc2kuqu/deeper/nonexisting/directory" 2025/08/22 02:39:53 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/08/22 02:39:53 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:53 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:53 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:53 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:53 DEBUG : TestFTPProftpd: detected overridden config - adding "{Op6rd}" suffix to name 2025/08/22 02:39:53 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/08/22 02:39:53 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/08/22 02:39:53 DEBUG : Setting pass="NRH-k-AJD9-No5-wFORy_IFJPkmM18Ctz9nrfL1-zmtK8g" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/08/22 02:39:53 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/deeper/nonexisting/directory: Connecting to FTP server 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/deeper/nonexisting/directory: dial("tcp","172.17.0.2:21") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:38720->172.17.0.2: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/08/22 02:39:53 DEBUG : Waiting for deletions to finish 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:24721") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:45752->172.17.0.2:24721, err= 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:48037") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:55340->172.17.0.2:48037, err= 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:47850") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:59370->172.17.0.2:47850, err= 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:42501") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:59372->172.17.0.2:42501, err= 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:35350") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:49988->172.17.0.2:35350, err= 2025/08/22 02:39:53 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:37765") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:42772->172.17.0.2:37765, err= 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:35499") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:42216->172.17.0.2:35499, err= 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:14935") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:43348->172.17.0.2:14935, err= 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:29144") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:34596->172.17.0.2:29144, err= 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:28955") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:48046->172.17.0.2:28955, err= 2025/08/22 02:39:53 DEBUG : removing 1 level 4 directories 2025/08/22 02:39:53 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/08/22 02:39:53 DEBUG : removing 1 level 3 directories 2025/08/22 02:39:53 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/08/22 02:39:53 DEBUG : removing 1 level 2 directories 2025/08/22 02:39:53 INFO : hello? sausage/êé: Removing directory 2025/08/22 02:39:53 DEBUG : removing 1 level 1 directories 2025/08/22 02:39:53 INFO : hello? sausage: Removing directory 2025/08/22 02:39:53 DEBUG : removing 1 level 0 directories 2025/08/22 02:39:53 INFO : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: Removing directory 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:35854") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:52018->172.17.0.2:35854, err= 2025/08/22 02:39:53 ERROR : error listing: directory not found 2025/08/22 02:39:53 DEBUG : Waiting for deletions to finish 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:53483") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:50526->172.17.0.2:53483, err= 2025/08/22 02:39:53 ERROR : error listing: directory not found 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: dial("tcp","172.17.0.2:9518") 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: > dial: conn=172.17.0.1:37248->172.17.0.2:9518, err= 2025/08/22 02:39:53 ERROR : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: Failed to list "": directory not found 2025/08/22 02:39:53 DEBUG : removing 1 level 0 directories 2025/08/22 02:39:53 INFO : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: Removing directory 2025/08/22 02:39:53 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/08/22 02:39:53 DEBUG : ftp://172.17.0.2:21/rclone-test-duyequc2kuqu: closing 2 unused connections --- PASS: TestIntegration (2.91s) --- 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.83s) --- 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.29s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.02s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.02s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.02s) --- 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.09s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.08s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.79s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.79s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.02s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 2.937s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 3.880928742s (try 1/5)