"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/09/14 02:32:54 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-lelofaw9pose" 2025/09/14 02:32:54 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/14 02:32:54 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/14 02:32:54 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:54 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:54 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:54 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:54 DEBUG : TestFTPProftpd: detected overridden config - adding "{kLOJy}" suffix to name 2025/09/14 02:32:54 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:54 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:54 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:54 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: Connecting to FTP server 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:21") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:34576->172.17.0.4:21, err= 2025/09/14 02:32:54 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/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:18559") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:38004->172.17.0.4:18559, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:57580") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:54374->172.17.0.4:57580, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/09/14 02:32:54 INFO : dir/subdir: Making directory 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:38677") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:56238->172.17.0.4:38677, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:2895") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:38268->172.17.0.4:2895, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:6092") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:46640->172.17.0.4:6092, err= 2025/09/14 02:32:54 INFO : dir/subdir: Removing directory 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:36968") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:40956->172.17.0.4:36968, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:5157") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:55748->172.17.0.4:5157, err= 2025/09/14 02:32:54 INFO : dir: Removing directory 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:55770") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:53670->172.17.0.4:55770, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:1027") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:59226->172.17.0.4:1027, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:19379") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:41906->172.17.0.4:19379, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:9761") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:47446->172.17.0.4:9761, err= 2025/09/14 02:32:54 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/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:44812") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:39074->172.17.0.4:44812, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:19632") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:41454->172.17.0.4:19632, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:2441") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:52632->172.17.0.4:2441, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:35033") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:49084->172.17.0.4:35033, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:8288") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:50818->172.17.0.4:8288, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:63718") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:45456->172.17.0.4:63718, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:30903") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:50182->172.17.0.4:30903, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:39258") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:40474->172.17.0.4:39258, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:43476") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:35378->172.17.0.4:43476, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:54945") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:46604->172.17.0.4:54945, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:33682") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:58056->172.17.0.4:33682, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:55979") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:53658->172.17.0.4:55979, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:17333") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:38418->172.17.0.4:17333, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:25670") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:33782->172.17.0.4:25670, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:50589") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:53612->172.17.0.4:50589, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:33917") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:51938->172.17.0.4:33917, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:15880") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:46140->172.17.0.4:15880, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:10656") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:34572->172.17.0.4:10656, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:16362") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:54872->172.17.0.4:16362, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:54837") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:51282->172.17.0.4:54837, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:28192") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:44840->172.17.0.4:28192, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:8407") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:55428->172.17.0.4:8407, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:27979") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:47036->172.17.0.4:27979, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:30063") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:43302->172.17.0.4:30063, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:13475") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:42126->172.17.0.4:13475, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:63923") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:42594->172.17.0.4:63923, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:34196") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:52086->172.17.0.4:34196, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:3710") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:50556->172.17.0.4:3710, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:63927") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:44664->172.17.0.4:63927, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:52551") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:50704->172.17.0.4:52551, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:12448") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:60080->172.17.0.4:12448, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:43204") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:49672->172.17.0.4:43204, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:6649") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:52972->172.17.0.4:6649, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:13865") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:33228->172.17.0.4:13865, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:12703") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:40232->172.17.0.4:12703, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:13914") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:50352->172.17.0.4:13914, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:12048") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:54028->172.17.0.4:12048, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:42582") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:36750->172.17.0.4:42582, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:52148") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:60600->172.17.0.4:52148, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:54501") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:36254->172.17.0.4:54501, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:31992") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:55762->172.17.0.4:31992, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:20295") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:54470->172.17.0.4:20295, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:44946") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:52570->172.17.0.4:44946, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:48301") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:34396->172.17.0.4:48301, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:44942") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:42448->172.17.0.4:44942, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:30001") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:47740->172.17.0.4:30001, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:16684") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:44660->172.17.0.4:16684, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:59798") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:41810->172.17.0.4:59798, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:39633") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:40386->172.17.0.4:39633, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:32023") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:53990->172.17.0.4:32023, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:49100") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:60316->172.17.0.4:49100, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:2290") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:37302->172.17.0.4:2290, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:39406") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:36172->172.17.0.4:39406, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:11545") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:33036->172.17.0.4:11545, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:31330") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:48266->172.17.0.4:31330, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:51858") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:52968->172.17.0.4:51858, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:9933") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:38028->172.17.0.4:9933, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:64502") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:59796->172.17.0.4:64502, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:54545") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:39158->172.17.0.4:54545, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:8326") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:54084->172.17.0.4:8326, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:51519") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:36144->172.17.0.4:51519, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:1458") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:35410->172.17.0.4:1458, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:50506") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:59404->172.17.0.4:50506, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:57145") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:58684->172.17.0.4:57145, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:14300") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:46274->172.17.0.4:14300, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:62185") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:38886->172.17.0.4:62185, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:5524") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:56338->172.17.0.4:5524, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:25325") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:57490->172.17.0.4:25325, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:39233") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:55838->172.17.0.4:39233, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:56649") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:57456->172.17.0.4:56649, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:14291") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:44800->172.17.0.4:14291, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:5690") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:60542->172.17.0.4:5690, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:11409") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:50194->172.17.0.4:11409, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:58214") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:37888->172.17.0.4:58214, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:52968") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:51362->172.17.0.4:52968, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:55327") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:44652->172.17.0.4:55327, err= 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:22680") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:58328->172.17.0.4:22680, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:4118") 2025/09/14 02:32:54 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:54988->172.17.0.4:4118, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: Connecting to FTP server 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:21") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:34584->172.17.0.4:21, err= 2025/09/14 02:32:55 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:43552") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:49586->172.17.0.4:43552, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:9051") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:50920->172.17.0.4:9051, 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/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:12699") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:59366->172.17.0.4:12699, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:4889") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:38022->172.17.0.4:4889, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:65152") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:44206->172.17.0.4:65152, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:5179") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:42936->172.17.0.4:5179, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:36252") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:33806->172.17.0.4:36252, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:48311") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:59580->172.17.0.4:48311, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:14167") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:35262->172.17.0.4:14167, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:49114") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:33826->172.17.0.4:49114, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:49083") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:54306->172.17.0.4:49083, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:28095") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:58496->172.17.0.4:28095, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:7180") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:43140->172.17.0.4:7180, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:61794") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:59056->172.17.0.4:61794, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:47048") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:58352->172.17.0.4:47048, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:38073") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:51258->172.17.0.4:38073, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:26554") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:55120->172.17.0.4:26554, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:6211") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:47744->172.17.0.4:6211, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:41872") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:56610->172.17.0.4:41872, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/09/14 02:32:55 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/09/14 02:32:55 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/14 02:32:55 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:55 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:55 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:55 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:55 DEBUG : TestFTPProftpd: detected overridden config - adding "{kLOJy}" suffix to name 2025/09/14 02:32:55 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:55 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:55 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:55 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34592->172.17.0.4:21, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21478") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58950->172.17.0.4:21478, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:16428") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:48270->172.17.0.4:16428, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:52277") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:47868->172.17.0.4:52277, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:34810") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:60926->172.17.0.4:34810, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:48616") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:35978->172.17.0.4:48616, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:40197") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:60774->172.17.0.4:40197, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:8615") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:48676->172.17.0.4:8615, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:14820") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:56926->172.17.0.4:14820, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:42968") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:39380->172.17.0.4:42968, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:51424") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:54926->172.17.0.4:51424, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:8002") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:34330->172.17.0.4:8002, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:9083") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:59230->172.17.0.4:9083, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:6959") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:40262->172.17.0.4:6959, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:50530") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:49104->172.17.0.4:50530, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:17111") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:55280->172.17.0.4:17111, 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/09/14 02:32:55 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-lelofaw9pose/hello? sausage/êé" 2025/09/14 02:32:55 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/14 02:32:55 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:55 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:55 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:55 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:55 DEBUG : TestFTPProftpd: detected overridden config - adding "{kLOJy}" suffix to name 2025/09/14 02:32:55 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:55 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:55 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:55 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: Connecting to FTP server 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:34604->172.17.0.4:21, err= 2025/09/14 02:32:55 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-lelofaw9pose/hello? sausage/êé" to be canonical "TestFTPProftpd{kLOJy}:rclone-test-lelofaw9pose/hello? sausage/êé" 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:50036") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:49602->172.17.0.4:50036, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:6479") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:50714->172.17.0.4:6479, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: Connecting to FTP server 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:34606->172.17.0.4:21, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:7449") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:57886->172.17.0.4:7449, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:49474") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:53644->172.17.0.4:49474, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:6119") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:34366->172.17.0.4:6119, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:6651") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:55806->172.17.0.4:6651, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:27809") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:39698->172.17.0.4:27809, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:49486") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:49546->172.17.0.4:49486, err= 2025/09/14 02:32:55 DEBUG : Waiting for deletions to finish 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:15543") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:33114->172.17.0.4:15543, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:32240") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:50864->172.17.0.4:32240, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:56461") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:53268->172.17.0.4:56461, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:48983") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:33410->172.17.0.4:48983, err= 2025/09/14 02:32:55 INFO : a/b/c/d/e.txt: Deleted 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:43793") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:60112->172.17.0.4:43793, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:20876") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:49472->172.17.0.4:20876, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:4392") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:38106->172.17.0.4:4392, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: dial("tcp","172.17.0.4:11184") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé: > dial: conn=172.17.0.1:55752->172.17.0.4:11184, err= 2025/09/14 02:32:55 DEBUG : removing 1 level 4 directories 2025/09/14 02:32:55 INFO : a/b/c/d: Removing directory 2025/09/14 02:32:55 DEBUG : removing 1 level 3 directories 2025/09/14 02:32:55 INFO : a/b/c: Removing directory 2025/09/14 02:32:55 DEBUG : removing 1 level 2 directories 2025/09/14 02:32:55 INFO : a/b: Removing directory 2025/09/14 02:32:55 DEBUG : removing 1 level 1 directories 2025/09/14 02:32:55 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:18635") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:58210->172.17.0.4:18635, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:54396") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:47322->172.17.0.4:54396, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:16728") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:34948->172.17.0.4:16728, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:22790") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:58728->172.17.0.4:22790, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:25113") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:59894->172.17.0.4:25113, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:64016") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:52798->172.17.0.4:64016, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: Connecting to FTP server 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:21") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:34622->172.17.0.4:21, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:35933") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:55328->172.17.0.4:35933, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:23945") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:60580->172.17.0.4:23945, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:8692") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:37400->172.17.0.4:8692, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:35690") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:53042->172.17.0.4:35690, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:47564") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:60174->172.17.0.4:47564, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:1808") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:56364->172.17.0.4:1808, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:63004") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:29174") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:33692->172.17.0.4:63004, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:58008->172.17.0.4:29174, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:14849") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:44486->172.17.0.4:14849, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:11039") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:59036->172.17.0.4:11039, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:43823") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:59296->172.17.0.4:43823, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:7644") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:49886->172.17.0.4:7644, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:30026") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:59084->172.17.0.4:30026, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:44518") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:47614->172.17.0.4:44518, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:51899") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:48974->172.17.0.4:51899, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:15510") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:55140->172.17.0.4:15510, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:4843") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:50404->172.17.0.4:4843, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/09/14 02:32:55 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-bumoviw8cacu" 2025/09/14 02:32:55 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/14 02:32:55 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:55 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:55 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:55 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:55 DEBUG : TestFTPProftpd: detected overridden config - adding "{kLOJy}" suffix to name 2025/09/14 02:32:55 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:55 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:55 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:55 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: Connecting to FTP server 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: dial("tcp","172.17.0.4:21") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: > dial: conn=172.17.0.1:34626->172.17.0.4:21, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:50955") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:40804->172.17.0.4:50955, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: dial("tcp","172.17.0.4:2134") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: > dial: conn=172.17.0.1:47048->172.17.0.4:2134, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: dial("tcp","172.17.0.4:13025") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: > dial: conn=172.17.0.1:35330->172.17.0.4:13025, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: dial("tcp","172.17.0.4:51121") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: > dial: conn=172.17.0.1:37174->172.17.0.4:51121, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: dial("tcp","172.17.0.4:23968") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: > dial: conn=172.17.0.1:58200->172.17.0.4:23968, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: dial("tcp","172.17.0.4:9950") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: > dial: conn=172.17.0.1:42342->172.17.0.4:9950, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: dial("tcp","172.17.0.4:38959") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: > dial: conn=172.17.0.1:50474->172.17.0.4:38959, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: dial("tcp","172.17.0.4:11811") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: > dial: conn=172.17.0.1:59678->172.17.0.4:11811, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:49706") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:42578->172.17.0.4:49706, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:24378") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:59532->172.17.0.4:24378, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:28236") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:54882->172.17.0.4:28236, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:4767") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:52060->172.17.0.4:4767, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:20247") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:36666->172.17.0.4:20247, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: dial("tcp","172.17.0.4:27017") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: > dial: conn=172.17.0.1:34520->172.17.0.4:27017, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: dial("tcp","172.17.0.4:39955") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: > dial: conn=172.17.0.1:43684->172.17.0.4:39955, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: dial("tcp","172.17.0.4:64394") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: > dial: conn=172.17.0.1:53846->172.17.0.4:64394, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: dial("tcp","172.17.0.4:35416") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: > dial: conn=172.17.0.1:37866->172.17.0.4:35416, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: Purge dir "new_name" 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-bumoviw8cacu: 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/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:59530") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:43020->172.17.0.4:59530, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:37891") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:58002->172.17.0.4:37891, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:41275") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:37168->172.17.0.4:41275, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:36449") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:36560->172.17.0.4:36449, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:37577") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:57912->172.17.0.4:37577, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:62022") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:56762->172.17.0.4:62022, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:3328") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:34220->172.17.0.4:3328, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:11111") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:49648->172.17.0.4:11111, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:5102") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:36218->172.17.0.4:5102, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/09/14 02:32:55 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-lelofaw9pose/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/09/14 02:32:55 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/14 02:32:55 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:55 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:55 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:55 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:55 DEBUG : TestFTPProftpd: detected overridden config - adding "{kLOJy}" suffix to name 2025/09/14 02:32:55 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:55 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:55 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:55 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:56768->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:54276") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:36758->172.17.0.4:54276, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/09/14 02:32:55 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-lelofaw9pose/not found.txt" 2025/09/14 02:32:55 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/14 02:32:55 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:55 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:55 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:55 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:55 DEBUG : TestFTPProftpd: detected overridden config - adding "{kLOJy}" suffix to name 2025/09/14 02:32:55 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:55 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:55 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:55 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/not found.txt: Connecting to FTP server 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/not found.txt: dial("tcp","172.17.0.4:21") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/not found.txt: > dial: conn=172.17.0.1:56782->172.17.0.4:21, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/not found.txt: dial("tcp","172.17.0.4:10305") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/not found.txt: > dial: conn=172.17.0.1:59968->172.17.0.4:10305, err= 2025/09/14 02:32:55 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-lelofaw9pose" from "TestFTPProftpd:rclone-test-lelofaw9pose" 2025/09/14 02:32:55 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/09/14 02:32:55 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/14 02:32:55 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:55 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:55 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:55 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:55 DEBUG : TestFTPProftpd: detected overridden config - adding "{kLOJy}" suffix to name 2025/09/14 02:32:55 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:55 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:55 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:55 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56790->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:51012") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:55512->172.17.0.4:51012, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:51837") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:38116->172.17.0.4:51837, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30298") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:38218->172.17.0.4:30298, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:62989") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:50100->172.17.0.4:62989, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:13794") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:35462->172.17.0.4:13794, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:6776") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34290->172.17.0.4:6776, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:6408") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:38286->172.17.0.4:6408, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:54065") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:55324->172.17.0.4:54065, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:63206") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:47442->172.17.0.4:63206, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:11167") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56820->172.17.0.4:11167, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:59668") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:48776->172.17.0.4:59668, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:48065") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:36024->172.17.0.4:48065, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:24284") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:35654->172.17.0.4:24284, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:28884") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34510->172.17.0.4:28884, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:27951") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:59174->172.17.0.4:27951, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:51246") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:35790->172.17.0.4:51246, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35287") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44106->172.17.0.4:35287, 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/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:46885") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:55292->172.17.0.4:46885, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:17125") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:53290->172.17.0.4:17125, err= 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:50611") 2025/09/14 02:32:55 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:45000->172.17.0.4:50611, err= 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:53056") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:52262->172.17.0.4:53056, err= 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:8866") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:49156->172.17.0.4:8866, 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/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:46695") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:55886->172.17.0.4:46695, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:55503") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:56518->172.17.0.4:55503, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/09/14 02:32:56 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-lelofaw9pose" 2025/09/14 02:32:56 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/14 02:32:56 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:56 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:56 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:56 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:56 DEBUG : TestFTPProftpd: detected overridden config - adding "{LxqRf}" suffix to name 2025/09/14 02:32:56 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:56 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:56 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:56 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: Connecting to FTP server 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:21") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:56806->172.17.0.4:21, err= 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:55632") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:40500->172.17.0.4:55632, 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/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:38964") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:42836->172.17.0.4:38964, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:49832") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:51914->172.17.0.4:49832, err= 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:24103") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:49536->172.17.0.4:24103, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/09/14 02:32:56 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-lelofaw9pose/deeper/nonexisting/directory" 2025/09/14 02:32:56 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/14 02:32:56 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:56 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:56 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:56 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:56 DEBUG : TestFTPProftpd: detected overridden config - adding "{kLOJy}" suffix to name 2025/09/14 02:32:56 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/14 02:32:56 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/14 02:32:56 DEBUG : Setting pass="VbEjVms98FObGo1CX_lgWDsmvVVQPVZUX3P8JCiN-6SZaA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/14 02:32:56 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/deeper/nonexisting/directory: Connecting to FTP server 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose/deeper/nonexisting/directory: > dial: conn=172.17.0.1:56818->172.17.0.4: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/09/14 02:32:56 DEBUG : Waiting for deletions to finish 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:63351") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:41262->172.17.0.4:63351, err= 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:61115") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:59304->172.17.0.4:61115, err= 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:2824") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:38396->172.17.0.4:2824, err= 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:61439") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:58306->172.17.0.4:61439, err= 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:55434") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:53508->172.17.0.4:55434, err= 2025/09/14 02:32:56 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:9099") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:37706->172.17.0.4:9099, err= 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:2228") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:52368->172.17.0.4:2228, err= 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:12691") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:36374->172.17.0.4:12691, err= 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:30040") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:38990->172.17.0.4:30040, err= 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:14539") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:53818->172.17.0.4:14539, err= 2025/09/14 02:32:56 DEBUG : removing 1 level 4 directories 2025/09/14 02:32:56 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/09/14 02:32:56 DEBUG : removing 1 level 3 directories 2025/09/14 02:32:56 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/09/14 02:32:56 DEBUG : removing 1 level 2 directories 2025/09/14 02:32:56 INFO : hello? sausage/êé: Removing directory 2025/09/14 02:32:56 DEBUG : removing 1 level 1 directories 2025/09/14 02:32:56 INFO : hello? sausage: Removing directory 2025/09/14 02:32:56 DEBUG : removing 1 level 0 directories 2025/09/14 02:32:56 INFO : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: Removing directory 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:62471") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:38600->172.17.0.4:62471, err= 2025/09/14 02:32:56 ERROR : error listing: directory not found 2025/09/14 02:32:56 DEBUG : Waiting for deletions to finish 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:1655") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:33036->172.17.0.4:1655, err= 2025/09/14 02:32:56 ERROR : error listing: directory not found 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: dial("tcp","172.17.0.4:28396") 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: > dial: conn=172.17.0.1:41164->172.17.0.4:28396, err= 2025/09/14 02:32:56 ERROR : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: Failed to list "": directory not found 2025/09/14 02:32:56 DEBUG : removing 1 level 0 directories 2025/09/14 02:32:56 INFO : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: Removing directory 2025/09/14 02:32:56 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/09/14 02:32:56 DEBUG : ftp://172.17.0.4:21/rclone-test-lelofaw9pose: closing 2 unused connections --- PASS: TestIntegration (2.81s) --- 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.75s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.21s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.44s) --- 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.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.09s) --- 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.08s) --- 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.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 2.825s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 3.677177979s (try 1/5)