"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/09/04 03:51:39 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pekazeq1puxu" 2025/09/04 03:51:39 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/04 03:51:39 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/04 03:51:39 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:39 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:39 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:39 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:39 DEBUG : TestFTPProftpd: detected overridden config - adding "{GDsta}" suffix to name 2025/09/04 03:51:39 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:39 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:39 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:39 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: Connecting to FTP server 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:21") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:37192->172.17.0.4:21, err= 2025/09/04 03:51:39 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/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:42601") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:52104->172.17.0.4:42601, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:8461") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:54838->172.17.0.4:8461, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/09/04 03:51:39 INFO : dir/subdir: Making directory 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:21270") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:55260->172.17.0.4:21270, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:48786") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:60774->172.17.0.4:48786, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:41319") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:44498->172.17.0.4:41319, err= 2025/09/04 03:51:39 INFO : dir/subdir: Removing directory 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:51925") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:35872->172.17.0.4:51925, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:18655") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:36322->172.17.0.4:18655, err= 2025/09/04 03:51:39 INFO : dir: Removing directory 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:51929") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:34184->172.17.0.4:51929, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:7121") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:32870->172.17.0.4:7121, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:16432") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:34828->172.17.0.4:16432, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:19161") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:54990->172.17.0.4:19161, err= 2025/09/04 03:51:39 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/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:16675") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:43302->172.17.0.4:16675, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:41709") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:46528->172.17.0.4:41709, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:6189") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:40918->172.17.0.4:6189, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:3724") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:51454->172.17.0.4:3724, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:16682") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:49154->172.17.0.4:16682, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:56172") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:48284->172.17.0.4:56172, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:53950") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:44226->172.17.0.4:53950, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:19394") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:39962->172.17.0.4:19394, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:24239") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:39634->172.17.0.4:24239, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:15770") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:57064->172.17.0.4:15770, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:49146") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:46850->172.17.0.4:49146, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:54771") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:40792->172.17.0.4:54771, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:5220") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:38408->172.17.0.4:5220, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:48443") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:42848->172.17.0.4:48443, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:55599") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:35078->172.17.0.4:55599, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:18648") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:34872->172.17.0.4:18648, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:62443") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:55338->172.17.0.4:62443, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:64438") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:36892->172.17.0.4:64438, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:43869") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:35060->172.17.0.4:43869, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:43527") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:36700->172.17.0.4:43527, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:41505") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:40520->172.17.0.4:41505, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:51306") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:33244->172.17.0.4:51306, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:63774") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:37746->172.17.0.4:63774, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:24756") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:55348->172.17.0.4:24756, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:27091") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:45644->172.17.0.4:27091, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:50164") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:49458->172.17.0.4:50164, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:42388") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:38404->172.17.0.4:42388, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:13485") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:56038->172.17.0.4:13485, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:56261") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:50998->172.17.0.4:56261, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:57796") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:48490->172.17.0.4:57796, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:31622") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:33400->172.17.0.4:31622, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:7402") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:34242->172.17.0.4:7402, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:33971") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:47558->172.17.0.4:33971, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:36788") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:49472->172.17.0.4:36788, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:10103") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:42978->172.17.0.4:10103, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:49630") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:48804->172.17.0.4:49630, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:27426") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:38706->172.17.0.4:27426, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:63029") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:32884->172.17.0.4:63029, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:3489") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:51014->172.17.0.4:3489, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:50641") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:50090->172.17.0.4:50641, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:13265") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:42572->172.17.0.4:13265, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:51612") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:49008->172.17.0.4:51612, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:39878") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:44994->172.17.0.4:39878, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:17461") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:45462->172.17.0.4:17461, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:34520") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:51748->172.17.0.4:34520, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:29942") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:34066->172.17.0.4:29942, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:35086") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:37878->172.17.0.4:35086, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:31429") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:57708->172.17.0.4:31429, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:28846") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:60340->172.17.0.4:28846, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:13420") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:49458->172.17.0.4:13420, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:9422") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:58946->172.17.0.4:9422, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:4816") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:48180->172.17.0.4:4816, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:63703") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:38004->172.17.0.4:63703, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:7661") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:55006->172.17.0.4:7661, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:28549") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:56126->172.17.0.4:28549, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:25260") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:53834->172.17.0.4:25260, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:56802") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:38048->172.17.0.4:56802, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:5402") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:54212->172.17.0.4:5402, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:37721") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:55838->172.17.0.4:37721, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:47529") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:46564->172.17.0.4:47529, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:62175") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:60664->172.17.0.4:62175, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:3809") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:53928->172.17.0.4:3809, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:53908") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:60574->172.17.0.4:53908, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:30612") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:60158->172.17.0.4:30612, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:39574") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:33474->172.17.0.4:39574, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:62987") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:38960->172.17.0.4:62987, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:14707") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:37710->172.17.0.4:14707, err= 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:1465") 2025/09/04 03:51:39 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:50706->172.17.0.4:1465, err= 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:60481") 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:43746->172.17.0.4:60481, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:17172") 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:49208->172.17.0.4:17172, err= 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:51082") 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:60756->172.17.0.4:51082, err= 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:8212") 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:58874->172.17.0.4:8212, err= 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:3250") 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:55394->172.17.0.4:3250, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:25425") 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:52254->172.17.0.4:25425, err= 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:24650") 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:49752->172.17.0.4:24650, err= 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:36747") 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:40242->172.17.0.4:36747, err= 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:54344") 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:42648->172.17.0.4:54344, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:58712") 2025/09/04 03:51:40 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:44900->172.17.0.4:58712, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: Connecting to FTP server 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:21") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:37204->172.17.0.4:21, err= 2025/09/04 03:51:41 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:26689") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:47624->172.17.0.4:26689, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:16814") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:33300->172.17.0.4:16814, 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/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:17814") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:39302->172.17.0.4:17814, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:51934") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:36524->172.17.0.4:51934, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:20202") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:60294->172.17.0.4:20202, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:29564") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:39622->172.17.0.4:29564, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:11106") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:60538->172.17.0.4:11106, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:6970") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:50792->172.17.0.4:6970, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:41387") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:55966->172.17.0.4:41387, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:36086") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:45600->172.17.0.4:36086, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:39262") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:52018->172.17.0.4:39262, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:57058") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:56952->172.17.0.4:57058, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:5152") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:42300->172.17.0.4:5152, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:23825") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:44200->172.17.0.4:23825, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:4872") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:35752->172.17.0.4:4872, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:31087") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:41206->172.17.0.4:31087, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:6088") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:36168->172.17.0.4:6088, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:46692") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:37898->172.17.0.4:46692, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:25263") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:58570->172.17.0.4:25263, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/09/04 03:51:41 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/09/04 03:51:41 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/04 03:51:41 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:41 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:41 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:41 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:41 DEBUG : TestFTPProftpd: detected overridden config - adding "{GDsta}" suffix to name 2025/09/04 03:51:41 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:41 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:41 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:41 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37208->172.17.0.4:21, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:12791") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:33582->172.17.0.4:12791, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:54615") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:41288->172.17.0.4:54615, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:5742") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:48658->172.17.0.4:5742, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:64700") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:47272->172.17.0.4:64700, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:31979") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:58638->172.17.0.4:31979, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:21511") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:33522->172.17.0.4:21511, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:43167") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:55782->172.17.0.4:43167, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:27825") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:50632->172.17.0.4:27825, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:3291") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:40580->172.17.0.4:3291, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:17552") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:59572->172.17.0.4:17552, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:43813") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:47900->172.17.0.4:43813, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:36312") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:36626->172.17.0.4:36312, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:50372") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:40256->172.17.0.4:50372, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:4967") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:37102->172.17.0.4:4967, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:52103") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:58588->172.17.0.4:52103, 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/04 03:51:41 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pekazeq1puxu/hello? sausage/êé" 2025/09/04 03:51:41 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/04 03:51:41 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:41 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:41 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:41 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:41 DEBUG : TestFTPProftpd: detected overridden config - adding "{GDsta}" suffix to name 2025/09/04 03:51:41 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:41 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:41 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:41 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: Connecting to FTP server 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:37218->172.17.0.4:21, err= 2025/09/04 03:51:41 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-pekazeq1puxu/hello? sausage/êé" to be canonical "TestFTPProftpd{GDsta}:rclone-test-pekazeq1puxu/hello? sausage/êé" 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:50316") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:55814->172.17.0.4:50316, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:17193") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:46058->172.17.0.4:17193, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: Connecting to FTP server 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:13105") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:37232->172.17.0.4:21, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:56958->172.17.0.4:13105, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:50987") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:43648->172.17.0.4:50987, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:1604") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:52692->172.17.0.4:1604, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:12968") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:41438->172.17.0.4:12968, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:36558") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:40962->172.17.0.4:36558, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:40526") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:55626->172.17.0.4:40526, err= 2025/09/04 03:51:41 DEBUG : Waiting for deletions to finish 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:43856") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:59196->172.17.0.4:43856, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:48889") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:50734->172.17.0.4:48889, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:30119") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:46996->172.17.0.4:30119, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:3439") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:39636->172.17.0.4:3439, err= 2025/09/04 03:51:41 INFO : a/b/c/d/e.txt: Deleted 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:6291") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:42460->172.17.0.4:6291, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:6490") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:37152->172.17.0.4:6490, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:52334") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:34930->172.17.0.4:52334, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: dial("tcp","172.17.0.4:40357") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé: > dial: conn=172.17.0.1:46400->172.17.0.4:40357, err= 2025/09/04 03:51:41 DEBUG : removing 1 level 4 directories 2025/09/04 03:51:41 INFO : a/b/c/d: Removing directory 2025/09/04 03:51:41 DEBUG : removing 1 level 3 directories 2025/09/04 03:51:41 INFO : a/b/c: Removing directory 2025/09/04 03:51:41 DEBUG : removing 1 level 2 directories 2025/09/04 03:51:41 INFO : a/b: Removing directory 2025/09/04 03:51:41 DEBUG : removing 1 level 1 directories 2025/09/04 03:51:41 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:2652") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:56440->172.17.0.4:2652, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:55878") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:41776->172.17.0.4:55878, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:6770") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:50252->172.17.0.4:6770, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:31193") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:59694->172.17.0.4:31193, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:1449") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:40380->172.17.0.4:1449, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:12717") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:56908->172.17.0.4:12717, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: Connecting to FTP server 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:21") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:37242->172.17.0.4:21, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:7045") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:43786->172.17.0.4:7045, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:17354") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:51340->172.17.0.4:17354, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:36512") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:45354->172.17.0.4:36512, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:8318") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:55644->172.17.0.4:8318, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:50955") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:41988->172.17.0.4:50955, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:49774") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:50526->172.17.0.4:49774, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:63080") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:47076->172.17.0.4:63080, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:14987") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:53016->172.17.0.4:14987, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:40640") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:60400->172.17.0.4:40640, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:28530") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:48450->172.17.0.4:28530, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:9245") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:56850->172.17.0.4:9245, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:5137") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:37648->172.17.0.4:5137, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:58210") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:51422->172.17.0.4:58210, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:2417") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:46816->172.17.0.4:2417, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:29883") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:36022->172.17.0.4:29883, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:6192") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:41714->172.17.0.4:6192, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:8814") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:34806->172.17.0.4:8814, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/09/04 03:51:41 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zavegiy2zulu" 2025/09/04 03:51:41 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/04 03:51:41 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:41 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:41 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:41 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:41 DEBUG : TestFTPProftpd: detected overridden config - adding "{GDsta}" suffix to name 2025/09/04 03:51:41 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:41 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:41 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:41 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: Connecting to FTP server 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: dial("tcp","172.17.0.4:21") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: > dial: conn=172.17.0.1:37244->172.17.0.4:21, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:14309") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:40508->172.17.0.4:14309, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: dial("tcp","172.17.0.4:60125") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: > dial: conn=172.17.0.1:36078->172.17.0.4:60125, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: dial("tcp","172.17.0.4:11906") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: > dial: conn=172.17.0.1:58052->172.17.0.4:11906, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: dial("tcp","172.17.0.4:25644") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: > dial: conn=172.17.0.1:54516->172.17.0.4:25644, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: dial("tcp","172.17.0.4:5300") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: > dial: conn=172.17.0.1:48830->172.17.0.4:5300, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: dial("tcp","172.17.0.4:1371") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: > dial: conn=172.17.0.1:37558->172.17.0.4:1371, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: dial("tcp","172.17.0.4:34667") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: > dial: conn=172.17.0.1:41902->172.17.0.4:34667, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: dial("tcp","172.17.0.4:59122") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: > dial: conn=172.17.0.1:40962->172.17.0.4:59122, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:8774") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:60060->172.17.0.4:8774, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:48086") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:44500->172.17.0.4:48086, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:35020") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:42066->172.17.0.4:35020, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:30432") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:39516->172.17.0.4:30432, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:56839") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:44298->172.17.0.4:56839, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: dial("tcp","172.17.0.4:49716") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: > dial: conn=172.17.0.1:58792->172.17.0.4:49716, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: dial("tcp","172.17.0.4:46970") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: > dial: conn=172.17.0.1:53376->172.17.0.4:46970, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: dial("tcp","172.17.0.4:47723") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: > dial: conn=172.17.0.1:49658->172.17.0.4:47723, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: dial("tcp","172.17.0.4:9781") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: > dial: conn=172.17.0.1:56522->172.17.0.4:9781, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: Purge dir "new_name" 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-zavegiy2zulu: 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/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:3390") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:54530->172.17.0.4:3390, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:52804") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:57110->172.17.0.4:52804, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:29597") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:56426->172.17.0.4:29597, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:42955") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:43490->172.17.0.4:42955, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:34345") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:60470->172.17.0.4:34345, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:50548") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:38440->172.17.0.4:50548, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:48385") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:49644->172.17.0.4:48385, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:36181") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:35356->172.17.0.4:36181, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:27348") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:60264->172.17.0.4:27348, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/09/04 03:51:41 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pekazeq1puxu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/09/04 03:51:41 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/04 03:51:41 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:41 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:41 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:41 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:41 DEBUG : TestFTPProftpd: detected overridden config - adding "{GDsta}" suffix to name 2025/09/04 03:51:41 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:41 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:41 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:41 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:37252->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:6136") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:36348->172.17.0.4:6136, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/09/04 03:51:41 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pekazeq1puxu/not found.txt" 2025/09/04 03:51:41 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/04 03:51:41 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:41 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:41 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:41 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:41 DEBUG : TestFTPProftpd: detected overridden config - adding "{GDsta}" suffix to name 2025/09/04 03:51:41 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:41 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:41 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:41 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/not found.txt: Connecting to FTP server 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/not found.txt: dial("tcp","172.17.0.4:21") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/not found.txt: > dial: conn=172.17.0.1:37268->172.17.0.4:21, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/not found.txt: dial("tcp","172.17.0.4:19015") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/not found.txt: > dial: conn=172.17.0.1:35210->172.17.0.4:19015, err= 2025/09/04 03:51:41 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-pekazeq1puxu" from "TestFTPProftpd:rclone-test-pekazeq1puxu" 2025/09/04 03:51:41 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/09/04 03:51:41 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/04 03:51:41 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:41 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:41 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:41 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:41 DEBUG : TestFTPProftpd: detected overridden config - adding "{GDsta}" suffix to name 2025/09/04 03:51:41 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:41 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:41 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:41 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37276->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37678") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:59098->172.17.0.4:37678, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:6335") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:42324->172.17.0.4:6335, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37746") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58786->172.17.0.4:37746, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:56364") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:43274->172.17.0.4:56364, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:33093") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:53094->172.17.0.4:33093, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:55826") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:51958->172.17.0.4:55826, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:45419") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:50052->172.17.0.4:45419, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:17974") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:47770->172.17.0.4:17974, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:57585") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37132->172.17.0.4:57585, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:56617") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37586->172.17.0.4:56617, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:43393") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34834->172.17.0.4:43393, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:33600") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:52402->172.17.0.4:33600, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:63139") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:35700->172.17.0.4:63139, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:3503") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:39630->172.17.0.4:3503, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30278") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:36850->172.17.0.4:30278, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:60036") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56396->172.17.0.4:60036, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:56556") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58916->172.17.0.4:56556, 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/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:8781") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:43538->172.17.0.4:8781, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:51556") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:43656->172.17.0.4:51556, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:7230") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:45564->172.17.0.4:7230, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:27031") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:32916->172.17.0.4:27031, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:61146") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:58408->172.17.0.4:61146, 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/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:11048") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:43932->172.17.0.4:11048, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:29349") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:35288->172.17.0.4:29349, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/09/04 03:51:41 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-pekazeq1puxu" 2025/09/04 03:51:41 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/04 03:51:41 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:41 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:41 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:41 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:41 DEBUG : TestFTPProftpd: detected overridden config - adding "{mutSX}" suffix to name 2025/09/04 03:51:41 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:41 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:41 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:41 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: Connecting to FTP server 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:21") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:37280->172.17.0.4:21, err= 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:44460") 2025/09/04 03:51:41 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:32778->172.17.0.4:44460, 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/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:23758") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:54048->172.17.0.4:23758, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:39424") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:60642->172.17.0.4:39424, err= 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:55529") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:56936->172.17.0.4:55529, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/09/04 03:51:42 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-pekazeq1puxu/deeper/nonexisting/directory" 2025/09/04 03:51:42 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/09/04 03:51:42 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:42 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:42 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:42 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:42 DEBUG : TestFTPProftpd: detected overridden config - adding "{GDsta}" suffix to name 2025/09/04 03:51:42 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/09/04 03:51:42 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/09/04 03:51:42 DEBUG : Setting pass="GNzmlATFXEZin-i_qYWYn6hrLxqfYQv_z1UadfrU7NvLbA" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/09/04 03:51:42 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/deeper/nonexisting/directory: Connecting to FTP server 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:37282->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/04 03:51:42 DEBUG : Waiting for deletions to finish 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:46337") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:33936->172.17.0.4:46337, err= 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:24007") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:41624->172.17.0.4:24007, err= 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:8596") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:38118->172.17.0.4:8596, err= 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:58248") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:58780->172.17.0.4:58248, err= 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:43368") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:54326->172.17.0.4:43368, err= 2025/09/04 03:51:42 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:38208") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:38824->172.17.0.4:38208, err= 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:32905") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:43532->172.17.0.4:32905, err= 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:33128") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:56072->172.17.0.4:33128, err= 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:10224") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:56722->172.17.0.4:10224, err= 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:62372") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:58798->172.17.0.4:62372, err= 2025/09/04 03:51:42 DEBUG : removing 1 level 4 directories 2025/09/04 03:51:42 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/09/04 03:51:42 DEBUG : removing 1 level 3 directories 2025/09/04 03:51:42 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/09/04 03:51:42 DEBUG : removing 1 level 2 directories 2025/09/04 03:51:42 INFO : hello? sausage/êé: Removing directory 2025/09/04 03:51:42 DEBUG : removing 1 level 1 directories 2025/09/04 03:51:42 INFO : hello? sausage: Removing directory 2025/09/04 03:51:42 DEBUG : removing 1 level 0 directories 2025/09/04 03:51:42 INFO : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: Removing directory 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:48191") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:50808->172.17.0.4:48191, err= 2025/09/04 03:51:42 ERROR : error listing: directory not found 2025/09/04 03:51:42 DEBUG : Waiting for deletions to finish 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:33711") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:44824->172.17.0.4:33711, err= 2025/09/04 03:51:42 ERROR : error listing: directory not found 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: dial("tcp","172.17.0.4:49945") 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: > dial: conn=172.17.0.1:56492->172.17.0.4:49945, err= 2025/09/04 03:51:42 ERROR : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: Failed to list "": directory not found 2025/09/04 03:51:42 DEBUG : removing 1 level 0 directories 2025/09/04 03:51:42 INFO : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: Removing directory 2025/09/04 03:51:42 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/09/04 03:51:42 DEBUG : ftp://172.17.0.4:21/rclone-test-pekazeq1puxu: closing 2 unused connections --- PASS: TestIntegration (2.80s) --- 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.20s) --- 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.46s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.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.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.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.820s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 3.65732337s (try 1/5)