"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/10/14 03:51:00 NOTICE: TestFTPProftpd: Stopping server 2025/10/14 03:51:01 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 2/10 2025/10/14 03:51:01 NOTICE: TestFTPProftpd: Stopping server 2025/10/14 03:51:02 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 3/10 2025/10/14 03:51:02 NOTICE: TestFTPProftpd: Stopping server 2025/10/14 03:51:03 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 4/10 2025/10/14 03:51:03 NOTICE: TestFTPProftpd: Stopping server 2025/10/14 03:51:04 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 5/10 2025/10/14 03:51:04 NOTICE: TestFTPProftpd: Stopping server 2025/10/14 03:51:05 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 6/10 2025/10/14 03:51:05 NOTICE: TestFTPProftpd: Stopping server 2025/10/14 03:51:06 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 7/10 2025/10/14 03:51:06 NOTICE: TestFTPProftpd: Stopping server 2025/10/14 03:51:07 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 8/10 2025/10/14 03:51:07 NOTICE: TestFTPProftpd: Stopping server 2025/10/14 03:51:08 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 9/10 2025/10/14 03:51:08 NOTICE: TestFTPProftpd: Stopping server 2025/10/14 03:51:09 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 10/10 2025/10/14 03:51:09 NOTICE: TestFTPProftpd: Stopping server 2025/10/14 03:51:09 NOTICE: TestFTPProftpd: Starting server 2025/10/14 03:51:11 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.3:21" try 1/100 2025/10/14 03:51:11 DEBUG : TestFTPProftpd: Read 1, error: 2025/10/14 03:51:11 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.3:21" 2025/10/14 03:51:11 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-cecigum3yasa" 2025/10/14 03:51:11 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/14 03:51:11 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/14 03:51:11 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:11 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:11 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:11 DEBUG : TestFTPProftpd: detected overridden config - adding "{tOt7r}" suffix to name 2025/10/14 03:51:11 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:11 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:11 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:11 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: Connecting to FTP server 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:21") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:46392->172.17.0.3:21, err= 2025/10/14 03:51:11 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/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:41086") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:45546->172.17.0.3:41086, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:13700") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:58286->172.17.0.3:13700, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/10/14 03:51:11 INFO : dir/subdir: Making directory 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:3473") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:50448->172.17.0.3:3473, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:12956") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:59452->172.17.0.3:12956, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:20851") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:54838->172.17.0.3:20851, err= 2025/10/14 03:51:11 INFO : dir/subdir: Removing directory 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:20813") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:59104->172.17.0.3:20813, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:60118") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:49568->172.17.0.3:60118, err= 2025/10/14 03:51:11 INFO : dir: Removing directory 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:15848") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:47786->172.17.0.3:15848, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:29690") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:45556->172.17.0.3:29690, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:2431") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:47444->172.17.0.3:2431, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:36082") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:42276->172.17.0.3:36082, err= 2025/10/14 03:51:11 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/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:37051") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:55154->172.17.0.3:37051, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:16419") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:56876->172.17.0.3:16419, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:24086") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:49392->172.17.0.3:24086, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:38920") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:36146->172.17.0.3:38920, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:16151") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:48186->172.17.0.3:16151, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:14527") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:41942->172.17.0.3:14527, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:53287") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:59956->172.17.0.3:53287, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:24875") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:32940->172.17.0.3:24875, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:14225") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:58748->172.17.0.3:14225, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:33981") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:35982->172.17.0.3:33981, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:50889") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:60244->172.17.0.3:50889, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:28883") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:49760->172.17.0.3:28883, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:20577") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:46040->172.17.0.3:20577, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:26223") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:56850->172.17.0.3:26223, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:34078") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:35066->172.17.0.3:34078, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:20064") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:48318->172.17.0.3:20064, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:38967") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:39482->172.17.0.3:38967, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:19378") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:53036->172.17.0.3:19378, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:1673") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:46876->172.17.0.3:1673, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:53048") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:49400->172.17.0.3:53048, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:59441") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:36490->172.17.0.3:59441, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:14350") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:39742->172.17.0.3:14350, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:55497") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:43290->172.17.0.3:55497, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:6863") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:55946->172.17.0.3:6863, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:34177") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:41974->172.17.0.3:34177, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:10776") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:57278->172.17.0.3:10776, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:1446") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:49930->172.17.0.3:1446, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:49002") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:35086->172.17.0.3:49002, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:39442") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:37824->172.17.0.3:39442, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:2853") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:59158->172.17.0.3:2853, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:19550") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:41706->172.17.0.3:19550, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:10958") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:39032->172.17.0.3:10958, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:18248") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:54002->172.17.0.3:18248, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:42612") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:42792->172.17.0.3:42612, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:48854") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:32786->172.17.0.3:48854, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:33376") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:55728->172.17.0.3:33376, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:56115") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:60016->172.17.0.3:56115, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:36606") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:59286->172.17.0.3:36606, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:57227") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:52714->172.17.0.3:57227, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:4806") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:44686->172.17.0.3:4806, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:5053") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:52340->172.17.0.3:5053, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:42581") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:39582->172.17.0.3:42581, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:32666") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:53138->172.17.0.3:32666, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:24606") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:54036->172.17.0.3:24606, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:3270") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:37654->172.17.0.3:3270, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:1209") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:59036->172.17.0.3:1209, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:43647") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:48974->172.17.0.3:43647, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:41214") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:59596->172.17.0.3:41214, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:19564") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:45664->172.17.0.3:19564, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:44296") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:44142->172.17.0.3:44296, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:28727") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:41282->172.17.0.3:28727, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:13471") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:48680->172.17.0.3:13471, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:57623") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:52324->172.17.0.3:57623, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:18690") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:38098->172.17.0.3:18690, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:19310") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:59972->172.17.0.3:19310, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:26266") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:32798->172.17.0.3:26266, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:28442") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:50532->172.17.0.3:28442, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:19732") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:49060->172.17.0.3:19732, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:9733") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:60398->172.17.0.3:9733, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:2349") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:53954->172.17.0.3:2349, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:21562") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:51852->172.17.0.3:21562, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:28260") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:49332->172.17.0.3:28260, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:12284") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:34600->172.17.0.3:12284, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:38787") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:57350->172.17.0.3:38787, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:5337") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:59626->172.17.0.3:5337, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:60114") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:53406->172.17.0.3:60114, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:6628") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:40010->172.17.0.3:6628, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:60429") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:41144->172.17.0.3:60429, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:31186") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:38328->172.17.0.3:31186, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:62831") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:53678->172.17.0.3:62831, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:64212") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:47088->172.17.0.3:64212, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:35215") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:41686->172.17.0.3:35215, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:39878") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:38700->172.17.0.3:39878, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:31344") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:37422->172.17.0.3:31344, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:58798") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:48998->172.17.0.3:58798, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:42125") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:53494->172.17.0.3:42125, err= 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:31529") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:52110->172.17.0.3:31529, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:36911") 2025/10/14 03:51:11 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:53862->172.17.0.3:36911, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: Connecting to FTP server 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:21") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:46402->172.17.0.3:21, err= 2025/10/14 03:51:12 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:35532") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:34968->172.17.0.3:35532, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:61499") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:46014->172.17.0.3:61499, 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/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:40130") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:56918->172.17.0.3:40130, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:38114") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:41198->172.17.0.3:38114, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:6587") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:50486->172.17.0.3:6587, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:4525") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:57988->172.17.0.3:4525, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:20485") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:59434->172.17.0.3:20485, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:8325") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:47780->172.17.0.3:8325, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:39027") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:32918->172.17.0.3:39027, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:49762") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:59336->172.17.0.3:49762, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:17067") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:36220->172.17.0.3:17067, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:62721") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:52060->172.17.0.3:62721, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:52760") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:52328->172.17.0.3:52760, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:6766") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:57386->172.17.0.3:6766, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:51814") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:38374->172.17.0.3:51814, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:26995") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:39064->172.17.0.3:26995, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:45564") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:58982->172.17.0.3:45564, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:56956") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:34448->172.17.0.3:56956, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:19393") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:48922->172.17.0.3:19393, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/10/14 03:51:12 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/10/14 03:51:12 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/14 03:51:12 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:12 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:12 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:12 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:12 DEBUG : TestFTPProftpd: detected overridden config - adding "{tOt7r}" suffix to name 2025/10/14 03:51:12 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:12 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:12 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:12 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:46416->172.17.0.3:21, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:14335") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:43330->172.17.0.3:14335, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:28546") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:47182->172.17.0.3:28546, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:51058") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:37378->172.17.0.3:51058, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:13805") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:54742->172.17.0.3:13805, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:45054") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:57786->172.17.0.3:45054, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:64865") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:42674->172.17.0.3:64865, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:12445") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:33310->172.17.0.3:12445, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:20698") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:47264->172.17.0.3:20698, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:27495") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:36114->172.17.0.3:27495, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:33062") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:49052->172.17.0.3:33062, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:51020") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:42268->172.17.0.3:51020, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:15137") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:44486->172.17.0.3:15137, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:49126") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:46618->172.17.0.3:49126, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:21017") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:37762->172.17.0.3:21017, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:11101") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:59564->172.17.0.3:11101, 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/14 03:51:12 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-cecigum3yasa/hello? sausage/êé" 2025/10/14 03:51:12 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/14 03:51:12 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:12 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:12 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:12 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:12 DEBUG : TestFTPProftpd: detected overridden config - adding "{tOt7r}" suffix to name 2025/10/14 03:51:12 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:12 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:12 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:12 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: Connecting to FTP server 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:46424->172.17.0.3:21, err= 2025/10/14 03:51:12 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-cecigum3yasa/hello? sausage/êé" to be canonical "TestFTPProftpd{tOt7r}:rclone-test-cecigum3yasa/hello? sausage/êé" 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:44320") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:49404->172.17.0.3:44320, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:24642") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:43452->172.17.0.3:24642, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: Connecting to FTP server 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:46440->172.17.0.3:21, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:62051") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:48914->172.17.0.3:62051, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:30924") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:58844->172.17.0.3:30924, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:25329") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:48568->172.17.0.3:25329, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:35417") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:48728->172.17.0.3:35417, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:65127") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:41516->172.17.0.3:65127, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:51939") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:45456->172.17.0.3:51939, err= 2025/10/14 03:51:12 DEBUG : Waiting for deletions to finish 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:12009") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:50316->172.17.0.3:12009, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:55008") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:46132->172.17.0.3:55008, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:47988") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:47564->172.17.0.3:47988, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:64357") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:58808->172.17.0.3:64357, err= 2025/10/14 03:51:12 INFO : a/b/c/d/e.txt: Deleted 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:46573") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:35836->172.17.0.3:46573, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:54792") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:51744->172.17.0.3:54792, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:49112") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:52218->172.17.0.3:49112, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: dial("tcp","172.17.0.3:54091") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé: > dial: conn=172.17.0.1:54130->172.17.0.3:54091, err= 2025/10/14 03:51:12 DEBUG : removing 1 level 4 directories 2025/10/14 03:51:12 INFO : a/b/c/d: Removing directory 2025/10/14 03:51:12 DEBUG : removing 1 level 3 directories 2025/10/14 03:51:12 INFO : a/b/c: Removing directory 2025/10/14 03:51:12 DEBUG : removing 1 level 2 directories 2025/10/14 03:51:12 INFO : a/b: Removing directory 2025/10/14 03:51:12 DEBUG : removing 1 level 1 directories 2025/10/14 03:51:12 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:23722") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:34112->172.17.0.3:23722, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:58107") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:41598->172.17.0.3:58107, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:16665") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:43746->172.17.0.3:16665, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:27223") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:56130->172.17.0.3:27223, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:13057") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:35046->172.17.0.3:13057, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:23966") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:56806->172.17.0.3:23966, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: Connecting to FTP server 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:21") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:65226") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:46446->172.17.0.3:21, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:35384->172.17.0.3:65226, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:53352") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:59712->172.17.0.3:53352, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:61796") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:56392->172.17.0.3:61796, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:20815") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:53694->172.17.0.3:20815, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:40009") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:56346->172.17.0.3:40009, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:25051") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:41014->172.17.0.3:25051, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:45322") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:62412") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:37654->172.17.0.3:62412, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:35974->172.17.0.3:45322, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:49021") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:48510->172.17.0.3:49021, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:3399") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:35158->172.17.0.3:3399, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:45752") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:59036->172.17.0.3:45752, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:52732") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:50082->172.17.0.3:52732, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:48692") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:41708->172.17.0.3:48692, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:38666") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:57780->172.17.0.3:38666, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:10482") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:45726->172.17.0.3:10482, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:59321") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:60388->172.17.0.3:59321, err= 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:25781") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:51982->172.17.0.3:25781, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/10/14 03:51:12 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-mibejik1some" 2025/10/14 03:51:12 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/14 03:51:12 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:12 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:12 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:12 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:12 DEBUG : TestFTPProftpd: detected overridden config - adding "{tOt7r}" suffix to name 2025/10/14 03:51:12 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:12 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:12 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:12 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: Connecting to FTP server 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: dial("tcp","172.17.0.3:21") 2025/10/14 03:51:12 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: > dial: conn=172.17.0.1:46458->172.17.0.3:21, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:29494") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:45826->172.17.0.3:29494, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: dial("tcp","172.17.0.3:33132") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: > dial: conn=172.17.0.1:56136->172.17.0.3:33132, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: dial("tcp","172.17.0.3:61514") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: > dial: conn=172.17.0.1:35960->172.17.0.3:61514, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: dial("tcp","172.17.0.3:2753") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: > dial: conn=172.17.0.1:48520->172.17.0.3:2753, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: dial("tcp","172.17.0.3:41867") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: > dial: conn=172.17.0.1:34378->172.17.0.3:41867, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: dial("tcp","172.17.0.3:34231") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: > dial: conn=172.17.0.1:50120->172.17.0.3:34231, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: dial("tcp","172.17.0.3:16782") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: > dial: conn=172.17.0.1:36864->172.17.0.3:16782, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: dial("tcp","172.17.0.3:26946") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: > dial: conn=172.17.0.1:45410->172.17.0.3:26946, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:40113") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:47454->172.17.0.3:40113, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:28376") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:50828->172.17.0.3:28376, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:28852") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:44324->172.17.0.3:28852, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:36402") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:39198->172.17.0.3:36402, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:53304") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:58048->172.17.0.3:53304, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: dial("tcp","172.17.0.3:16426") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: > dial: conn=172.17.0.1:50318->172.17.0.3:16426, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: dial("tcp","172.17.0.3:43114") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: > dial: conn=172.17.0.1:39442->172.17.0.3:43114, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: dial("tcp","172.17.0.3:20990") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: > dial: conn=172.17.0.1:40616->172.17.0.3:20990, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: dial("tcp","172.17.0.3:63489") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: > dial: conn=172.17.0.1:44854->172.17.0.3:63489, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: Purge dir "new_name" 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-mibejik1some: 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/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:18914") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:32986->172.17.0.3:18914, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:65030") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:49662->172.17.0.3:65030, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:44069") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:60676->172.17.0.3:44069, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:25637") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:50508->172.17.0.3:25637, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:54797") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:35344->172.17.0.3:54797, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:41633") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:37430->172.17.0.3:41633, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:32823") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:46054->172.17.0.3:32823, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:24967") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:43682->172.17.0.3:24967, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:53055") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:60812->172.17.0.3:53055, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/10/14 03:51:13 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-cecigum3yasa/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/10/14 03:51:13 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/14 03:51:13 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:13 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:13 DEBUG : TestFTPProftpd: detected overridden config - adding "{tOt7r}" suffix to name 2025/10/14 03:51:13 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:13 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:21") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:46462->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:37597") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:57326->172.17.0.3:37597, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/10/14 03:51:13 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-cecigum3yasa/not found.txt" 2025/10/14 03:51:13 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/14 03:51:13 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:13 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:13 DEBUG : TestFTPProftpd: detected overridden config - adding "{tOt7r}" suffix to name 2025/10/14 03:51:13 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:13 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/not found.txt: Connecting to FTP server 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/not found.txt: dial("tcp","172.17.0.3:21") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/not found.txt: > dial: conn=172.17.0.1:46464->172.17.0.3:21, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/not found.txt: dial("tcp","172.17.0.3:16956") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/not found.txt: > dial: conn=172.17.0.1:40006->172.17.0.3:16956, err= 2025/10/14 03:51:13 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-cecigum3yasa" from "TestFTPProftpd:rclone-test-cecigum3yasa" 2025/10/14 03:51:13 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/10/14 03:51:13 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/14 03:51:13 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:13 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:13 DEBUG : TestFTPProftpd: detected overridden config - adding "{tOt7r}" suffix to name 2025/10/14 03:51:13 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:13 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:46466->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:19372") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:59250->172.17.0.3:19372, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:22735") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:36164->172.17.0.3:22735, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:12084") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:47464->172.17.0.3:12084, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:53016") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:52704->172.17.0.3:53016, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33552") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:46824->172.17.0.3:33552, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:63812") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:42644->172.17.0.3:63812, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:35873") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:59460->172.17.0.3:35873, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:2148") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:40664->172.17.0.3:2148, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:62787") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:51620->172.17.0.3:62787, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:59234") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:44098->172.17.0.3:59234, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:56006") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:41908->172.17.0.3:56006, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33390") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:43176->172.17.0.3:33390, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:5831") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:38420->172.17.0.3:5831, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:51977") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:34320->172.17.0.3:51977, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:53265") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:58300->172.17.0.3:53265, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:11230") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:50838->172.17.0.3:11230, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:48361") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56156->172.17.0.3:48361, 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/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:17961") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:50360->172.17.0.3:17961, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:52498") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:43224->172.17.0.3:52498, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:41916") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:42812->172.17.0.3:41916, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:51439") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:44626->172.17.0.3:51439, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:53937") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:60664->172.17.0.3:53937, 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/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:52983") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:45000->172.17.0.3:52983, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:20582") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:45332->172.17.0.3:20582, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/10/14 03:51:13 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-cecigum3yasa" 2025/10/14 03:51:13 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/14 03:51:13 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:13 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:13 DEBUG : TestFTPProftpd: detected overridden config - adding "{8laIZ}" suffix to name 2025/10/14 03:51:13 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:13 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: Connecting to FTP server 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:21") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:46476->172.17.0.3:21, err= 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:7726") 2025/10/14 03:51:13 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:58248->172.17.0.3:7726, 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/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:28323") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:39802->172.17.0.3:28323, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:15646") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:35598->172.17.0.3:15646, err= 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:37983") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:58636->172.17.0.3:37983, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/14 03:51:14 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-cecigum3yasa/deeper/nonexisting/directory" 2025/10/14 03:51:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/14 03:51:14 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:14 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{tOt7r}" suffix to name 2025/10/14 03:51:14 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/14 03:51:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/14 03:51:14 DEBUG : Setting pass="O3PgCwesrvYj-FlL-G2bp3wH6xI3RkzmUlIJn4EX5nV8qw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/14 03:51:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/deeper/nonexisting/directory: Connecting to FTP server 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/deeper/nonexisting/directory: dial("tcp","172.17.0.3:21") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa/deeper/nonexisting/directory: > dial: conn=172.17.0.1:46482->172.17.0.3: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/14 03:51:14 DEBUG : Waiting for deletions to finish 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:58378") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:53232->172.17.0.3:58378, err= 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:1041") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:56232->172.17.0.3:1041, err= 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:1566") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:51716->172.17.0.3:1566, err= 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:4174") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:37934->172.17.0.3:4174, err= 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:15741") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:40886->172.17.0.3:15741, err= 2025/10/14 03:51:14 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:57976") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:42884->172.17.0.3:57976, err= 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:25377") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:39258->172.17.0.3:25377, err= 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:11119") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:52146->172.17.0.3:11119, err= 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:8461") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:48110->172.17.0.3:8461, err= 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:26872") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:57014->172.17.0.3:26872, err= 2025/10/14 03:51:14 DEBUG : removing 1 level 4 directories 2025/10/14 03:51:14 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/10/14 03:51:14 DEBUG : removing 1 level 3 directories 2025/10/14 03:51:14 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/10/14 03:51:14 DEBUG : removing 1 level 2 directories 2025/10/14 03:51:14 INFO : hello? sausage/êé: Removing directory 2025/10/14 03:51:14 DEBUG : removing 1 level 1 directories 2025/10/14 03:51:14 INFO : hello? sausage: Removing directory 2025/10/14 03:51:14 DEBUG : removing 1 level 0 directories 2025/10/14 03:51:14 INFO : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: Removing directory 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:50549") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:50928->172.17.0.3:50549, err= 2025/10/14 03:51:14 ERROR : error listing: directory not found 2025/10/14 03:51:14 DEBUG : Waiting for deletions to finish 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:56366") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:43128->172.17.0.3:56366, err= 2025/10/14 03:51:14 ERROR : error listing: directory not found 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: dial("tcp","172.17.0.3:26760") 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: > dial: conn=172.17.0.1:34120->172.17.0.3:26760, err= 2025/10/14 03:51:14 ERROR : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: Failed to list "": directory not found 2025/10/14 03:51:14 DEBUG : removing 1 level 0 directories 2025/10/14 03:51:14 INFO : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: Removing directory 2025/10/14 03:51:14 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/10/14 03:51:14 DEBUG : ftp://172.17.0.3:21/rclone-test-cecigum3yasa: closing 2 unused connections 2025/10/14 03:51:14 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (14.86s) --- 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.66s) --- 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.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.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 14.881s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 15.690829732s (try 1/5)