"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/10/30 03:17:53 NOTICE: TestFTPProftpd: Stopping server 2025/10/30 03:17:54 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 2/10 2025/10/30 03:17:54 NOTICE: TestFTPProftpd: Stopping server 2025/10/30 03:17:55 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 3/10 2025/10/30 03:17:55 NOTICE: TestFTPProftpd: Stopping server 2025/10/30 03:17:56 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 4/10 2025/10/30 03:17:57 NOTICE: TestFTPProftpd: Stopping server 2025/10/30 03:17:58 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 5/10 2025/10/30 03:17:58 NOTICE: TestFTPProftpd: Stopping server 2025/10/30 03:17:59 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 6/10 2025/10/30 03:17:59 NOTICE: TestFTPProftpd: Stopping server 2025/10/30 03:18:00 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 7/10 2025/10/30 03:18:00 NOTICE: TestFTPProftpd: Stopping server 2025/10/30 03:18:01 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 8/10 2025/10/30 03:18:01 NOTICE: TestFTPProftpd: Stopping server 2025/10/30 03:18:02 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 9/10 2025/10/30 03:18:02 NOTICE: TestFTPProftpd: Stopping server 2025/10/30 03:18:03 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 10/10 2025/10/30 03:18:03 NOTICE: TestFTPProftpd: Stopping server 2025/10/30 03:18:03 NOTICE: TestFTPProftpd: Starting server 2025/10/30 03:18:04 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.2:21" try 1/100 2025/10/30 03:18:04 DEBUG : TestFTPProftpd: Read 1, error: 2025/10/30 03:18:04 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.2:21" 2025/10/30 03:18:04 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zugeluc0sutu" 2025/10/30 03:18:04 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/30 03:18:04 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/30 03:18:04 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:04 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{6cuJx}" suffix to name 2025/10/30 03:18:04 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:04 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:04 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: Connecting to FTP server 2025/10/30 03:18:04 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:21") 2025/10/30 03:18:04 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:57366->172.17.0.2:21, err= 2025/10/30 03:18:05 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/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:37014") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:36586->172.17.0.2:37014, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:23873") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:57436->172.17.0.2:23873, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/10/30 03:18:05 INFO : dir/subdir: Making directory 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:2159") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:47116->172.17.0.2:2159, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:57008") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:43682->172.17.0.2:57008, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:23860") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:43866->172.17.0.2:23860, err= 2025/10/30 03:18:05 INFO : dir/subdir: Removing directory 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:36910") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:33770->172.17.0.2:36910, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:24595") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:48688->172.17.0.2:24595, err= 2025/10/30 03:18:05 INFO : dir: Removing directory 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:57404") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:51442->172.17.0.2:57404, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:50790") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:32818->172.17.0.2:50790, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:45655") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:52724->172.17.0.2:45655, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:48431") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:47026->172.17.0.2:48431, err= 2025/10/30 03:18:05 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/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:51921") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:59904->172.17.0.2:51921, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:16757") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:59108->172.17.0.2:16757, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:22521") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:36474->172.17.0.2:22521, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:31770") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:52422->172.17.0.2:31770, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:35078") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:57228->172.17.0.2:35078, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:12924") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:41860->172.17.0.2:12924, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:11921") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:35012->172.17.0.2:11921, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:56212") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:59702->172.17.0.2:56212, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:57390") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:53118->172.17.0.2:57390, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:43309") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:55784->172.17.0.2:43309, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:50178") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:42662->172.17.0.2:50178, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:42903") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:56988->172.17.0.2:42903, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:56680") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:50958->172.17.0.2:56680, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:56990") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:47400->172.17.0.2:56990, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:48827") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:56018->172.17.0.2:48827, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:4375") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:60246->172.17.0.2:4375, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:32989") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:51444->172.17.0.2:32989, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:47636") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:52472->172.17.0.2:47636, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:37777") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:43948->172.17.0.2:37777, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:22147") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:43120->172.17.0.2:22147, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:19115") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:36956->172.17.0.2:19115, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:60627") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:50320->172.17.0.2:60627, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:23283") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:38206->172.17.0.2:23283, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:10589") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:35548->172.17.0.2:10589, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:18953") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:42126->172.17.0.2:18953, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:59169") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:52358->172.17.0.2:59169, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:34160") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:59458->172.17.0.2:34160, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:10823") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:40318->172.17.0.2:10823, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:44425") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:36724->172.17.0.2:44425, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:14281") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:35764->172.17.0.2:14281, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:58230") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:41394->172.17.0.2:58230, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:30811") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:42098->172.17.0.2:30811, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:30015") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:55538->172.17.0.2:30015, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:15216") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:41088->172.17.0.2:15216, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:61557") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:53334->172.17.0.2:61557, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:64069") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:44062->172.17.0.2:64069, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:27117") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:54556->172.17.0.2:27117, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:7944") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:45596->172.17.0.2:7944, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:54746") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:58220->172.17.0.2:54746, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:18972") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:57252->172.17.0.2:18972, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:50229") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:40760->172.17.0.2:50229, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:39390") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:34458->172.17.0.2:39390, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:60852") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:35362->172.17.0.2:60852, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:41375") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:40402->172.17.0.2:41375, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:30846") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:50864->172.17.0.2:30846, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:44144") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:51742->172.17.0.2:44144, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:44727") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:44416->172.17.0.2:44727, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:62811") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:39638->172.17.0.2:62811, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:26245") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:44494->172.17.0.2:26245, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:16970") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:44330->172.17.0.2:16970, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:19424") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:46224->172.17.0.2:19424, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:44337") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:38384->172.17.0.2:44337, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:12062") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:60338->172.17.0.2:12062, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:41683") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:47140->172.17.0.2:41683, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:53902") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:52130->172.17.0.2:53902, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:29992") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:54164->172.17.0.2:29992, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:35317") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:43414->172.17.0.2:35317, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:22528") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:56178->172.17.0.2:22528, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:39791") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:45228->172.17.0.2:39791, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:14208") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:45940->172.17.0.2:14208, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:35785") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:37132->172.17.0.2:35785, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:32486") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:33564->172.17.0.2:32486, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:43996") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:40884->172.17.0.2:43996, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:64776") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:59732->172.17.0.2:64776, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:46679") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:40502->172.17.0.2:46679, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:40019") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:43624->172.17.0.2:40019, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:63311") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:37338->172.17.0.2:63311, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:8261") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:36970->172.17.0.2:8261, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:46939") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:35666->172.17.0.2:46939, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:52523") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:43956->172.17.0.2:52523, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:26210") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:56300->172.17.0.2:26210, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:31634") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:44514->172.17.0.2:31634, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:26379") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:40010->172.17.0.2:26379, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:21527") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:45084->172.17.0.2:21527, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:7475") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:54378->172.17.0.2:7475, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:56201") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:50350->172.17.0.2:56201, err= 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:64647") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:34246->172.17.0.2:64647, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:51178") 2025/10/30 03:18:05 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:55096->172.17.0.2:51178, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: Connecting to FTP server 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:21") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:56844->172.17.0.2:21, err= 2025/10/30 03:18:06 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:55000") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:48658->172.17.0.2:55000, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:7500") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:47372->172.17.0.2:7500, 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/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:34463") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:56718->172.17.0.2:34463, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:34056") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:46350->172.17.0.2:34056, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:39652") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:39876->172.17.0.2:39652, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:17318") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:39228->172.17.0.2:17318, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:4376") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:52980->172.17.0.2:4376, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:37902") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:60492->172.17.0.2:37902, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:22818") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:49036->172.17.0.2:22818, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:10388") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:46024->172.17.0.2:10388, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:55818") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:33318->172.17.0.2:55818, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:23705") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:55682->172.17.0.2:23705, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:62472") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:46398->172.17.0.2:62472, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:28581") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:41578->172.17.0.2:28581, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:47792") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:40428->172.17.0.2:47792, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:18043") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:56918->172.17.0.2:18043, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:20805") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:45146->172.17.0.2:20805, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:36647") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:58880->172.17.0.2:36647, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:39628") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:33892->172.17.0.2:39628, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/10/30 03:18:06 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/10/30 03:18:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/30 03:18:06 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:06 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{6cuJx}" suffix to name 2025/10/30 03:18:06 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:06 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:56848->172.17.0.2:21, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:26044") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:59066->172.17.0.2:26044, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:6801") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:39574->172.17.0.2:6801, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:13934") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:47200->172.17.0.2:13934, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:52263") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:51060->172.17.0.2:52263, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:10248") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:44042->172.17.0.2:10248, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:17739") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:33988->172.17.0.2:17739, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:15645") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:42996->172.17.0.2:15645, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:60973") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:48704->172.17.0.2:60973, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:38047") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:34850->172.17.0.2:38047, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:7117") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:46240->172.17.0.2:7117, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:56928") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:50714->172.17.0.2:56928, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:36133") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:35970->172.17.0.2:36133, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:26732") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:52346->172.17.0.2:26732, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:46394") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:45992->172.17.0.2:46394, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:42610") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:41416->172.17.0.2:42610, 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/10/30 03:18:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zugeluc0sutu/hello? sausage/êé" 2025/10/30 03:18:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/30 03:18:06 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:06 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{6cuJx}" suffix to name 2025/10/30 03:18:06 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:06 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: Connecting to FTP server 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:56858->172.17.0.2:21, err= 2025/10/30 03:18:06 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-zugeluc0sutu/hello? sausage/êé" to be canonical "TestFTPProftpd{6cuJx}:rclone-test-zugeluc0sutu/hello? sausage/êé" 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:47479") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:39064->172.17.0.2:47479, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:4500") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:57680->172.17.0.2:4500, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: Connecting to FTP server 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:56864->172.17.0.2:21, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:16330") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:57456->172.17.0.2:16330, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:28738") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:54746->172.17.0.2:28738, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:55126") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:43198->172.17.0.2:55126, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:42668") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:40414->172.17.0.2:42668, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:14069") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:36794->172.17.0.2:14069, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:11713") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:56822->172.17.0.2:11713, err= 2025/10/30 03:18:06 DEBUG : Waiting for deletions to finish 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:27286") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:38626->172.17.0.2:27286, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:62015") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:51318->172.17.0.2:62015, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:31144") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:35682->172.17.0.2:31144, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:39292") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:38718->172.17.0.2:39292, err= 2025/10/30 03:18:06 INFO : a/b/c/d/e.txt: Deleted 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:10879") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:35742->172.17.0.2:10879, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:13342") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:36804->172.17.0.2:13342, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:54062") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:41494->172.17.0.2:54062, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: dial("tcp","172.17.0.2:50579") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé: > dial: conn=172.17.0.1:37460->172.17.0.2:50579, err= 2025/10/30 03:18:06 DEBUG : removing 1 level 4 directories 2025/10/30 03:18:06 INFO : a/b/c/d: Removing directory 2025/10/30 03:18:06 DEBUG : removing 1 level 3 directories 2025/10/30 03:18:06 INFO : a/b/c: Removing directory 2025/10/30 03:18:06 DEBUG : removing 1 level 2 directories 2025/10/30 03:18:06 INFO : a/b: Removing directory 2025/10/30 03:18:06 DEBUG : removing 1 level 1 directories 2025/10/30 03:18:06 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:60171") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:37082->172.17.0.2:60171, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:14916") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:41824->172.17.0.2:14916, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:16727") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:32956->172.17.0.2:16727, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:11955") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:43350->172.17.0.2:11955, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:18268") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:53576->172.17.0.2:18268, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:53606") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:58174->172.17.0.2:53606, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: Connecting to FTP server 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:21") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:56874->172.17.0.2:21, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:33750") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:57408->172.17.0.2:33750, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:8501") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:40302->172.17.0.2:8501, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:27633") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:43560->172.17.0.2:27633, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:2204") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:58786->172.17.0.2:2204, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:43890") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:34432->172.17.0.2:43890, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:31158") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:57990->172.17.0.2:31158, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:56432") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:50934->172.17.0.2:56432, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:56622") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:53186->172.17.0.2:56622, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:24570") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:44774->172.17.0.2:24570, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:6946") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:44062->172.17.0.2:6946, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:6936") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:53250->172.17.0.2:6936, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:4338") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:43932->172.17.0.2:4338, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:38689") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:52426") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:50870->172.17.0.2:38689, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:59148->172.17.0.2:52426, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:54915") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:34626->172.17.0.2:54915, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:41590") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:39888->172.17.0.2:41590, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:56747") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:38440->172.17.0.2:56747, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/10/30 03:18:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-xuharac0lita" 2025/10/30 03:18:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/30 03:18:06 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:06 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{6cuJx}" suffix to name 2025/10/30 03:18:06 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:06 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: Connecting to FTP server 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: dial("tcp","172.17.0.2:21") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: > dial: conn=172.17.0.1:56888->172.17.0.2:21, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:26718") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:58534->172.17.0.2:26718, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: dial("tcp","172.17.0.2:11002") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: > dial: conn=172.17.0.1:55476->172.17.0.2:11002, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: dial("tcp","172.17.0.2:8996") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: > dial: conn=172.17.0.1:38696->172.17.0.2:8996, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: dial("tcp","172.17.0.2:58015") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: > dial: conn=172.17.0.1:36078->172.17.0.2:58015, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: dial("tcp","172.17.0.2:26280") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: > dial: conn=172.17.0.1:48986->172.17.0.2:26280, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: dial("tcp","172.17.0.2:46970") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: > dial: conn=172.17.0.1:41870->172.17.0.2:46970, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: dial("tcp","172.17.0.2:46558") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: > dial: conn=172.17.0.1:43102->172.17.0.2:46558, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: dial("tcp","172.17.0.2:53407") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: > dial: conn=172.17.0.1:51910->172.17.0.2:53407, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:17620") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:37970->172.17.0.2:17620, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:9802") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:43680->172.17.0.2:9802, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:14352") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:56380->172.17.0.2:14352, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:15683") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:55098->172.17.0.2:15683, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:9524") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:58796->172.17.0.2:9524, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: dial("tcp","172.17.0.2:35835") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: > dial: conn=172.17.0.1:45750->172.17.0.2:35835, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: dial("tcp","172.17.0.2:23872") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: > dial: conn=172.17.0.1:58120->172.17.0.2:23872, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: dial("tcp","172.17.0.2:11918") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: > dial: conn=172.17.0.1:59808->172.17.0.2:11918, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: dial("tcp","172.17.0.2:39785") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: > dial: conn=172.17.0.1:50772->172.17.0.2:39785, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: Purge dir "new_name" 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-xuharac0lita: 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/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:32496") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:39432->172.17.0.2:32496, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:22712") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:37862->172.17.0.2:22712, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:2411") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:58438->172.17.0.2:2411, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:5169") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:58596->172.17.0.2:5169, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:41720") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:57236->172.17.0.2:41720, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:54916") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:53222->172.17.0.2:54916, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:54819") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:60344->172.17.0.2:54819, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:2939") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:59354->172.17.0.2:2939, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:1745") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:43022->172.17.0.2:1745, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/10/30 03:18:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zugeluc0sutu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/10/30 03:18:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/30 03:18:06 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:06 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{6cuJx}" suffix to name 2025/10/30 03:18:06 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:06 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:21") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:56904->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:46975") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:38612->172.17.0.2:46975, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/10/30 03:18:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zugeluc0sutu/not found.txt" 2025/10/30 03:18:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/30 03:18:06 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:06 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{6cuJx}" suffix to name 2025/10/30 03:18:06 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:06 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/not found.txt: Connecting to FTP server 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/not found.txt: dial("tcp","172.17.0.2:21") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/not found.txt: > dial: conn=172.17.0.1:56910->172.17.0.2:21, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/not found.txt: dial("tcp","172.17.0.2:40385") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/not found.txt: > dial: conn=172.17.0.1:59034->172.17.0.2:40385, err= 2025/10/30 03:18:06 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-zugeluc0sutu" from "TestFTPProftpd:rclone-test-zugeluc0sutu" 2025/10/30 03:18:06 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/10/30 03:18:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/30 03:18:06 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:06 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{6cuJx}" suffix to name 2025/10/30 03:18:06 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:06 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:56916->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:17467") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:38332->172.17.0.2:17467, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:1621") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:56476->172.17.0.2:1621, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:22635") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:59816->172.17.0.2:22635, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:29637") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:45432->172.17.0.2:29637, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:18977") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:44460->172.17.0.2:18977, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:48977") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50102->172.17.0.2:48977, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:12470") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:49610->172.17.0.2:12470, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:64595") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:55518->172.17.0.2:64595, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:1949") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:55606->172.17.0.2:1949, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:37667") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:48348->172.17.0.2:37667, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:15113") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:38286->172.17.0.2:15113, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:30025") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:39842->172.17.0.2:30025, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:22220") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:56302->172.17.0.2:22220, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:59493") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:49458->172.17.0.2:59493, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:44914") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:47858->172.17.0.2:44914, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:36860") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:37370->172.17.0.2:36860, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:19589") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:55756->172.17.0.2:19589, 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/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:39428") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:34206->172.17.0.2:39428, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:44049") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:53788->172.17.0.2:44049, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:17032") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:45644->172.17.0.2:17032, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:34474") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:59172->172.17.0.2:34474, err= 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:37159") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:48626->172.17.0.2:37159, 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/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:11941") 2025/10/30 03:18:06 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:50956->172.17.0.2:11941, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:35036") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:45820->172.17.0.2:35036, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/10/30 03:18:07 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-zugeluc0sutu" 2025/10/30 03:18:07 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/30 03:18:07 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:07 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:07 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:07 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:07 DEBUG : TestFTPProftpd: detected overridden config - adding "{H8w37}" suffix to name 2025/10/30 03:18:07 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:07 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:07 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:07 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: Connecting to FTP server 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:21") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:56930->172.17.0.2:21, err= 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:20987") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:52498->172.17.0.2:20987, 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/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:23126") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:42720->172.17.0.2:23126, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:28553") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:41134->172.17.0.2:28553, err= 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:34500") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:40602->172.17.0.2:34500, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/30 03:18:07 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zugeluc0sutu/deeper/nonexisting/directory" 2025/10/30 03:18:07 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/30 03:18:07 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:07 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:07 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:07 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:07 DEBUG : TestFTPProftpd: detected overridden config - adding "{6cuJx}" suffix to name 2025/10/30 03:18:07 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/30 03:18:07 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/30 03:18:07 DEBUG : Setting pass="FIETehB4op_lRcF7AG3dJDUkf_vy9qxEi1GYQiITu3oGvg" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/30 03:18:07 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/deeper/nonexisting/directory: Connecting to FTP server 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/deeper/nonexisting/directory: dial("tcp","172.17.0.2:21") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:56940->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/10/30 03:18:07 DEBUG : Waiting for deletions to finish 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:47050") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:44732->172.17.0.2:47050, err= 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:54898") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:57556->172.17.0.2:54898, err= 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:48834") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:37456->172.17.0.2:48834, err= 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:28374") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:46096->172.17.0.2:28374, err= 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:9413") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:58308->172.17.0.2:9413, err= 2025/10/30 03:18:07 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:12654") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:45546->172.17.0.2:12654, err= 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:24125") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:47156->172.17.0.2:24125, err= 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:11613") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:48174->172.17.0.2:11613, err= 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:43471") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:53382->172.17.0.2:43471, err= 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:14456") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:55706->172.17.0.2:14456, err= 2025/10/30 03:18:07 DEBUG : removing 1 level 4 directories 2025/10/30 03:18:07 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/10/30 03:18:07 DEBUG : removing 1 level 3 directories 2025/10/30 03:18:07 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/10/30 03:18:07 DEBUG : removing 1 level 2 directories 2025/10/30 03:18:07 INFO : hello? sausage/êé: Removing directory 2025/10/30 03:18:07 DEBUG : removing 1 level 1 directories 2025/10/30 03:18:07 INFO : hello? sausage: Removing directory 2025/10/30 03:18:07 DEBUG : removing 1 level 0 directories 2025/10/30 03:18:07 INFO : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: Removing directory 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:32217") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:36154->172.17.0.2:32217, err= 2025/10/30 03:18:07 ERROR : error listing: directory not found 2025/10/30 03:18:07 DEBUG : Waiting for deletions to finish 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:23305") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:33082->172.17.0.2:23305, err= 2025/10/30 03:18:07 ERROR : error listing: directory not found 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: dial("tcp","172.17.0.2:22128") 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: > dial: conn=172.17.0.1:33308->172.17.0.2:22128, err= 2025/10/30 03:18:07 ERROR : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: Failed to list "": directory not found 2025/10/30 03:18:07 DEBUG : removing 1 level 0 directories 2025/10/30 03:18:07 INFO : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: Removing directory 2025/10/30 03:18:07 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/10/30 03:18:07 DEBUG : ftp://172.17.0.2:21/rclone-test-zugeluc0sutu: closing 2 unused connections 2025/10/30 03:18:08 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (15.02s) --- 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.77s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.02s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.24s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.02s) --- 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.41s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.09s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.06s) --- 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.06s) --- 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.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.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 15.041s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 15.927944503s (try 1/5)