"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/09/12 01:12:27 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-kuzayer3kuse" 2025/09/12 01:12:27 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/12 01:12:27 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/12 01:12:27 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:27 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:27 DEBUG : TestFTPProftpd: detected overridden config - adding "{TZzW6}" suffix to name 2025/09/12 01:12:27 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:27 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:27 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:27 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: Connecting to FTP server 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:21") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:37034->172.17.0.4:21, err= 2025/09/12 01:12:27 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/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:11497") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:60532->172.17.0.4:11497, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:62556") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:37452->172.17.0.4:62556, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/09/12 01:12:27 INFO : dir/subdir: Making directory 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:32500") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:50828->172.17.0.4:32500, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:61867") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:36026->172.17.0.4:61867, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:49766") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:57986->172.17.0.4:49766, err= 2025/09/12 01:12:27 INFO : dir/subdir: Removing directory 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:52888") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:51420->172.17.0.4:52888, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:7631") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:57048->172.17.0.4:7631, err= 2025/09/12 01:12:27 INFO : dir: Removing directory 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:35893") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:56516->172.17.0.4:35893, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:8770") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:49330->172.17.0.4:8770, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:60630") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:51448->172.17.0.4:60630, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:54491") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:56518->172.17.0.4:54491, err= 2025/09/12 01:12:27 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/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:47647") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:38798->172.17.0.4:47647, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:28424") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:55086->172.17.0.4:28424, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:27322") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:40278->172.17.0.4:27322, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:10213") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:43266->172.17.0.4:10213, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:62606") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:42216->172.17.0.4:62606, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:17004") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:33500->172.17.0.4:17004, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:7924") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:55788->172.17.0.4:7924, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:33650") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:58294->172.17.0.4:33650, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:42665") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:50526->172.17.0.4:42665, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:63872") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:40424->172.17.0.4:63872, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:2066") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:45184->172.17.0.4:2066, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:33971") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:41430->172.17.0.4:33971, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:32784") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:44276->172.17.0.4:32784, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:36330") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:44308->172.17.0.4:36330, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:43976") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:50722->172.17.0.4:43976, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:63385") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:51068->172.17.0.4:63385, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:55405") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:46380->172.17.0.4:55405, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:59663") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:41330->172.17.0.4:59663, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:61596") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:45824->172.17.0.4:61596, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:6006") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:37062->172.17.0.4:6006, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:5625") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:42430->172.17.0.4:5625, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:58618") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:56428->172.17.0.4:58618, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:37482") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:45396->172.17.0.4:37482, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:1957") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:39162->172.17.0.4:1957, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:42849") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:37310->172.17.0.4:42849, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:24836") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:43604->172.17.0.4:24836, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:8565") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:45400->172.17.0.4:8565, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:13207") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:57662->172.17.0.4:13207, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:32582") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:44154->172.17.0.4:32582, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:3660") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:33772->172.17.0.4:3660, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:2164") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:33248->172.17.0.4:2164, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:14694") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:57272->172.17.0.4:14694, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:31060") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:38208->172.17.0.4:31060, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:28462") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:46552->172.17.0.4:28462, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:23884") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:36946->172.17.0.4:23884, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:28131") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:38628->172.17.0.4:28131, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:44442") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:44022->172.17.0.4:44442, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:30784") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:58040->172.17.0.4:30784, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:60758") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:59584->172.17.0.4:60758, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:21572") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:46494->172.17.0.4:21572, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:29121") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:35964->172.17.0.4:29121, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:61800") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:52288->172.17.0.4:61800, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:54520") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:41576->172.17.0.4:54520, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:60881") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:45796->172.17.0.4:60881, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:32596") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:50158->172.17.0.4:32596, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:32962") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:37344->172.17.0.4:32962, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:58731") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:53686->172.17.0.4:58731, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:22466") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:53534->172.17.0.4:22466, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:27090") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:46450->172.17.0.4:27090, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:54793") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:42874->172.17.0.4:54793, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:27448") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:33870->172.17.0.4:27448, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:31691") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:35566->172.17.0.4:31691, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:47877") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:40720->172.17.0.4:47877, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:63907") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:38546->172.17.0.4:63907, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:32625") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:58932->172.17.0.4:32625, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:25191") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:57714->172.17.0.4:25191, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:23208") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:52396->172.17.0.4:23208, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:40166") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:55862->172.17.0.4:40166, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:37375") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:54106->172.17.0.4:37375, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:54767") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:34276->172.17.0.4:54767, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:42802") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:54628->172.17.0.4:42802, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:38516") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:58352->172.17.0.4:38516, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:3926") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:41358->172.17.0.4:3926, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:8328") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:58334->172.17.0.4:8328, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:1443") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:53138->172.17.0.4:1443, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:26786") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:51586->172.17.0.4:26786, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:35436") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:52538->172.17.0.4:35436, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:44862") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:59978->172.17.0.4:44862, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:56547") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:33784->172.17.0.4:56547, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:30659") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:59468->172.17.0.4:30659, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:65411") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:36408->172.17.0.4:65411, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:20133") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:52838->172.17.0.4:20133, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:26925") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:44260->172.17.0.4:26925, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:54397") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:51122->172.17.0.4:54397, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:15480") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:47462->172.17.0.4:15480, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:58497") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:40598->172.17.0.4:58497, err= 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:21824") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:54722->172.17.0.4:21824, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:8677") 2025/09/12 01:12:27 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:33320->172.17.0.4:8677, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: Connecting to FTP server 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:21") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:37050->172.17.0.4:21, err= 2025/09/12 01:12:28 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:41786") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:59954->172.17.0.4:41786, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:20158") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:57352->172.17.0.4:20158, 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/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:42127") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:44362->172.17.0.4:42127, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:8710") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:38534->172.17.0.4:8710, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:28623") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:52748->172.17.0.4:28623, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:58037") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:40964->172.17.0.4:58037, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:2144") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:45552->172.17.0.4:2144, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:8708") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:47172->172.17.0.4:8708, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:28042") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:55296->172.17.0.4:28042, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:27895") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:59394->172.17.0.4:27895, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:25633") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:56610->172.17.0.4:25633, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:10483") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:36062->172.17.0.4:10483, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:64265") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:40928->172.17.0.4:64265, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:3049") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:57702->172.17.0.4:3049, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:18122") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:52188->172.17.0.4:18122, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:32530") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:52614->172.17.0.4:32530, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:42819") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:35430->172.17.0.4:42819, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:37613") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:39450->172.17.0.4:37613, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:43077") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:35284->172.17.0.4:43077, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/09/12 01:12:28 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/09/12 01:12:28 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/12 01:12:28 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:28 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{TZzW6}" suffix to name 2025/09/12 01:12:28 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:28 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37060->172.17.0.4:21, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:25313") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:36310->172.17.0.4:25313, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:36972") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:53294->172.17.0.4:36972, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:6593") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:56944->172.17.0.4:6593, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:50552") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:51250->172.17.0.4:50552, err= 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:40418") 2025/09/12 01:12:28 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:55260->172.17.0.4:40418, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:1316") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:34866->172.17.0.4:1316, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:26750") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:56848->172.17.0.4:26750, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:38895") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:37136->172.17.0.4:38895, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:4712") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:43136->172.17.0.4:4712, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:15337") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:33318->172.17.0.4:15337, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:8261") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:60724->172.17.0.4:8261, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:17631") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:52094->172.17.0.4:17631, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:54143") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:56166->172.17.0.4:54143, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:49024") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:46324->172.17.0.4:49024, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:36766") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:37294->172.17.0.4:36766, 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/12 01:12:29 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-kuzayer3kuse/hello? sausage/êé" 2025/09/12 01:12:29 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/12 01:12:29 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:29 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{TZzW6}" suffix to name 2025/09/12 01:12:29 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:29 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: Connecting to FTP server 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:37068->172.17.0.4:21, err= 2025/09/12 01:12:29 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-kuzayer3kuse/hello? sausage/êé" to be canonical "TestFTPProftpd{TZzW6}:rclone-test-kuzayer3kuse/hello? sausage/êé" 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:52997") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:48272->172.17.0.4:52997, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:28346") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:60318->172.17.0.4:28346, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: Connecting to FTP server 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:37084->172.17.0.4:21, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:46153") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:59744->172.17.0.4:46153, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:51694") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:50566->172.17.0.4:51694, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:18006") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:56334->172.17.0.4:18006, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:62980") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:31233") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:49696->172.17.0.4:31233, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:57250->172.17.0.4:62980, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:3750") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:51034->172.17.0.4:3750, err= 2025/09/12 01:12:29 DEBUG : Waiting for deletions to finish 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:25498") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:36468->172.17.0.4:25498, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:38644") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:53362->172.17.0.4:38644, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:31435") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:59088->172.17.0.4:31435, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:30501") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:52928->172.17.0.4:30501, err= 2025/09/12 01:12:29 INFO : a/b/c/d/e.txt: Deleted 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:12341") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:47166->172.17.0.4:12341, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:35966") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:56500->172.17.0.4:35966, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:25483") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:36280->172.17.0.4:25483, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: dial("tcp","172.17.0.4:64177") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé: > dial: conn=172.17.0.1:49072->172.17.0.4:64177, err= 2025/09/12 01:12:29 DEBUG : removing 1 level 4 directories 2025/09/12 01:12:29 INFO : a/b/c/d: Removing directory 2025/09/12 01:12:29 DEBUG : removing 1 level 3 directories 2025/09/12 01:12:29 INFO : a/b/c: Removing directory 2025/09/12 01:12:29 DEBUG : removing 1 level 2 directories 2025/09/12 01:12:29 INFO : a/b: Removing directory 2025/09/12 01:12:29 DEBUG : removing 1 level 1 directories 2025/09/12 01:12:29 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:30736") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:40458->172.17.0.4:30736, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:56710") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:50160->172.17.0.4:56710, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:64366") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:36322->172.17.0.4:64366, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:23239") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:47754->172.17.0.4:23239, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:57831") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:35044->172.17.0.4:57831, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:7539") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:46176->172.17.0.4:7539, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: Connecting to FTP server 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:21") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:37094->172.17.0.4:21, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:50257") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:39628->172.17.0.4:50257, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:52111") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:43478->172.17.0.4:52111, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:20192") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:36004->172.17.0.4:20192, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:37352") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:36468->172.17.0.4:37352, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:32149") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:58542->172.17.0.4:32149, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:54944") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:52094->172.17.0.4:54944, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:59717") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:48200->172.17.0.4:59717, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:18055") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:42184->172.17.0.4:18055, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:18922") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:37246->172.17.0.4:18922, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:25973") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:60318->172.17.0.4:25973, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:34174") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:46632->172.17.0.4:34174, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:51278") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:50514->172.17.0.4:51278, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:12304") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:40816->172.17.0.4:12304, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:8986") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:51918->172.17.0.4:8986, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:50429") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:36588->172.17.0.4:50429, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:54465") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:38202->172.17.0.4:54465, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:11459") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:45334->172.17.0.4:11459, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/09/12 01:12:29 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-senoqoz2soce" 2025/09/12 01:12:29 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/12 01:12:29 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:29 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{TZzW6}" suffix to name 2025/09/12 01:12:29 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:29 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: Connecting to FTP server 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: dial("tcp","172.17.0.4:21") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: > dial: conn=172.17.0.1:37110->172.17.0.4:21, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:64980") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:56138->172.17.0.4:64980, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: dial("tcp","172.17.0.4:61738") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: > dial: conn=172.17.0.1:41348->172.17.0.4:61738, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: dial("tcp","172.17.0.4:44729") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: > dial: conn=172.17.0.1:60316->172.17.0.4:44729, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: dial("tcp","172.17.0.4:14978") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: > dial: conn=172.17.0.1:44444->172.17.0.4:14978, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: dial("tcp","172.17.0.4:60955") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: > dial: conn=172.17.0.1:40556->172.17.0.4:60955, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: dial("tcp","172.17.0.4:43580") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: > dial: conn=172.17.0.1:60690->172.17.0.4:43580, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: dial("tcp","172.17.0.4:19475") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: > dial: conn=172.17.0.1:33464->172.17.0.4:19475, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: dial("tcp","172.17.0.4:19129") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: > dial: conn=172.17.0.1:42820->172.17.0.4:19129, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:48893") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:43844->172.17.0.4:48893, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:47133") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:60058->172.17.0.4:47133, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:27971") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:36304->172.17.0.4:27971, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:21515") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:33222->172.17.0.4:21515, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:47407") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:42918->172.17.0.4:47407, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: dial("tcp","172.17.0.4:36565") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: > dial: conn=172.17.0.1:44476->172.17.0.4:36565, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: dial("tcp","172.17.0.4:15396") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: > dial: conn=172.17.0.1:57048->172.17.0.4:15396, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: dial("tcp","172.17.0.4:41689") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: > dial: conn=172.17.0.1:33442->172.17.0.4:41689, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: dial("tcp","172.17.0.4:53921") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: > dial: conn=172.17.0.1:60712->172.17.0.4:53921, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: Purge dir "new_name" 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-senoqoz2soce: 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/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:61800") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:52302->172.17.0.4:61800, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:12287") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:38554->172.17.0.4:12287, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:49299") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:55696->172.17.0.4:49299, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:54463") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:54792->172.17.0.4:54463, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:10163") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:47118->172.17.0.4:10163, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:12988") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:41534->172.17.0.4:12988, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:22290") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:45590->172.17.0.4:22290, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:54755") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:40246->172.17.0.4:54755, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:38715") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:50336->172.17.0.4:38715, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/09/12 01:12:29 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-kuzayer3kuse/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/09/12 01:12:29 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/12 01:12:29 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:29 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{TZzW6}" suffix to name 2025/09/12 01:12:29 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:29 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:37118->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:39382") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:37420->172.17.0.4:39382, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/09/12 01:12:29 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-kuzayer3kuse/not found.txt" 2025/09/12 01:12:29 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/12 01:12:29 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:29 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{TZzW6}" suffix to name 2025/09/12 01:12:29 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:29 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/not found.txt: Connecting to FTP server 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/not found.txt: dial("tcp","172.17.0.4:21") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/not found.txt: > dial: conn=172.17.0.1:37120->172.17.0.4:21, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/not found.txt: dial("tcp","172.17.0.4:28586") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/not found.txt: > dial: conn=172.17.0.1:56342->172.17.0.4:28586, err= 2025/09/12 01:12:29 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-kuzayer3kuse" from "TestFTPProftpd:rclone-test-kuzayer3kuse" 2025/09/12 01:12:29 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/09/12 01:12:29 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/12 01:12:29 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:29 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{TZzW6}" suffix to name 2025/09/12 01:12:29 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:29 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37126->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:6591") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:40538->172.17.0.4:6591, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:29491") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:46550->172.17.0.4:29491, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:48964") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:51000->172.17.0.4:48964, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:6446") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:38292->172.17.0.4:6446, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:5406") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37528->172.17.0.4:5406, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:8493") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:43150->172.17.0.4:8493, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:45894") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:40680->172.17.0.4:45894, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:42608") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:42782->172.17.0.4:42608, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:19376") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:40896->172.17.0.4:19376, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:58940") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:48264->172.17.0.4:58940, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:36337") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:42104->172.17.0.4:36337, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:57146") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:48332->172.17.0.4:57146, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:3033") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:43156->172.17.0.4:3033, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:55384") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34734->172.17.0.4:55384, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:25728") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:40674->172.17.0.4:25728, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:16436") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56298->172.17.0.4:16436, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:43327") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34900->172.17.0.4:43327, 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/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:21128") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:55872->172.17.0.4:21128, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:60162") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:35318->172.17.0.4:60162, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:7610") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:35858->172.17.0.4:7610, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:58444") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:44184->172.17.0.4:58444, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:52486") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:38392->172.17.0.4:52486, 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/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:47269") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:49584->172.17.0.4:47269, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:53029") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:42432->172.17.0.4:53029, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/09/12 01:12:29 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-kuzayer3kuse" 2025/09/12 01:12:29 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/12 01:12:29 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:29 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{yPfc8}" suffix to name 2025/09/12 01:12:29 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:29 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: Connecting to FTP server 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:21") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:37134->172.17.0.4:21, err= 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:27704") 2025/09/12 01:12:29 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:34130->172.17.0.4:27704, 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/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:18282") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:40944->172.17.0.4:18282, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:42574") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:58816->172.17.0.4:42574, err= 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:2888") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:58732->172.17.0.4:2888, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/09/12 01:12:30 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-kuzayer3kuse/deeper/nonexisting/directory" 2025/09/12 01:12:30 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/12 01:12:30 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:30 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:30 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:30 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:30 DEBUG : TestFTPProftpd: detected overridden config - adding "{TZzW6}" suffix to name 2025/09/12 01:12:30 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/12 01:12:30 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/12 01:12:30 DEBUG : Setting pass="7tfJSzg3DFiV-EOVKecVTS_TNZXEIjgmUFxldmKeT11Bpg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/12 01:12:30 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/deeper/nonexisting/directory: Connecting to FTP server 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse/deeper/nonexisting/directory: > dial: conn=172.17.0.1:37148->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/12 01:12:30 DEBUG : Waiting for deletions to finish 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:8914") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:52346->172.17.0.4:8914, err= 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:10541") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:38512->172.17.0.4:10541, err= 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:50506") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:54882->172.17.0.4:50506, err= 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:41637") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:41048->172.17.0.4:41637, err= 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:47068") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:38666->172.17.0.4:47068, err= 2025/09/12 01:12:30 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:50889") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:49970->172.17.0.4:50889, err= 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:28100") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:43888->172.17.0.4:28100, err= 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:46284") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:43888->172.17.0.4:46284, err= 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:48989") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:44578->172.17.0.4:48989, err= 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:6839") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:36980->172.17.0.4:6839, err= 2025/09/12 01:12:30 DEBUG : removing 1 level 4 directories 2025/09/12 01:12:30 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/09/12 01:12:30 DEBUG : removing 1 level 3 directories 2025/09/12 01:12:30 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/09/12 01:12:30 DEBUG : removing 1 level 2 directories 2025/09/12 01:12:30 INFO : hello? sausage/êé: Removing directory 2025/09/12 01:12:30 DEBUG : removing 1 level 1 directories 2025/09/12 01:12:30 INFO : hello? sausage: Removing directory 2025/09/12 01:12:30 DEBUG : removing 1 level 0 directories 2025/09/12 01:12:30 INFO : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: Removing directory 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:42064") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:56750->172.17.0.4:42064, err= 2025/09/12 01:12:30 ERROR : error listing: directory not found 2025/09/12 01:12:30 DEBUG : Waiting for deletions to finish 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:19491") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:56604->172.17.0.4:19491, err= 2025/09/12 01:12:30 ERROR : error listing: directory not found 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: dial("tcp","172.17.0.4:45115") 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: > dial: conn=172.17.0.1:59680->172.17.0.4:45115, err= 2025/09/12 01:12:30 ERROR : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: Failed to list "": directory not found 2025/09/12 01:12:30 DEBUG : removing 1 level 0 directories 2025/09/12 01:12:30 INFO : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: Removing directory 2025/09/12 01:12:30 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/09/12 01:12:30 DEBUG : ftp://172.17.0.4:21/rclone-test-kuzayer3kuse: closing 2 unused connections --- PASS: TestIntegration (2.62s) --- 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.55s) --- 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.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.25s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.05s) --- 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.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 2.634s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 3.463427889s (try 1/5)