"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/10/11 01:00:52 NOTICE: TestFTPProftpd: Stopping server 2025/10/11 01:00:53 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 2/10 2025/10/11 01:00:53 NOTICE: TestFTPProftpd: Stopping server 2025/10/11 01:00:54 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 3/10 2025/10/11 01:00:54 NOTICE: TestFTPProftpd: Stopping server 2025/10/11 01:00:55 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 4/10 2025/10/11 01:00:55 NOTICE: TestFTPProftpd: Stopping server 2025/10/11 01:00:56 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 5/10 2025/10/11 01:00:56 NOTICE: TestFTPProftpd: Stopping server 2025/10/11 01:00:57 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 6/10 2025/10/11 01:00:57 NOTICE: TestFTPProftpd: Stopping server 2025/10/11 01:00:58 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 7/10 2025/10/11 01:00:58 NOTICE: TestFTPProftpd: Stopping server 2025/10/11 01:00:59 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 8/10 2025/10/11 01:00:59 NOTICE: TestFTPProftpd: Stopping server 2025/10/11 01:01:00 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 9/10 2025/10/11 01:01:00 NOTICE: TestFTPProftpd: Stopping server 2025/10/11 01:01:01 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 10/10 2025/10/11 01:01:01 NOTICE: TestFTPProftpd: Stopping server 2025/10/11 01:01:01 NOTICE: TestFTPProftpd: Starting server 2025/10/11 01:01:03 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.5:21" try 1/100 2025/10/11 01:01:03 DEBUG : TestFTPProftpd: Read 1, error: 2025/10/11 01:01:03 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.5:21" 2025/10/11 01:01:03 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-yereged2joyo" 2025/10/11 01:01:03 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/11 01:01:03 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/11 01:01:03 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:03 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:03 DEBUG : TestFTPProftpd: detected overridden config - adding "{Vs3Fm}" suffix to name 2025/10/11 01:01:03 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:03 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: Connecting to FTP server 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:21") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:39564->172.17.0.5:21, err= 2025/10/11 01:01:03 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:22566") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:60196->172.17.0.5:22566, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:47724") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:39038->172.17.0.5:47724, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/10/11 01:01:03 INFO : dir/subdir: Making directory 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:43865") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:36662->172.17.0.5:43865, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:5299") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:49852->172.17.0.5:5299, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:57831") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:34294->172.17.0.5:57831, err= 2025/10/11 01:01:03 INFO : dir/subdir: Removing directory 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:27751") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:52134->172.17.0.5:27751, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:13565") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:39412->172.17.0.5:13565, err= 2025/10/11 01:01:03 INFO : dir: Removing directory 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:17456") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:42026->172.17.0.5:17456, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:59031") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:44570->172.17.0.5:59031, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:9543") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:54686->172.17.0.5:9543, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:47074") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:45412->172.17.0.5:47074, err= 2025/10/11 01:01:03 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:46285") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:38434->172.17.0.5:46285, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:59069") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:38582->172.17.0.5:59069, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:55590") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:54132->172.17.0.5:55590, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:31910") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:57046->172.17.0.5:31910, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:33823") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:40110->172.17.0.5:33823, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:44562") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:50910->172.17.0.5:44562, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:40434") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:51092->172.17.0.5:40434, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:8751") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:35416->172.17.0.5:8751, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:49957") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:41266->172.17.0.5:49957, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:41733") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:42326->172.17.0.5:41733, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:42252") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:56738->172.17.0.5:42252, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:38807") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:48930->172.17.0.5:38807, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:10080") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:60266->172.17.0.5:10080, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:5457") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:55854->172.17.0.5:5457, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:59143") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:49466->172.17.0.5:59143, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:34443") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:38052->172.17.0.5:34443, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:35333") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:35208->172.17.0.5:35333, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:16818") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:53304->172.17.0.5:16818, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:48508") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:50478->172.17.0.5:48508, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:26542") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:51640->172.17.0.5:26542, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:38360") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:55462->172.17.0.5:38360, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:30697") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:58934->172.17.0.5:30697, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:4872") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:50484->172.17.0.5:4872, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:42635") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:37954->172.17.0.5:42635, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:22993") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:33454->172.17.0.5:22993, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:31600") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:57478->172.17.0.5:31600, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:55177") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:36406->172.17.0.5:55177, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:39426") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:60980->172.17.0.5:39426, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:25096") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:54234->172.17.0.5:25096, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:63696") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:42702->172.17.0.5:63696, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:20965") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:57616->172.17.0.5:20965, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:5847") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:33556->172.17.0.5:5847, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:57231") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:45126->172.17.0.5:57231, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:11021") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:46642->172.17.0.5:11021, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:36734") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:44576->172.17.0.5:36734, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:25519") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:48672->172.17.0.5:25519, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:54560") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:41548->172.17.0.5:54560, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:11633") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:40300->172.17.0.5:11633, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:33247") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:33326->172.17.0.5:33247, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:38982") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:32866->172.17.0.5:38982, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:52343") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:47866->172.17.0.5:52343, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:9965") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:39714->172.17.0.5:9965, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:12255") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:47902->172.17.0.5:12255, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:61399") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:33166->172.17.0.5:61399, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:14399") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:55244->172.17.0.5:14399, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:5863") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:35764->172.17.0.5:5863, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:30308") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:46604->172.17.0.5:30308, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:48708") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:34388->172.17.0.5:48708, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:21657") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:40882->172.17.0.5:21657, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:13281") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:53760->172.17.0.5:13281, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:9716") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:42762->172.17.0.5:9716, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:58993") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:47488->172.17.0.5:58993, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:42954") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:44944->172.17.0.5:42954, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:13565") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:39416->172.17.0.5:13565, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:36094") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:47812->172.17.0.5:36094, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:64924") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:42628->172.17.0.5:64924, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:44142") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:39168->172.17.0.5:44142, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:25736") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:48322->172.17.0.5:25736, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:38816") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:44254->172.17.0.5:38816, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:3704") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:52220->172.17.0.5:3704, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:23898") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:33508->172.17.0.5:23898, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:58758") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:32882->172.17.0.5:58758, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:8527") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:53046->172.17.0.5:8527, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:15594") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:53424->172.17.0.5:15594, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:4245") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:39964->172.17.0.5:4245, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:44237") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:56310->172.17.0.5:44237, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:40090") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:46888->172.17.0.5:40090, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:57781") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:48472->172.17.0.5:57781, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:54846") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:58300->172.17.0.5:54846, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:7803") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:40520->172.17.0.5:7803, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:31229") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:47418->172.17.0.5:31229, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:41654") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:38492->172.17.0.5:41654, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:16745") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:60140->172.17.0.5:16745, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:42460") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:34070->172.17.0.5:42460, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:37519") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:59542->172.17.0.5:37519, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:30120") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:42132->172.17.0.5:30120, err= 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:47299") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:48558->172.17.0.5:47299, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:2292") 2025/10/11 01:01:03 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:50266->172.17.0.5:2292, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: Connecting to FTP server 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:21") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:39570->172.17.0.5:21, err= 2025/10/11 01:01:04 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:26146") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:34572->172.17.0.5:26146, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:5005") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:56902->172.17.0.5:5005, 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/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:63156") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:50588->172.17.0.5:63156, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:50405") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:59142->172.17.0.5:50405, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:21796") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:48102->172.17.0.5:21796, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:48489") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:48656->172.17.0.5:48489, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:11676") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:38954->172.17.0.5:11676, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:46455") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:59332->172.17.0.5:46455, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:58449") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:38460->172.17.0.5:58449, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:27493") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:50022->172.17.0.5:27493, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:16817") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:60730->172.17.0.5:16817, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:44694") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:50114->172.17.0.5:44694, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:62297") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:38432->172.17.0.5:62297, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:16260") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:51334->172.17.0.5:16260, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:30686") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:59548->172.17.0.5:30686, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:36314") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:58924->172.17.0.5:36314, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:43476") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:43416->172.17.0.5:43476, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:59908") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:51124->172.17.0.5:59908, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:27207") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:43932->172.17.0.5:27207, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/10/11 01:01:04 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/10/11 01:01:04 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/11 01:01:04 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:04 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{Vs3Fm}" suffix to name 2025/10/11 01:01:04 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:04 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21: Connecting to FTP server 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:21") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:39576->172.17.0.5:21, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:14076") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:36354->172.17.0.5:14076, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:8395") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:50360->172.17.0.5:8395, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:5398") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:42290->172.17.0.5:5398, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:5536") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:55690->172.17.0.5:5536, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:58063") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:51696->172.17.0.5:58063, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:28100") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:59982->172.17.0.5:28100, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:51947") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:40132->172.17.0.5:51947, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:21701") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:53826->172.17.0.5:21701, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:15213") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:39880->172.17.0.5:15213, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:34525") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:59300->172.17.0.5:34525, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:47030") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:50818->172.17.0.5:47030, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:11209") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:38848->172.17.0.5:11209, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:28540") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:34498->172.17.0.5:28540, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:7641") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:49632->172.17.0.5:7641, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:15191") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:60060->172.17.0.5:15191, 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/11 01:01:04 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-yereged2joyo/hello? sausage/êé" 2025/10/11 01:01:04 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/11 01:01:04 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:04 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{Vs3Fm}" suffix to name 2025/10/11 01:01:04 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:04 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: Connecting to FTP server 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:21") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:39586->172.17.0.5:21, err= 2025/10/11 01:01:04 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-yereged2joyo/hello? sausage/êé" to be canonical "TestFTPProftpd{Vs3Fm}:rclone-test-yereged2joyo/hello? sausage/êé" 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:13339") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:43104->172.17.0.5:13339, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:50375") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:35520->172.17.0.5:50375, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: Connecting to FTP server 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:21") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:39588->172.17.0.5:21, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:18631") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:37126->172.17.0.5:18631, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:29764") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:46086->172.17.0.5:29764, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:24491") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:56456->172.17.0.5:24491, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:54106") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:50262->172.17.0.5:54106, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:60447") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:52876->172.17.0.5:60447, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:37757") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:47952->172.17.0.5:37757, err= 2025/10/11 01:01:04 DEBUG : Waiting for deletions to finish 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:47710") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:54424->172.17.0.5:47710, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:64092") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:34810->172.17.0.5:64092, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:23532") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:35772->172.17.0.5:23532, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:38234") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:39406->172.17.0.5:38234, err= 2025/10/11 01:01:04 INFO : a/b/c/d/e.txt: Deleted 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:61928") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:47942->172.17.0.5:61928, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:64302") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:37242->172.17.0.5:64302, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:43258") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:45494->172.17.0.5:43258, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: dial("tcp","172.17.0.5:40653") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé: > dial: conn=172.17.0.1:37648->172.17.0.5:40653, err= 2025/10/11 01:01:04 DEBUG : removing 1 level 4 directories 2025/10/11 01:01:04 INFO : a/b/c/d: Removing directory 2025/10/11 01:01:04 DEBUG : removing 1 level 3 directories 2025/10/11 01:01:04 INFO : a/b/c: Removing directory 2025/10/11 01:01:04 DEBUG : removing 1 level 2 directories 2025/10/11 01:01:04 INFO : a/b: Removing directory 2025/10/11 01:01:04 DEBUG : removing 1 level 1 directories 2025/10/11 01:01:04 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:26161") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:47794->172.17.0.5:26161, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:57023") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:40572->172.17.0.5:57023, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:35963") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:46624->172.17.0.5:35963, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:9116") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:58778->172.17.0.5:9116, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:3165") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:46620->172.17.0.5:3165, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:16884") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:59736->172.17.0.5:16884, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: Connecting to FTP server 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:21") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:39596->172.17.0.5:21, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:2031") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:37506->172.17.0.5:2031, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:21420") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:33486->172.17.0.5:21420, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:29634") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:38862->172.17.0.5:29634, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:5303") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:48322->172.17.0.5:5303, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:32677") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:40698->172.17.0.5:32677, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:19015") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:58506->172.17.0.5:19015, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:45701") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:40450->172.17.0.5:45701, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:37428") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:34196->172.17.0.5:37428, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:26396") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:57414->172.17.0.5:26396, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:64943") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:45202->172.17.0.5:64943, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:47913") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:46050->172.17.0.5:47913, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:31930") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:36498->172.17.0.5:31930, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:10853") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:28698") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:47046->172.17.0.5:10853, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:33378->172.17.0.5:28698, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:61687") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:45436->172.17.0.5:61687, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:37383") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:56684->172.17.0.5:37383, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:25854") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:39136->172.17.0.5:25854, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/10/11 01:01:04 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hoxexub0yewu" 2025/10/11 01:01:04 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/11 01:01:04 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:04 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:04 DEBUG : TestFTPProftpd: detected overridden config - adding "{Vs3Fm}" suffix to name 2025/10/11 01:01:04 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:04 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:04 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:04 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: Connecting to FTP server 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: dial("tcp","172.17.0.5:21") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: > dial: conn=172.17.0.1:39606->172.17.0.5:21, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:16629") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:41188->172.17.0.5:16629, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: dial("tcp","172.17.0.5:3890") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: > dial: conn=172.17.0.1:47558->172.17.0.5:3890, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: dial("tcp","172.17.0.5:2429") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: > dial: conn=172.17.0.1:37274->172.17.0.5:2429, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: dial("tcp","172.17.0.5:23874") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: > dial: conn=172.17.0.1:35568->172.17.0.5:23874, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: dial("tcp","172.17.0.5:4946") 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: > dial: conn=172.17.0.1:33462->172.17.0.5:4946, err= 2025/10/11 01:01:04 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: dial("tcp","172.17.0.5:18944") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: > dial: conn=172.17.0.1:53422->172.17.0.5:18944, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: dial("tcp","172.17.0.5:44301") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: > dial: conn=172.17.0.1:59094->172.17.0.5:44301, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: dial("tcp","172.17.0.5:43434") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: > dial: conn=172.17.0.1:39662->172.17.0.5:43434, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:5226") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:41274->172.17.0.5:5226, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:14594") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:51020->172.17.0.5:14594, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:23359") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:49726->172.17.0.5:23359, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:4210") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:34320->172.17.0.5:4210, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:33225") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:38444->172.17.0.5:33225, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: dial("tcp","172.17.0.5:43941") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: > dial: conn=172.17.0.1:34442->172.17.0.5:43941, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: dial("tcp","172.17.0.5:11488") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: > dial: conn=172.17.0.1:58098->172.17.0.5:11488, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: dial("tcp","172.17.0.5:6755") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: > dial: conn=172.17.0.1:50442->172.17.0.5:6755, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: dial("tcp","172.17.0.5:61195") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: > dial: conn=172.17.0.1:45224->172.17.0.5:61195, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: Purge dir "new_name" 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-hoxexub0yewu: 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/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:54706") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:50618->172.17.0.5:54706, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:49944") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:60500->172.17.0.5:49944, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:28872") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:55176->172.17.0.5:28872, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:9601") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:38748->172.17.0.5:9601, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:27566") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:40968->172.17.0.5:27566, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:27872") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:38740->172.17.0.5:27872, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:25754") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:52504->172.17.0.5:25754, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:36677") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:33582->172.17.0.5:36677, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:14284") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:39768->172.17.0.5:14284, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/10/11 01:01:05 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-yereged2joyo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/10/11 01:01:05 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/11 01:01:05 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:05 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{Vs3Fm}" suffix to name 2025/10/11 01:01:05 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:05 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.5:21") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:39616->172.17.0.5:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.5:50815") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:50352->172.17.0.5:50815, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/10/11 01:01:05 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-yereged2joyo/not found.txt" 2025/10/11 01:01:05 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/11 01:01:05 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:05 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{Vs3Fm}" suffix to name 2025/10/11 01:01:05 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:05 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/not found.txt: Connecting to FTP server 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/not found.txt: dial("tcp","172.17.0.5:21") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/not found.txt: > dial: conn=172.17.0.1:39624->172.17.0.5:21, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/not found.txt: dial("tcp","172.17.0.5:38919") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/not found.txt: > dial: conn=172.17.0.1:57646->172.17.0.5:38919, err= 2025/10/11 01:01:05 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-yereged2joyo" from "TestFTPProftpd:rclone-test-yereged2joyo" 2025/10/11 01:01:05 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/10/11 01:01:05 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/11 01:01:05 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:05 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{Vs3Fm}" suffix to name 2025/10/11 01:01:05 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:05 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: Connecting to FTP server 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:21") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:39640->172.17.0.5:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:15532") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:50120->172.17.0.5:15532, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:23132") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:35158->172.17.0.5:23132, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:61536") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:55452->172.17.0.5:61536, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:35021") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:42614->172.17.0.5:35021, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:46829") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:58372->172.17.0.5:46829, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:36116") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:39934->172.17.0.5:36116, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:8856") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:34614->172.17.0.5:8856, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:32478") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:49992->172.17.0.5:32478, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:24486") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:36084->172.17.0.5:24486, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:29030") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:45668->172.17.0.5:29030, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:20105") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:34594->172.17.0.5:20105, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:4555") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:49778->172.17.0.5:4555, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:45008") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:51300->172.17.0.5:45008, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:12645") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:59412->172.17.0.5:12645, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:45660") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:34776->172.17.0.5:45660, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:12957") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:35370->172.17.0.5:12957, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: dial("tcp","172.17.0.5:31540") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21: > dial: conn=172.17.0.1:49654->172.17.0.5:31540, 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/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:47311") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:44158->172.17.0.5:47311, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:46432") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:57584->172.17.0.5:46432, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:41237") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:58238->172.17.0.5:41237, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:50867") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:52930->172.17.0.5:50867, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:56939") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:47628->172.17.0.5:56939, 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/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:33354") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:37456->172.17.0.5:33354, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:47786") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:37890->172.17.0.5:47786, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/10/11 01:01:05 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-yereged2joyo" 2025/10/11 01:01:05 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/11 01:01:05 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:05 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:05 DEBUG : TestFTPProftpd: detected overridden config - adding "{skC3U}" suffix to name 2025/10/11 01:01:05 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:05 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:05 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:05 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: Connecting to FTP server 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:21") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:39652->172.17.0.5:21, err= 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:35818") 2025/10/11 01:01:05 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:41776->172.17.0.5:35818, 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/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:56718") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:59460->172.17.0.5:56718, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:36540") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:43574->172.17.0.5:36540, err= 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:27928") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:43892->172.17.0.5:27928, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/11 01:01:06 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-yereged2joyo/deeper/nonexisting/directory" 2025/10/11 01:01:06 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/11 01:01:06 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:06 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:06 DEBUG : TestFTPProftpd: detected overridden config - adding "{Vs3Fm}" suffix to name 2025/10/11 01:01:06 DEBUG : Setting host="172.17.0.5" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/11 01:01:06 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/11 01:01:06 DEBUG : Setting pass="lA5EIfoXUs0qrKWcaNI-sEx5o0NCMO1vYb-ValTMzEdaUw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/11 01:01:06 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/deeper/nonexisting/directory: Connecting to FTP server 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/deeper/nonexisting/directory: dial("tcp","172.17.0.5:21") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo/deeper/nonexisting/directory: > dial: conn=172.17.0.1:42316->172.17.0.5: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/11 01:01:06 DEBUG : Waiting for deletions to finish 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:49220") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:55968->172.17.0.5:49220, err= 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:61052") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:57326->172.17.0.5:61052, err= 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:18121") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:54292->172.17.0.5:18121, err= 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:10792") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:49026->172.17.0.5:10792, err= 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:32815") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:35134->172.17.0.5:32815, err= 2025/10/11 01:01:06 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:34546") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:55972->172.17.0.5:34546, err= 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:56240") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:52390->172.17.0.5:56240, err= 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:10709") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:57028->172.17.0.5:10709, err= 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:47602") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:33296->172.17.0.5:47602, err= 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:35930") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:45034->172.17.0.5:35930, err= 2025/10/11 01:01:06 DEBUG : removing 1 level 4 directories 2025/10/11 01:01:06 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/10/11 01:01:06 DEBUG : removing 1 level 3 directories 2025/10/11 01:01:06 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/10/11 01:01:06 DEBUG : removing 1 level 2 directories 2025/10/11 01:01:06 INFO : hello? sausage/êé: Removing directory 2025/10/11 01:01:06 DEBUG : removing 1 level 1 directories 2025/10/11 01:01:06 INFO : hello? sausage: Removing directory 2025/10/11 01:01:06 DEBUG : removing 1 level 0 directories 2025/10/11 01:01:06 INFO : ftp://172.17.0.5:21/rclone-test-yereged2joyo: Removing directory 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:26035") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:56276->172.17.0.5:26035, err= 2025/10/11 01:01:06 ERROR : error listing: directory not found 2025/10/11 01:01:06 DEBUG : Waiting for deletions to finish 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:7231") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:49340->172.17.0.5:7231, err= 2025/10/11 01:01:06 ERROR : error listing: directory not found 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: dial("tcp","172.17.0.5:45648") 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: > dial: conn=172.17.0.1:34554->172.17.0.5:45648, err= 2025/10/11 01:01:06 ERROR : ftp://172.17.0.5:21/rclone-test-yereged2joyo: Failed to list "": directory not found 2025/10/11 01:01:06 DEBUG : removing 1 level 0 directories 2025/10/11 01:01:06 INFO : ftp://172.17.0.5:21/rclone-test-yereged2joyo: Removing directory 2025/10/11 01:01:06 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/10/11 01:01:06 DEBUG : ftp://172.17.0.5:21/rclone-test-yereged2joyo: closing 2 unused connections 2025/10/11 01:01:06 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (14.96s) --- 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.62s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.03s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.01s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.01s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.20s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.02s) --- 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.02s) --- 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.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.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.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.06s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.04s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 14.987s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 16.430841621s (try 1/5)