"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/12/20 02:38:02 NOTICE: TestFTPProftpd: Starting server 2025/12/20 02:38:03 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.9:21" try 1/100 2025/12/20 02:38:03 DEBUG : TestFTPProftpd: Read 1, error: 2025/12/20 02:38:03 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.9:21" 2025/12/20 02:38:03 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-fotovuw0cibu" 2025/12/20 02:38:03 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/20 02:38:03 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/20 02:38:03 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:03 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:03 DEBUG : TestFTPProftpd: detected overridden config - adding "{g8x2g}" suffix to name 2025/12/20 02:38:03 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:03 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: Connecting to FTP server 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:21") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:49958->172.17.0.9:21, err= 2025/12/20 02:38:03 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/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:53004") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:40304->172.17.0.9:53004, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:14340") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:44684->172.17.0.9:14340, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/12/20 02:38:03 INFO : dir/subdir: Making directory 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:9601") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:40498->172.17.0.9:9601, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:40233") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:47526->172.17.0.9:40233, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:54501") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:51898->172.17.0.9:54501, err= 2025/12/20 02:38:03 INFO : dir/subdir: Removing directory 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:13774") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:59540->172.17.0.9:13774, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:10373") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:36516->172.17.0.9:10373, err= 2025/12/20 02:38:03 INFO : dir: Removing directory 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:22220") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:59686->172.17.0.9:22220, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:24679") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:55606->172.17.0.9:24679, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:61405") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:54198->172.17.0.9:61405, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:12140") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:35906->172.17.0.9:12140, err= 2025/12/20 02:38:03 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/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:55265") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:44432->172.17.0.9:55265, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:29447") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:49016->172.17.0.9:29447, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:52592") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:44972->172.17.0.9:52592, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:21988") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:37676->172.17.0.9:21988, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:50885") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:50250->172.17.0.9:50885, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:61952") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:59042->172.17.0.9:61952, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:49705") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:45578->172.17.0.9:49705, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:59847") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:60498->172.17.0.9:59847, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:59657") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:55248->172.17.0.9:59657, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:50543") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:51488->172.17.0.9:50543, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:63138") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:59234->172.17.0.9:63138, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:18569") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:47032->172.17.0.9:18569, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:62059") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:53910->172.17.0.9:62059, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:23545") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:59234->172.17.0.9:23545, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:44856") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:40198->172.17.0.9:44856, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:15069") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:54258->172.17.0.9:15069, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:2254") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:34696->172.17.0.9:2254, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:50310") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:50282->172.17.0.9:50310, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:50283") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:59420->172.17.0.9:50283, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:35129") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:44456->172.17.0.9:35129, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:37780") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:37018->172.17.0.9:37780, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:63599") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:42428->172.17.0.9:63599, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:43706") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:47770->172.17.0.9:43706, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:12478") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:60588->172.17.0.9:12478, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:52566") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:58286->172.17.0.9:52566, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:56457") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:37450->172.17.0.9:56457, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:21827") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:59058->172.17.0.9:21827, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:9251") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:42778->172.17.0.9:9251, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:15601") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:43126->172.17.0.9:15601, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:17698") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:52224->172.17.0.9:17698, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:20368") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:34128->172.17.0.9:20368, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:5331") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:60742->172.17.0.9:5331, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:46121") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:47100->172.17.0.9:46121, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:7425") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:52702->172.17.0.9:7425, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:26295") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:44856->172.17.0.9:26295, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:31472") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:45432->172.17.0.9:31472, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:3843") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:44948->172.17.0.9:3843, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:10466") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:41356->172.17.0.9:10466, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:25784") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:39638->172.17.0.9:25784, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:62476") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:52622->172.17.0.9:62476, err= 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:59985") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:47458->172.17.0.9:59985, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:23388") 2025/12/20 02:38:03 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:57016->172.17.0.9:23388, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:15510") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:33070->172.17.0.9:15510, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:56510") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:36708->172.17.0.9:56510, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:45910") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:50338->172.17.0.9:45910, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:59342") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:60996->172.17.0.9:59342, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:6045") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:35894->172.17.0.9:6045, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:47140") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:50566->172.17.0.9:47140, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:44118") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:45668->172.17.0.9:44118, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:55304") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:52190->172.17.0.9:55304, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:16735") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:59934->172.17.0.9:16735, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:16363") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:44784->172.17.0.9:16363, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:53369") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:56362->172.17.0.9:53369, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:59418") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:55072->172.17.0.9:59418, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:27818") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:54176->172.17.0.9:27818, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:40401") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:39826->172.17.0.9:40401, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:50340") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:47242->172.17.0.9:50340, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:48621") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:52324->172.17.0.9:48621, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:48628") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:33576->172.17.0.9:48628, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:64917") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:51318->172.17.0.9:64917, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:65296") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:54586->172.17.0.9:65296, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:3462") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:58866->172.17.0.9:3462, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:4713") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:51718->172.17.0.9:4713, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:45882") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:50354->172.17.0.9:45882, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:9864") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:55474->172.17.0.9:9864, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:29985") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:55414->172.17.0.9:29985, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:11819") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:46338->172.17.0.9:11819, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:12683") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:58858->172.17.0.9:12683, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:39427") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:49266->172.17.0.9:39427, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:36579") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:59034->172.17.0.9:36579, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:9625") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:34634->172.17.0.9:9625, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:33878") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:54042->172.17.0.9:33878, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:58944") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:42352->172.17.0.9:58944, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:24112") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:59256->172.17.0.9:24112, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:24854") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:37404->172.17.0.9:24854, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:39319") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:44502->172.17.0.9:39319, err= 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:17920") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:42140->172.17.0.9:17920, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:29875") 2025/12/20 02:38:04 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:44622->172.17.0.9:29875, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: Connecting to FTP server 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:21") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:56336->172.17.0.9:21, err= 2025/12/20 02:38:05 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:28648") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:46950->172.17.0.9:28648, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:30562") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:51874->172.17.0.9:30562, 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/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:49599") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:52002->172.17.0.9:49599, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:62660") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:60746->172.17.0.9:62660, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:27966") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:33858->172.17.0.9:27966, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:62649") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:50448->172.17.0.9:62649, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:35192") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:40010->172.17.0.9:35192, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:35429") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:41928->172.17.0.9:35429, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:2096") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:59860->172.17.0.9:2096, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:58815") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:38934->172.17.0.9:58815, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:59783") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:46652->172.17.0.9:59783, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:27309") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:52980->172.17.0.9:27309, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:46586") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:54072->172.17.0.9:46586, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:26607") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:50920->172.17.0.9:26607, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:3068") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:59282->172.17.0.9:3068, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:2839") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:38592->172.17.0.9:2839, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:52692") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:36904->172.17.0.9:52692, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:23638") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:55830->172.17.0.9:23638, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:18867") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:44540->172.17.0.9:18867, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/12/20 02:38:05 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/12/20 02:38:05 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/20 02:38:05 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:05 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{g8x2g}" suffix to name 2025/12/20 02:38:05 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:05 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: Connecting to FTP server 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:21") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:56352->172.17.0.9:21, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:11606") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:42408->172.17.0.9:11606, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:18426") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:54790->172.17.0.9:18426, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:22120") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:47412->172.17.0.9:22120, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:12818") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:42014->172.17.0.9:12818, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:20951") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:33252->172.17.0.9:20951, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:2138") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:57052->172.17.0.9:2138, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:9860") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:48882->172.17.0.9:9860, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:11047") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:53512->172.17.0.9:11047, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:16845") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:51384->172.17.0.9:16845, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:12502") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:55466->172.17.0.9:12502, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:63634") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:46830->172.17.0.9:63634, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:24305") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:54954->172.17.0.9:24305, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:63323") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:57342->172.17.0.9:63323, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:26748") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:49508->172.17.0.9:26748, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:53844") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:52488->172.17.0.9:53844, 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/12/20 02:38:05 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-fotovuw0cibu/hello? sausage/êé" 2025/12/20 02:38:05 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/20 02:38:05 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:05 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{g8x2g}" suffix to name 2025/12/20 02:38:05 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:05 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: Connecting to FTP server 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:21") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:56356->172.17.0.9:21, err= 2025/12/20 02:38:05 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-fotovuw0cibu/hello? sausage/êé" to be canonical "TestFTPProftpd{g8x2g}:rclone-test-fotovuw0cibu/hello? sausage/êé" 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:39829") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:35502->172.17.0.9:39829, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:4346") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:55406->172.17.0.9:4346, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: Connecting to FTP server 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:21") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:56368->172.17.0.9:21, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:21581") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:40220->172.17.0.9:21581, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:50140") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:53794->172.17.0.9:50140, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:15266") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:36316->172.17.0.9:15266, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:2634") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:43638->172.17.0.9:2634, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:61865") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:57950->172.17.0.9:61865, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:4219") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:51230->172.17.0.9:4219, err= 2025/12/20 02:38:05 DEBUG : Waiting for deletions to finish 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:36919") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:59242->172.17.0.9:36919, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:52719") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:36610->172.17.0.9:52719, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:7473") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:49528->172.17.0.9:7473, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:29747") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:57282->172.17.0.9:29747, err= 2025/12/20 02:38:05 INFO : a/b/c/d/e.txt: Deleted 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:13763") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:55592->172.17.0.9:13763, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:27764") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:39046->172.17.0.9:27764, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:23490") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:33716->172.17.0.9:23490, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: dial("tcp","172.17.0.9:48653") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé: > dial: conn=172.17.0.1:46372->172.17.0.9:48653, err= 2025/12/20 02:38:05 DEBUG : removing 1 level 4 directories 2025/12/20 02:38:05 INFO : a/b/c/d: Removing directory 2025/12/20 02:38:05 DEBUG : removing 1 level 3 directories 2025/12/20 02:38:05 INFO : a/b/c: Removing directory 2025/12/20 02:38:05 DEBUG : removing 1 level 2 directories 2025/12/20 02:38:05 INFO : a/b: Removing directory 2025/12/20 02:38:05 DEBUG : removing 1 level 1 directories 2025/12/20 02:38:05 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:47387") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:55876->172.17.0.9:47387, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:23874") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:51568->172.17.0.9:23874, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:16275") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:46274->172.17.0.9:16275, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:44501") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:60686->172.17.0.9:44501, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:58043") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:48642->172.17.0.9:58043, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:50681") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:48568->172.17.0.9:50681, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: Connecting to FTP server 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:21") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:56376->172.17.0.9:21, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:45574") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:55948->172.17.0.9:45574, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:10248") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:38734->172.17.0.9:10248, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:51324") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:44248->172.17.0.9:51324, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:57840") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:48922->172.17.0.9:57840, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:44930") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:37530->172.17.0.9:44930, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:37185") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:40926->172.17.0.9:37185, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:7348") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:50652->172.17.0.9:7348, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:2383") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:54126->172.17.0.9:2383, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:32375") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:46764->172.17.0.9:32375, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:39129") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:43036->172.17.0.9:39129, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:6003") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:50126->172.17.0.9:6003, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:37237") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:53148->172.17.0.9:37237, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:9393") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:58558->172.17.0.9:9393, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:37512") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:60618->172.17.0.9:37512, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:34190") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:41438->172.17.0.9:34190, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:24858") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:56448->172.17.0.9:24858, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:57671") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:41906->172.17.0.9:57671, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/12/20 02:38:05 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-wixaman4lova" 2025/12/20 02:38:05 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/20 02:38:05 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:05 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{g8x2g}" suffix to name 2025/12/20 02:38:05 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:05 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: Connecting to FTP server 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: dial("tcp","172.17.0.9:21") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: > dial: conn=172.17.0.1:56384->172.17.0.9:21, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:60604") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:60530->172.17.0.9:60604, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: dial("tcp","172.17.0.9:56213") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: > dial: conn=172.17.0.1:46264->172.17.0.9:56213, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: dial("tcp","172.17.0.9:47271") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: > dial: conn=172.17.0.1:60428->172.17.0.9:47271, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: dial("tcp","172.17.0.9:3053") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: > dial: conn=172.17.0.1:53010->172.17.0.9:3053, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: dial("tcp","172.17.0.9:56471") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: > dial: conn=172.17.0.1:60342->172.17.0.9:56471, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: dial("tcp","172.17.0.9:55703") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: > dial: conn=172.17.0.1:38860->172.17.0.9:55703, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: dial("tcp","172.17.0.9:44868") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: > dial: conn=172.17.0.1:47826->172.17.0.9:44868, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: dial("tcp","172.17.0.9:49256") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: > dial: conn=172.17.0.1:47950->172.17.0.9:49256, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:32008") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:47408->172.17.0.9:32008, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:37206") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:46660->172.17.0.9:37206, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:52034") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:34854->172.17.0.9:52034, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:35334") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:43432->172.17.0.9:35334, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:10562") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:49872->172.17.0.9:10562, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: dial("tcp","172.17.0.9:10135") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: > dial: conn=172.17.0.1:38154->172.17.0.9:10135, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: dial("tcp","172.17.0.9:34207") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: > dial: conn=172.17.0.1:52858->172.17.0.9:34207, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: dial("tcp","172.17.0.9:32451") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: > dial: conn=172.17.0.1:60226->172.17.0.9:32451, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: dial("tcp","172.17.0.9:7729") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: > dial: conn=172.17.0.1:44082->172.17.0.9:7729, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: Purge dir "new_name" 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-wixaman4lova: 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/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:9756") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:58984->172.17.0.9:9756, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:5163") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:38506->172.17.0.9:5163, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:4836") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:33386->172.17.0.9:4836, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:53104") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:49770->172.17.0.9:53104, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:17656") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:60954->172.17.0.9:17656, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:63828") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:43268->172.17.0.9:63828, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:30490") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:60896->172.17.0.9:30490, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:54218") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:47482->172.17.0.9:54218, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:8154") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:39790->172.17.0.9:8154, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/12/20 02:38:05 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-fotovuw0cibu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/12/20 02:38:05 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/20 02:38:05 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:05 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{g8x2g}" suffix to name 2025/12/20 02:38:05 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:05 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.9:21") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:56398->172.17.0.9:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.9:16536") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:49318->172.17.0.9:16536, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/12/20 02:38:05 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-fotovuw0cibu/not found.txt" 2025/12/20 02:38:05 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/20 02:38:05 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:05 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{g8x2g}" suffix to name 2025/12/20 02:38:05 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:05 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/not found.txt: Connecting to FTP server 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/not found.txt: dial("tcp","172.17.0.9:21") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/not found.txt: > dial: conn=172.17.0.1:56400->172.17.0.9:21, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/not found.txt: dial("tcp","172.17.0.9:29907") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/not found.txt: > dial: conn=172.17.0.1:32934->172.17.0.9:29907, err= 2025/12/20 02:38:05 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-fotovuw0cibu" from "TestFTPProftpd:rclone-test-fotovuw0cibu" 2025/12/20 02:38:05 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/12/20 02:38:05 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/20 02:38:05 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:05 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{g8x2g}" suffix to name 2025/12/20 02:38:05 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:05 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: Connecting to FTP server 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:21") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:56416->172.17.0.9:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:40431") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:49454->172.17.0.9:40431, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:22310") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:51918->172.17.0.9:22310, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:34119") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:53050->172.17.0.9:34119, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:11766") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:53742->172.17.0.9:11766, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:41435") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:42216->172.17.0.9:41435, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:48217") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:33554->172.17.0.9:48217, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:39370") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:58572->172.17.0.9:39370, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:7465") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:34706->172.17.0.9:7465, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:15785") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:34208->172.17.0.9:15785, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:62526") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:46388->172.17.0.9:62526, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:47010") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:47104->172.17.0.9:47010, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:43853") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:59528->172.17.0.9:43853, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:37628") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:35454->172.17.0.9:37628, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:16097") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:59746->172.17.0.9:16097, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:39437") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:38744->172.17.0.9:39437, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:64997") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:37482->172.17.0.9:64997, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: dial("tcp","172.17.0.9:24985") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21: > dial: conn=172.17.0.1:55818->172.17.0.9:24985, 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/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:54905") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:57318->172.17.0.9:54905, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:40513") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:34342->172.17.0.9:40513, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:18066") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:45552->172.17.0.9:18066, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:5529") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:58532->172.17.0.9:5529, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:49170") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:59812->172.17.0.9:49170, 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/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:7259") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:54462->172.17.0.9:7259, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:19632") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:49864->172.17.0.9:19632, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/12/20 02:38:05 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-fotovuw0cibu" 2025/12/20 02:38:05 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/20 02:38:05 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:05 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{IR_SY}" suffix to name 2025/12/20 02:38:05 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:05 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: Connecting to FTP server 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:21") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:56420->172.17.0.9:21, err= 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:35819") 2025/12/20 02:38:05 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:41922->172.17.0.9:35819, 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/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:63225") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:60960->172.17.0.9:63225, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:35677") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:35670->172.17.0.9:35677, err= 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:38613") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:43006->172.17.0.9:38613, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/12/20 02:38:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-fotovuw0cibu/deeper/nonexisting/directory" 2025/12/20 02:38:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/12/20 02:38:06 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:06 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{g8x2g}" suffix to name 2025/12/20 02:38:06 DEBUG : Setting host="172.17.0.9" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/12/20 02:38:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/12/20 02:38:06 DEBUG : Setting pass="mfosPDnRnCExy6OLa3ccXYK72jSTI4zDjoj9BNkWNz0Dxg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/12/20 02:38:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/deeper/nonexisting/directory: Connecting to FTP server 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/deeper/nonexisting/directory: dial("tcp","172.17.0.9:21") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:56430->172.17.0.9: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/12/20 02:38:06 DEBUG : Waiting for deletions to finish 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:8320") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:53766->172.17.0.9:8320, err= 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:28810") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:58180->172.17.0.9:28810, err= 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:25463") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:41264->172.17.0.9:25463, err= 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:17420") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:43220->172.17.0.9:17420, err= 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:47397") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:59974->172.17.0.9:47397, err= 2025/12/20 02:38:06 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:64338") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:38290->172.17.0.9:64338, err= 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:2260") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:39300->172.17.0.9:2260, err= 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:17120") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:49580->172.17.0.9:17120, err= 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:2773") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:40376->172.17.0.9:2773, err= 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:63783") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:43646->172.17.0.9:63783, err= 2025/12/20 02:38:06 DEBUG : removing 1 level 4 directories 2025/12/20 02:38:06 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/12/20 02:38:06 DEBUG : removing 1 level 3 directories 2025/12/20 02:38:06 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/12/20 02:38:06 DEBUG : removing 1 level 2 directories 2025/12/20 02:38:06 INFO : hello? sausage/êé: Removing directory 2025/12/20 02:38:06 DEBUG : removing 1 level 1 directories 2025/12/20 02:38:06 INFO : hello? sausage: Removing directory 2025/12/20 02:38:06 DEBUG : removing 1 level 0 directories 2025/12/20 02:38:06 INFO : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: Removing directory 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:22677") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:44756->172.17.0.9:22677, err= 2025/12/20 02:38:06 ERROR : error listing: directory not found 2025/12/20 02:38:06 DEBUG : Waiting for deletions to finish 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:2758") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:50338->172.17.0.9:2758, err= 2025/12/20 02:38:06 ERROR : error listing: directory not found 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: dial("tcp","172.17.0.9:32371") 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: > dial: conn=172.17.0.1:36032->172.17.0.9:32371, err= 2025/12/20 02:38:06 ERROR : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: Failed to list "": directory not found 2025/12/20 02:38:06 DEBUG : removing 1 level 0 directories 2025/12/20 02:38:06 INFO : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: Removing directory 2025/12/20 02:38:06 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/12/20 02:38:06 DEBUG : ftp://172.17.0.9:21/rclone-test-fotovuw0cibu: closing 2 unused connections 2025/12/20 02:38:06 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (4.07s) --- 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.79s) --- 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.17s) --- 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.51s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- 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.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.28s) --- 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.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.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.02s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 4.088s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 5.149546152s (try 1/5)