"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/06/19 04:17:42 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zuzivez4lucu" 2025/06/19 04:17:42 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/19 04:17:42 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/06/19 04:17:42 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:42 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:42 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:42 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:42 DEBUG : TestFTPProftpd: detected overridden config - adding "{YOJTM}" suffix to name 2025/06/19 04:17:42 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:42 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:42 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:42 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: Connecting to FTP server 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:21") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:42144->172.17.0.4:21, err= 2025/06/19 04:17:42 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/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:51050") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:49418->172.17.0.4:51050, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:44045") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:52008->172.17.0.4:44045, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/06/19 04:17:42 INFO : dir/subdir: Making directory 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:52183") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:42952->172.17.0.4:52183, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:51264") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:44890->172.17.0.4:51264, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:27971") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:35526->172.17.0.4:27971, err= 2025/06/19 04:17:42 INFO : dir/subdir: Removing directory 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:52996") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:38052->172.17.0.4:52996, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:52903") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:51778->172.17.0.4:52903, err= 2025/06/19 04:17:42 INFO : dir: Removing directory 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:17256") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:32932->172.17.0.4:17256, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:61967") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:36798->172.17.0.4:61967, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:1549") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:36138->172.17.0.4:1549, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:17472") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:53204->172.17.0.4:17472, err= 2025/06/19 04:17:42 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/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:46432") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:48726->172.17.0.4:46432, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:63822") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:52184->172.17.0.4:63822, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:14359") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:54906->172.17.0.4:14359, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:47537") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:40796->172.17.0.4:47537, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:45436") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:52488->172.17.0.4:45436, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:10687") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:38842->172.17.0.4:10687, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:10185") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:38298->172.17.0.4:10185, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:43650") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:55528->172.17.0.4:43650, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:64730") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:32924->172.17.0.4:64730, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:62285") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:35372->172.17.0.4:62285, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:38960") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:36144->172.17.0.4:38960, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:37310") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:57346->172.17.0.4:37310, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:6066") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:40514->172.17.0.4:6066, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:50552") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:55772->172.17.0.4:50552, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:54661") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:47676->172.17.0.4:54661, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:5959") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:48558->172.17.0.4:5959, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:16622") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:56694->172.17.0.4:16622, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:53880") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:34322->172.17.0.4:53880, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:34778") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:52450->172.17.0.4:34778, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:16813") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:49954->172.17.0.4:16813, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:39396") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:38742->172.17.0.4:39396, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:13289") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:48456->172.17.0.4:13289, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:3462") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:47664->172.17.0.4:3462, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:25125") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:37474->172.17.0.4:25125, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:40237") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:39650->172.17.0.4:40237, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:55435") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:58240->172.17.0.4:55435, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:12494") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:44490->172.17.0.4:12494, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:56469") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:35376->172.17.0.4:56469, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:51867") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:59400->172.17.0.4:51867, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:13019") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:56850->172.17.0.4:13019, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:8406") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:34306->172.17.0.4:8406, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:32765") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:39736->172.17.0.4:32765, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:11306") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:51910->172.17.0.4:11306, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:21742") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:60922->172.17.0.4:21742, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:14767") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:53912->172.17.0.4:14767, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:55719") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:37640->172.17.0.4:55719, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:31405") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:56456->172.17.0.4:31405, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:23928") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:55794->172.17.0.4:23928, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:33834") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:54992->172.17.0.4:33834, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:30601") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:44108->172.17.0.4:30601, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:20679") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:36054->172.17.0.4:20679, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:7260") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:55620->172.17.0.4:7260, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:2376") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:50590->172.17.0.4:2376, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:25722") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:37432->172.17.0.4:25722, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:56788") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:45548->172.17.0.4:56788, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:56014") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:56282->172.17.0.4:56014, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:30658") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:36924->172.17.0.4:30658, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:7876") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:37346->172.17.0.4:7876, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:44360") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:38586->172.17.0.4:44360, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:64413") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:40168->172.17.0.4:64413, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:23665") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:57096->172.17.0.4:23665, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:18221") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:37576->172.17.0.4:18221, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:12167") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:38540->172.17.0.4:12167, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:26104") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:36150->172.17.0.4:26104, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:42322") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:38538->172.17.0.4:42322, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:51380") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:56182->172.17.0.4:51380, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:16004") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:35002->172.17.0.4:16004, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:53792") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:43784->172.17.0.4:53792, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:42315") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:44834->172.17.0.4:42315, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:2336") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:39026->172.17.0.4:2336, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:1277") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:50436->172.17.0.4:1277, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:49697") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:55526->172.17.0.4:49697, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:34077") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:45918->172.17.0.4:34077, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:11560") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:48334->172.17.0.4:11560, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:5905") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:35748->172.17.0.4:5905, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:47821") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:45512->172.17.0.4:47821, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:1744") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:34460->172.17.0.4:1744, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:36286") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:49158->172.17.0.4:36286, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:6214") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:52070->172.17.0.4:6214, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:34555") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:35064->172.17.0.4:34555, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:1353") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:34812->172.17.0.4:1353, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:25869") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:40252->172.17.0.4:25869, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:40791") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:51566->172.17.0.4:40791, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:2705") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:35254->172.17.0.4:2705, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:50568") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:58124->172.17.0.4:50568, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:32045") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:37264->172.17.0.4:32045, err= 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:57696") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:55522->172.17.0.4:57696, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:15691") 2025/06/19 04:17:42 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:39494->172.17.0.4:15691, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: Connecting to FTP server 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:21") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:43330->172.17.0.4:21, err= 2025/06/19 04:17:43 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:36293") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:51536->172.17.0.4:36293, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:17410") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:47332->172.17.0.4:17410, 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/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:1526") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:46820->172.17.0.4:1526, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:18646") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:43094->172.17.0.4:18646, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:8430") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:59652->172.17.0.4:8430, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:37131") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:33876->172.17.0.4:37131, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:31340") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:51796->172.17.0.4:31340, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:52537") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:38082->172.17.0.4:52537, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:15365") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:52990->172.17.0.4:15365, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:57348") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:53854->172.17.0.4:57348, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:7823") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:37150->172.17.0.4:7823, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:14825") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:43558->172.17.0.4:14825, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:25061") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:37894->172.17.0.4:25061, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:49377") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:39720->172.17.0.4:49377, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:29422") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:40432->172.17.0.4:29422, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:22502") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:47968->172.17.0.4:22502, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:19937") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:38788->172.17.0.4:19937, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:58362") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:45368->172.17.0.4:58362, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:11942") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:55326->172.17.0.4:11942, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/06/19 04:17:43 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/06/19 04:17:43 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/06/19 04:17:43 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:43 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:43 DEBUG : TestFTPProftpd: detected overridden config - adding "{YOJTM}" suffix to name 2025/06/19 04:17:43 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:43 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:43332->172.17.0.4:21, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:5811") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:49402->172.17.0.4:5811, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:38603") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:37844->172.17.0.4:38603, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:15587") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:49092->172.17.0.4:15587, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:60593") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:41650->172.17.0.4:60593, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:26673") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:57410->172.17.0.4:26673, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:34477") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:35628->172.17.0.4:34477, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:21361") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:39644->172.17.0.4:21361, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:45645") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:52284->172.17.0.4:45645, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:21932") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:38916->172.17.0.4:21932, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:43037") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:54392->172.17.0.4:43037, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:42582") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:47494->172.17.0.4:42582, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:29732") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:44962->172.17.0.4:29732, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:54725") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:34734->172.17.0.4:54725, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:13340") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:35158->172.17.0.4:13340, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:46119") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:33346->172.17.0.4:46119, 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/06/19 04:17:43 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zuzivez4lucu/hello? sausage/êé" 2025/06/19 04:17:43 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/06/19 04:17:43 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:43 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:43 DEBUG : TestFTPProftpd: detected overridden config - adding "{YOJTM}" suffix to name 2025/06/19 04:17:43 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:43 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: Connecting to FTP server 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:43338->172.17.0.4:21, err= 2025/06/19 04:17:43 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-zuzivez4lucu/hello? sausage/êé" to be canonical "TestFTPProftpd{YOJTM}:rclone-test-zuzivez4lucu/hello? sausage/êé" 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:58899") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:36698->172.17.0.4:58899, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:57520") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:59830->172.17.0.4:57520, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: Connecting to FTP server 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:43346->172.17.0.4:21, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:42264") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:60362->172.17.0.4:42264, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:57134") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:51786->172.17.0.4:57134, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:16669") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:51706->172.17.0.4:16669, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:36520") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:46924->172.17.0.4:36520, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:23214") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:50784->172.17.0.4:23214, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:2096") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:57934->172.17.0.4:2096, err= 2025/06/19 04:17:43 DEBUG : Waiting for deletions to finish 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:33348") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:43348->172.17.0.4:33348, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:23617") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:54156->172.17.0.4:23617, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:16087") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:59016->172.17.0.4:16087, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:25487") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:42570->172.17.0.4:25487, err= 2025/06/19 04:17:43 INFO : a/b/c/d/e.txt: Deleted 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:32233") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:37196->172.17.0.4:32233, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:46960") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:50046->172.17.0.4:46960, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:49946") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:51920->172.17.0.4:49946, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: dial("tcp","172.17.0.4:31399") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé: > dial: conn=172.17.0.1:55574->172.17.0.4:31399, err= 2025/06/19 04:17:43 DEBUG : removing 1 level 4 directories 2025/06/19 04:17:43 INFO : a/b/c/d: Removing directory 2025/06/19 04:17:43 DEBUG : removing 1 level 3 directories 2025/06/19 04:17:43 INFO : a/b/c: Removing directory 2025/06/19 04:17:43 DEBUG : removing 1 level 2 directories 2025/06/19 04:17:43 INFO : a/b: Removing directory 2025/06/19 04:17:43 DEBUG : removing 1 level 1 directories 2025/06/19 04:17:43 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:55227") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:60270->172.17.0.4:55227, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:30963") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:45472->172.17.0.4:30963, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:53525") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:57626->172.17.0.4:53525, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:26823") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:45368->172.17.0.4:26823, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:61279") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:47252->172.17.0.4:61279, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:40527") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:51110->172.17.0.4:40527, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: Connecting to FTP server 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:21") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:43360->172.17.0.4:21, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:41164") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:34722->172.17.0.4:41164, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:33127") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:46974->172.17.0.4:33127, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:53093") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:51408->172.17.0.4:53093, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:50815") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:50392->172.17.0.4:50815, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:47327") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:58656->172.17.0.4:47327, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:31320") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:58944->172.17.0.4:31320, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:54966") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:47798->172.17.0.4:54966, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:57187") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:45762->172.17.0.4:57187, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:12619") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:54950->172.17.0.4:12619, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:3720") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:42614->172.17.0.4:3720, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:31170") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:60740->172.17.0.4:31170, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:37613") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:48886->172.17.0.4:37613, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:18853") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:42702->172.17.0.4:18853, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:26998") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:43104->172.17.0.4:26998, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:34098") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:35614->172.17.0.4:34098, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:35670") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:45970->172.17.0.4:35670, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:50084") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:47162->172.17.0.4:50084, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/06/19 04:17:43 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-decunes6tuxu" 2025/06/19 04:17:43 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/06/19 04:17:43 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:43 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:43 DEBUG : TestFTPProftpd: detected overridden config - adding "{YOJTM}" suffix to name 2025/06/19 04:17:43 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:43 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: Connecting to FTP server 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: dial("tcp","172.17.0.4:21") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: > dial: conn=172.17.0.1:43368->172.17.0.4:21, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:36867") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:39808->172.17.0.4:36867, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: dial("tcp","172.17.0.4:19361") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: > dial: conn=172.17.0.1:35566->172.17.0.4:19361, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: dial("tcp","172.17.0.4:31411") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: > dial: conn=172.17.0.1:33076->172.17.0.4:31411, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: dial("tcp","172.17.0.4:10100") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: > dial: conn=172.17.0.1:42670->172.17.0.4:10100, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: dial("tcp","172.17.0.4:55123") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: > dial: conn=172.17.0.1:39646->172.17.0.4:55123, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: dial("tcp","172.17.0.4:40882") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: > dial: conn=172.17.0.1:42590->172.17.0.4:40882, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: dial("tcp","172.17.0.4:49947") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: > dial: conn=172.17.0.1:44334->172.17.0.4:49947, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: dial("tcp","172.17.0.4:62459") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: > dial: conn=172.17.0.1:49358->172.17.0.4:62459, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:11681") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:57158->172.17.0.4:11681, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:55052") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:36260->172.17.0.4:55052, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:45016") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:34954->172.17.0.4:45016, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:15072") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:36886->172.17.0.4:15072, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:23152") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:36074->172.17.0.4:23152, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: dial("tcp","172.17.0.4:47650") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: > dial: conn=172.17.0.1:57384->172.17.0.4:47650, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: dial("tcp","172.17.0.4:28211") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: > dial: conn=172.17.0.1:55310->172.17.0.4:28211, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: dial("tcp","172.17.0.4:4944") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: > dial: conn=172.17.0.1:34694->172.17.0.4:4944, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: dial("tcp","172.17.0.4:2887") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: > dial: conn=172.17.0.1:48768->172.17.0.4:2887, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: Purge dir "new_name" 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-decunes6tuxu: 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/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:43375") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:39004->172.17.0.4:43375, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:24865") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:59580->172.17.0.4:24865, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:23894") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:32818->172.17.0.4:23894, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:26245") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:44836->172.17.0.4:26245, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:9211") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:45338->172.17.0.4:9211, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:40075") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:56224->172.17.0.4:40075, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:48801") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:59330->172.17.0.4:48801, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:59698") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:40868->172.17.0.4:59698, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:60412") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:39978->172.17.0.4:60412, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/06/19 04:17:43 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zuzivez4lucu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/06/19 04:17:43 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/06/19 04:17:43 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:43 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:43 DEBUG : TestFTPProftpd: detected overridden config - adding "{YOJTM}" suffix to name 2025/06/19 04:17:43 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:43 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:43378->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:53758") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:59394->172.17.0.4:53758, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/06/19 04:17:43 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zuzivez4lucu/not found.txt" 2025/06/19 04:17:43 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/06/19 04:17:43 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:43 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:43 DEBUG : TestFTPProftpd: detected overridden config - adding "{YOJTM}" suffix to name 2025/06/19 04:17:43 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:43 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/not found.txt: Connecting to FTP server 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/not found.txt: dial("tcp","172.17.0.4:21") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/not found.txt: > dial: conn=172.17.0.1:43388->172.17.0.4:21, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/not found.txt: dial("tcp","172.17.0.4:42113") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/not found.txt: > dial: conn=172.17.0.1:48670->172.17.0.4:42113, err= 2025/06/19 04:17:43 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-zuzivez4lucu" from "TestFTPProftpd:rclone-test-zuzivez4lucu" 2025/06/19 04:17:43 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/06/19 04:17:43 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/06/19 04:17:43 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:43 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:43 DEBUG : TestFTPProftpd: detected overridden config - adding "{YOJTM}" suffix to name 2025/06/19 04:17:43 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:43 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:43398->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37292") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:53904->172.17.0.4:37292, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:41947") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:43964->172.17.0.4:41947, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:20325") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:59672->172.17.0.4:20325, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:32521") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:60352->172.17.0.4:32521, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30542") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37508->172.17.0.4:30542, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:57657") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58072->172.17.0.4:57657, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:6786") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37780->172.17.0.4:6786, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30276") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44222->172.17.0.4:30276, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:58899") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:36702->172.17.0.4:58899, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:6157") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:51464->172.17.0.4:6157, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:3246") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:32834->172.17.0.4:3246, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:48153") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:57846->172.17.0.4:48153, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:6335") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:46988->172.17.0.4:6335, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:16455") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:47918->172.17.0.4:16455, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:22005") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:51394->172.17.0.4:22005, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:34465") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56104->172.17.0.4:34465, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:23946") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:41416->172.17.0.4:23946, 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/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:64288") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:41440->172.17.0.4:64288, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:28912") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:57880->172.17.0.4:28912, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:56846") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:43114->172.17.0.4:56846, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:16096") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:58934->172.17.0.4:16096, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:34997") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:41398->172.17.0.4:34997, 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/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:27666") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:50862->172.17.0.4:27666, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:37915") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:56910->172.17.0.4:37915, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/06/19 04:17:43 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-zuzivez4lucu" 2025/06/19 04:17:43 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/06/19 04:17:43 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:43 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:43 DEBUG : TestFTPProftpd: detected overridden config - adding "{k-lop}" suffix to name 2025/06/19 04:17:43 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:43 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:43 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:43 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: Connecting to FTP server 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:21") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:43406->172.17.0.4:21, err= 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:32577") 2025/06/19 04:17:43 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:35670->172.17.0.4:32577, 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/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:56542") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:60452->172.17.0.4:56542, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:2923") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:42960->172.17.0.4:2923, err= 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:5959") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:57880->172.17.0.4:5959, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/06/19 04:17:44 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-zuzivez4lucu/deeper/nonexisting/directory" 2025/06/19 04:17:44 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/06/19 04:17:44 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:44 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:44 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:44 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:44 DEBUG : TestFTPProftpd: detected overridden config - adding "{YOJTM}" suffix to name 2025/06/19 04:17:44 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/06/19 04:17:44 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/06/19 04:17:44 DEBUG : Setting pass="szhzKdA9BG37zOpLIeBn5juWDePHYpL4wwyap3VAdOIbBQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/06/19 04:17:44 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/deeper/nonexisting/directory: Connecting to FTP server 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:43414->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/06/19 04:17:44 DEBUG : Waiting for deletions to finish 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:26406") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:53392->172.17.0.4:26406, err= 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:44804") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:40586->172.17.0.4:44804, err= 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:32306") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:40596->172.17.0.4:32306, err= 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:27105") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:52720->172.17.0.4:27105, err= 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:54820") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:46956->172.17.0.4:54820, err= 2025/06/19 04:17:44 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:18276") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:50376->172.17.0.4:18276, err= 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:31755") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:45302->172.17.0.4:31755, err= 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:25388") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:58668->172.17.0.4:25388, err= 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:64223") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:47362->172.17.0.4:64223, err= 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:16797") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:40134->172.17.0.4:16797, err= 2025/06/19 04:17:44 DEBUG : removing 1 level 4 directories 2025/06/19 04:17:44 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/06/19 04:17:44 DEBUG : removing 1 level 3 directories 2025/06/19 04:17:44 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/06/19 04:17:44 DEBUG : removing 1 level 2 directories 2025/06/19 04:17:44 INFO : hello? sausage/êé: Removing directory 2025/06/19 04:17:44 DEBUG : removing 1 level 1 directories 2025/06/19 04:17:44 INFO : hello? sausage: Removing directory 2025/06/19 04:17:44 DEBUG : removing 1 level 0 directories 2025/06/19 04:17:44 INFO : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: Removing directory 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:48215") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:55850->172.17.0.4:48215, err= 2025/06/19 04:17:44 ERROR : error listing: directory not found 2025/06/19 04:17:44 DEBUG : Waiting for deletions to finish 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:60616") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:36816->172.17.0.4:60616, err= 2025/06/19 04:17:44 ERROR : error listing: directory not found 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: dial("tcp","172.17.0.4:13378") 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: > dial: conn=172.17.0.1:43116->172.17.0.4:13378, err= 2025/06/19 04:17:44 ERROR : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: Failed to list "": directory not found 2025/06/19 04:17:44 DEBUG : removing 1 level 0 directories 2025/06/19 04:17:44 INFO : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: Removing directory 2025/06/19 04:17:44 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/06/19 04:17:44 DEBUG : ftp://172.17.0.4:21/rclone-test-zuzivez4lucu: closing 2 unused connections --- PASS: TestIntegration (2.68s) --- 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.63s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.24s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.27s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.04s) --- 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.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 2.695s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 3.520221043s (try 1/5)