"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPPureftpd:" 2026/04/19 03:00:58 NOTICE: TestFTPPureftpd: Starting server 2026/04/19 03:00:59 NOTICE: TestFTPPureftpd: Attempting to connect to "172.17.0.2:21" try 1/100 2026/04/19 03:00:59 DEBUG : TestFTPPureftpd: Read 1, error: 2026/04/19 03:00:59 NOTICE: TestFTPPureftpd: Started server and connected to "172.17.0.2:21" 2026/04/19 03:00:59 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-kawexuc1yusa" 2026/04/19 03:00:59 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/04/19 03:00:59 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/19 03:00:59 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:00:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:00:59 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:00:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:00:59 DEBUG : TestFTPPureftpd: detected overridden config - adding "{RjC2s}" suffix to name 2026/04/19 03:00:59 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:00:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:00:59 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:00:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:00:59 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: Connecting to FTP server 2026/04/19 03:00:59 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:21") 2026/04/19 03:00:59 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:44010->172.17.0.2:21, err= 2026/04/19 03:01:02 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_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 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:36613") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:39998->172.17.0.2:36613, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30591") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:56254->172.17.0.2:30591, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/04/19 03:01:02 INFO : dir/subdir: Making directory 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:38714") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:33016->172.17.0.2:38714, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35055") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:59120->172.17.0.2:35055, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32174") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:39460->172.17.0.2:32174, err= 2026/04/19 03:01:02 INFO : dir/subdir: Removing directory 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:37685") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:34514->172.17.0.2:37685, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34162") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:49450->172.17.0.2:34162, err= 2026/04/19 03:01:02 INFO : dir: Removing directory 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35401") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:37890->172.17.0.2:35401, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33288") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:36362->172.17.0.2:33288, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32450") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:46414->172.17.0.2:32450, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30967") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:58722->172.17.0.2:30967, err= 2026/04/19 03:01:02 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 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:36218") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:34030->172.17.0.2:36218, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:708: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31377") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:36590->172.17.0.2:31377, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30029") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:43784->172.17.0.2:30029, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32327") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:44104->172.17.0.2:32327, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35052") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:59658->172.17.0.2:35052, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:708: testing "．" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31532") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:35802->172.17.0.2:31532, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32824") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:34068->172.17.0.2:32824, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32451") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:59956->172.17.0.2:32451, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35139") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:44964->172.17.0.2:35139, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:708: testing "．．" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34120") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:47216->172.17.0.2:34120, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:38586") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:42190->172.17.0.2:38586, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39883") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:45224->172.17.0.2:39883, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33294") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:45458->172.17.0.2:33294, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:708: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32577") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:37806->172.17.0.2:32577, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35260") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:41518->172.17.0.2:35260, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:37136") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:58190->172.17.0.2:37136, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30636") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:35120->172.17.0.2:30636, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:708: testing " leading space" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34977") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:60152->172.17.0.2:34977, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34920") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:32768->172.17.0.2:34920, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33973") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:45856->172.17.0.2:33973, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32856") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:33862->172.17.0.2:32856, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:708: testing "~leading tilde" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31151") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:46148->172.17.0.2:31151, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34847") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:59374->172.17.0.2:34847, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35332") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:37456->172.17.0.2:35332, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33687") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:37230->172.17.0.2:33687, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:708: testing "␍leading CR" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30312") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:42350->172.17.0.2:30312, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35413") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:41634->172.17.0.2:35413, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:36000") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:52818->172.17.0.2:36000, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33451") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:55884->172.17.0.2:33451, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:708: testing "␊leading LF" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31784") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:53586->172.17.0.2:31784, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35880") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:60084->172.17.0.2:35880, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31175") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:36048->172.17.0.2:31175, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39270") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:52410->172.17.0.2:39270, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:708: testing "␉leading HT" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:38438") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:37858->172.17.0.2:38438, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39349") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:45126->172.17.0.2:39349, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35852") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:34480->172.17.0.2:35852, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:37612") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:53850->172.17.0.2:37612, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:708: testing "␋leading VT" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32945") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:34276->172.17.0.2:32945, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:38363") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:51234->172.17.0.2:38363, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34845") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:38006->172.17.0.2:34845, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:36947") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:42324->172.17.0.2:36947, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:708: testing ".leading dot" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:37358") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:39668->172.17.0.2:37358, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32420") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:45058->172.17.0.2:32420, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39304") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:35854->172.17.0.2:39304, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39915") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:35494->172.17.0.2:39915, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:708: testing "trailing space " 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31539") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:49674->172.17.0.2:31539, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30466") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:44916->172.17.0.2:30466, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31414") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:49202->172.17.0.2:31414, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34491") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:48186->172.17.0.2:34491, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:708: testing "trailing CR␍" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:36097") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:40236->172.17.0.2:36097, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34108") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:36020->172.17.0.2:34108, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34868") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:33992->172.17.0.2:34868, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:37345") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:51032->172.17.0.2:37345, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:708: testing "trailing LF␊" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39969") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:40574->172.17.0.2:39969, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31316") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:35106->172.17.0.2:31316, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:38318") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:57586->172.17.0.2:38318, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34103") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:58200->172.17.0.2:34103, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:708: testing "trailing HT␉" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31281") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:39768->172.17.0.2:31281, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30014") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:60310->172.17.0.2:30014, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34254") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:59476->172.17.0.2:34254, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:38998") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:50682->172.17.0.2:38998, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:708: testing "trailing VT␋" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:36326") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:51228->172.17.0.2:36326, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30543") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:40080->172.17.0.2:30543, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:37080") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:60166->172.17.0.2:37080, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33932") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:42882->172.17.0.2:33932, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:708: testing "trailing dot." 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:36997") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:51206->172.17.0.2:36997, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39573") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:34380->172.17.0.2:39573, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33445") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:50486->172.17.0.2:33445, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34790") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:51116->172.17.0.2:34790, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:708: testing "invalid utf-8\xfe" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39545") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:53500->172.17.0.2:39545, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33870") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:35558->172.17.0.2:33870, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33846") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:49818->172.17.0.2:33846, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32988") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:42232->172.17.0.2:32988, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:708: testing "test%46.txt" 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35349") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:60350->172.17.0.2:35349, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35072") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:46032->172.17.0.2:35072, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30147") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:33758->172.17.0.2:30147, err= 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39238") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:44510->172.17.0.2:39238, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:37204") 2026/04/19 03:01:02 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:40688->172.17.0.2:37204, err= 2026/04/19 03:01:03 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: Connecting to FTP server 2026/04/19 03:01:03 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:21") 2026/04/19 03:01:03 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:35656->172.17.0.2:21, err= 2026/04/19 03:01:05 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33706") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:33932->172.17.0.2:33706, err= 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:38130") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:56526->172.17.0.2:38130, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:787: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:820: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:869: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33851") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:56260->172.17.0.2:33851, err= 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:37458") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:41638->172.17.0.2:37458, err= 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34070") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:49546->172.17.0.2:34070, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34917") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:35094->172.17.0.2:34917, err= 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31507") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:37182->172.17.0.2:31507, err= 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34608") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:45274->172.17.0.2:34608, err= 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39446") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:57780->172.17.0.2:39446, err= 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34268") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:54166->172.17.0.2:34268, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:38473") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:55432->172.17.0.2:38473, err= 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:37203") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:44138->172.17.0.2:37203, err= 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39085") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:46828->172.17.0.2:39085, err= 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39528") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:58246->172.17.0.2:39528, err= 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39517") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:58376->172.17.0.2:39517, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34946") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:46166->172.17.0.2:34946, err= 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:36552") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:42720->172.17.0.2:36552, err= 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31730") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:55526->172.17.0.2:31730, err= 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30029") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:43786->172.17.0.2:30029, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/04/19 03:01:05 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2026/04/19 03:01:05 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/19 03:01:05 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:05 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:05 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:05 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:05 DEBUG : TestFTPPureftpd: detected overridden config - adding "{RjC2s}" suffix to name 2026/04/19 03:01:05 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:05 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:05 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:05 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2026/04/19 03:01:05 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:35668->172.17.0.2:21, err= 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:33900") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:47658->172.17.0.2:33900, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31188") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:58936->172.17.0.2:31188, err= 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30617") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:34900->172.17.0.2:30617, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39361") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:40170->172.17.0.2:39361, err= 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34406") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:54946->172.17.0.2:34406, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31462") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:42802->172.17.0.2:31462, err= 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:37559") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:49752->172.17.0.2:37559, err= 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32856") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:33876->172.17.0.2:32856, err= 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:38608") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:33972->172.17.0.2:38608, err= 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31338") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:50454->172.17.0.2:31338, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1122: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:36499") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:46494->172.17.0.2:36499, err= 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31792") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:36342->172.17.0.2:31792, err= 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31263") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:57196->172.17.0.2:31263, err= 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33249") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:37794->172.17.0.2:33249, err= 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35105") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:43448->172.17.0.2:35105, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1154: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1191: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/04/19 03:01:07 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-kawexuc1yusa/hello? sausage/êé" 2026/04/19 03:01:07 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/19 03:01:07 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:07 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:07 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:07 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:07 DEBUG : TestFTPPureftpd: detected overridden config - adding "{RjC2s}" suffix to name 2026/04/19 03:01:07 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:07 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:07 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:07 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: Connecting to FTP server 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2026/04/19 03:01:07 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:35678->172.17.0.2:21, err= 2026/04/19 03:01:10 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-kawexuc1yusa/hello? sausage/êé" to be canonical "TestFTPPureftpd{RjC2s}:rclone-test-kawexuc1yusa/hello? sausage/êé" 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:34770") 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:37756->172.17.0.2:34770, err= 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:31795") 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:35070->172.17.0.2:31795, err= 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: Connecting to FTP server 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:34935") 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:35682->172.17.0.2:21, err= 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:36376->172.17.0.2:34935, err= 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:34109") 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:46158->172.17.0.2:34109, err= 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:33098") 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:42330->172.17.0.2:33098, err= 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:34369") 2026/04/19 03:01:10 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:44476->172.17.0.2:34369, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:37599") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:40560->172.17.0.2:37599, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:32491") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:36356->172.17.0.2:32491, err= 2026/04/19 03:01:12 DEBUG : Waiting for deletions to finish 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:31190") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:41824->172.17.0.2:31190, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:38966") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:48558->172.17.0.2:38966, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:31771") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:59820->172.17.0.2:31771, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:39628") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:57550->172.17.0.2:39628, err= 2026/04/19 03:01:12 INFO : a/b/c/d/e.txt: Deleted 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:34321") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:33008->172.17.0.2:34321, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:38142") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:38516->172.17.0.2:38142, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:33639") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:50154->172.17.0.2:33639, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: dial("tcp","172.17.0.2:31656") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé: > dial: conn=172.17.0.1:53644->172.17.0.2:31656, err= 2026/04/19 03:01:12 DEBUG : removing 1 level 4 directories 2026/04/19 03:01:12 INFO : a/b/c/d: Removing directory 2026/04/19 03:01:12 DEBUG : removing 1 level 3 directories 2026/04/19 03:01:12 INFO : a/b/c: Removing directory 2026/04/19 03:01:12 DEBUG : removing 1 level 2 directories 2026/04/19 03:01:12 INFO : a/b: Removing directory 2026/04/19 03:01:12 DEBUG : removing 1 level 1 directories 2026/04/19 03:01:12 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1255: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32766") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:34180->172.17.0.2:32766, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33163") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:38612->172.17.0.2:33163, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32713") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:33726->172.17.0.2:32713, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34341") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:34752->172.17.0.2:34341, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33724") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:44704->172.17.0.2:33724, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35527") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:38818->172.17.0.2:35527, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: Connecting to FTP server 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:21") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:50954->172.17.0.2:21, err= 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30599") 2026/04/19 03:01:12 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:57776->172.17.0.2:30599, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33057") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:37042->172.17.0.2:33057, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30160") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:58526->172.17.0.2:30160, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30572") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:46374->172.17.0.2:30572, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34600") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:43796->172.17.0.2:34600, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39413") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:54930->172.17.0.2:39413, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30107") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:38196") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:36336->172.17.0.2:30107, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:45058->172.17.0.2:38196, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39121") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:37242->172.17.0.2:39121, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:37883") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:33842->172.17.0.2:37883, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:38604") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:41530->172.17.0.2:38604, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31973") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:58036->172.17.0.2:31973, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:37513") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:59102->172.17.0.2:37513, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32699") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:52188->172.17.0.2:32699, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33184") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:57352->172.17.0.2:33184, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:36127") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:42750->172.17.0.2:36127, err= 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31002") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:49550->172.17.0.2:31002, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1403: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/04/19 03:01:14 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-rojujir7risa" 2026/04/19 03:01:14 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/19 03:01:14 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:14 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:14 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:14 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:14 DEBUG : TestFTPPureftpd: detected overridden config - adding "{RjC2s}" suffix to name 2026/04/19 03:01:14 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:14 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:14 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:14 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: Connecting to FTP server 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: dial("tcp","172.17.0.2:21") 2026/04/19 03:01:14 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: > dial: conn=172.17.0.1:50970->172.17.0.2:21, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32338") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:36048->172.17.0.2:32338, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: dial("tcp","172.17.0.2:34925") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: > dial: conn=172.17.0.1:59214->172.17.0.2:34925, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: dial("tcp","172.17.0.2:35277") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: > dial: conn=172.17.0.1:58568->172.17.0.2:35277, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: dial("tcp","172.17.0.2:37921") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: > dial: conn=172.17.0.1:51978->172.17.0.2:37921, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: dial("tcp","172.17.0.2:31007") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: > dial: conn=172.17.0.1:36698->172.17.0.2:31007, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: dial("tcp","172.17.0.2:33615") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: > dial: conn=172.17.0.1:58272->172.17.0.2:33615, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: dial("tcp","172.17.0.2:35911") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: > dial: conn=172.17.0.1:49716->172.17.0.2:35911, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: dial("tcp","172.17.0.2:30343") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: > dial: conn=172.17.0.1:48106->172.17.0.2:30343, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35456") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:55408->172.17.0.2:35456, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33886") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:36046->172.17.0.2:33886, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31435") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:54722->172.17.0.2:31435, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:34527") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:36962->172.17.0.2:34527, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39179") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:58674->172.17.0.2:39179, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: dial("tcp","172.17.0.2:39858") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: > dial: conn=172.17.0.1:37772->172.17.0.2:39858, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: dial("tcp","172.17.0.2:34507") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: > dial: conn=172.17.0.1:33214->172.17.0.2:34507, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: dial("tcp","172.17.0.2:35676") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: > dial: conn=172.17.0.1:57178->172.17.0.2:35676, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: dial("tcp","172.17.0.2:35509") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: > dial: conn=172.17.0.1:35874->172.17.0.2:35509, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: Purge dir "new_name" 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-rojujir7risa: 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:1597: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1628: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1699: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33195") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:49302->172.17.0.2:33195, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:36455") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:60832->172.17.0.2:36455, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32336") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:48042->172.17.0.2:32336, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31215") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:56358->172.17.0.2:31215, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39685") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:48718->172.17.0.2:39685, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30847") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:42432->172.17.0.2:30847, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39770") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:33858->172.17.0.2:39770, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32992") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:41434->172.17.0.2:32992, err= 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32725") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:54134->172.17.0.2:32725, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/04/19 03:01:16 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-kawexuc1yusa/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/04/19 03:01:16 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/19 03:01:16 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:16 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:16 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:16 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:16 DEBUG : TestFTPPureftpd: detected overridden config - adding "{RjC2s}" suffix to name 2026/04/19 03:01:16 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:16 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:16 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:16 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:21") 2026/04/19 03:01:16 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:50980->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/04/19 03:01:19 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:30930") 2026/04/19 03:01:19 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:59740->172.17.0.2:30930, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/04/19 03:01:19 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-kawexuc1yusa/not found.txt" 2026/04/19 03:01:19 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/19 03:01:19 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:19 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:19 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:19 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:19 DEBUG : TestFTPPureftpd: detected overridden config - adding "{RjC2s}" suffix to name 2026/04/19 03:01:19 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:19 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:19 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:19 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:19 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/not found.txt: Connecting to FTP server 2026/04/19 03:01:19 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/not found.txt: dial("tcp","172.17.0.2:21") 2026/04/19 03:01:19 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/not found.txt: > dial: conn=172.17.0.1:50982->172.17.0.2:21, err= 2026/04/19 03:01:21 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/not found.txt: dial("tcp","172.17.0.2:39145") 2026/04/19 03:01:21 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/not found.txt: > dial: conn=172.17.0.1:51468->172.17.0.2:39145, err= 2026/04/19 03:01:21 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1916: Opening root remote "TestFTPPureftpd:" path "rclone-test-kawexuc1yusa" from "TestFTPPureftpd:rclone-test-kawexuc1yusa" 2026/04/19 03:01:21 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2026/04/19 03:01:21 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/19 03:01:21 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:21 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:21 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:21 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:21 DEBUG : TestFTPPureftpd: detected overridden config - adding "{RjC2s}" suffix to name 2026/04/19 03:01:21 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:21 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:21 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:21 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:21 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2026/04/19 03:01:21 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2026/04/19 03:01:21 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50998->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:30374") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50052->172.17.0.2:30374, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:37907") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:55938->172.17.0.2:37907, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:34676") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:44416->172.17.0.2:34676, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:31431") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50986->172.17.0.2:31431, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:32746") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:53680->172.17.0.2:32746, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:31395") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:36738->172.17.0.2:31395, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1953: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:31098") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:47692->172.17.0.2:31098, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:37001") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:34920->172.17.0.2:37001, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:34758") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50124->172.17.0.2:34758, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:32469") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:45064->172.17.0.2:32469, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:33749") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:42010->172.17.0.2:33749, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:30423") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:52330->172.17.0.2:30423, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:36143") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:33198->172.17.0.2:36143, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:36857") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:57332->172.17.0.2:36857, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:39397") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:35562->172.17.0.2:39397, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:34386") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:38794->172.17.0.2:34386, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:38272") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:57954->172.17.0.2:38272, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2012: 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:2117: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2133: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31362") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:54174->172.17.0.2:31362, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31484") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:47356->172.17.0.2:31484, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33499") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:59884->172.17.0.2:33499, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:36796") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:39012->172.17.0.2:36796, err= 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:36075") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:42344->172.17.0.2:36075, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2289: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33657") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:33778->172.17.0.2:33657, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39009") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:40972->172.17.0.2:39009, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/04/19 03:01:23 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-kawexuc1yusa" 2026/04/19 03:01:23 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/19 03:01:23 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:23 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:23 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:23 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:23 DEBUG : TestFTPPureftpd: detected overridden config - adding "{9j1Hi}" suffix to name 2026/04/19 03:01:23 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:23 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:23 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:23 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: Connecting to FTP server 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:21") 2026/04/19 03:01:23 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:34730->172.17.0.2:21, err= 2026/04/19 03:01:24 DEBUG : pacer: low level retry 1/1 (error read tcp 172.17.0.1:34730->172.17.0.2:21: i/o timeout) 2026/04/19 03:01:24 DEBUG : pacer: Rate limited, increasing sleep to 20ms ftp_internal_test.go:30: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/backend/ftp/ftp_internal_test.go:30 /home/rclone/go/src/github.com/rclone/rclone/backend/ftp/ftp_internal_test.go:58 /home/rclone/go/src/github.com/rclone/rclone/backend/ftp/ftp_internal_test.go:85 Error: Received unexpected error: NewFs: failed to make FTP connection to "172.17.0.2:21": read tcp 172.17.0.1:34730->172.17.0.2:21: i/o timeout Test: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2372: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2484: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/04/19 03:01:24 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:32224") 2026/04/19 03:01:24 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:53306->172.17.0.2:32224, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/04/19 03:01:24 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30488") 2026/04/19 03:01:24 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:59560->172.17.0.2:30488, err= 2026/04/19 03:01:24 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:37898") 2026/04/19 03:01:24 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:35300->172.17.0.2:37898, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/04/19 03:01:24 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-kawexuc1yusa/deeper/nonexisting/directory" 2026/04/19 03:01:24 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/19 03:01:24 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:24 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:24 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:24 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:24 DEBUG : TestFTPPureftpd: detected overridden config - adding "{RjC2s}" suffix to name 2026/04/19 03:01:24 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/19 03:01:24 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/19 03:01:24 DEBUG : Setting pass="VlYMHm3Bf14c7R_dQgMMuAqxeXUF8YYNu2VqkEzpkXY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/19 03:01:24 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/19 03:01:24 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/deeper/nonexisting/directory: Connecting to FTP server 2026/04/19 03:01:24 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/deeper/nonexisting/directory: dial("tcp","172.17.0.2:21") 2026/04/19 03:01:24 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa/deeper/nonexisting/directory: > dial: conn=172.17.0.1:34742->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2633: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2676: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2733: FS has no Directory methods and doesn't Wrap 2026/04/19 03:01:26 DEBUG : Waiting for deletions to finish 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31242") 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:55294->172.17.0.2:31242, err= 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35288") 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:53184->172.17.0.2:35288, err= 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:30732") 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:57566->172.17.0.2:30732, err= 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39957") 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:42608->172.17.0.2:39957, err= 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:36289") 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:40394->172.17.0.2:36289, err= 2026/04/19 03:01:26 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39823") 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:34070->172.17.0.2:39823, err= 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:38910") 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:45504->172.17.0.2:38910, err= 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31373") 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:53954->172.17.0.2:31373, err= 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:39250") 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:50420->172.17.0.2:39250, err= 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:37183") 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:38528->172.17.0.2:37183, err= 2026/04/19 03:01:26 DEBUG : removing 1 level 4 directories 2026/04/19 03:01:26 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/04/19 03:01:26 DEBUG : removing 1 level 3 directories 2026/04/19 03:01:26 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/04/19 03:01:26 DEBUG : removing 1 level 2 directories 2026/04/19 03:01:26 INFO : hello? sausage/êé: Removing directory 2026/04/19 03:01:26 DEBUG : removing 1 level 1 directories 2026/04/19 03:01:26 INFO : hello? sausage: Removing directory 2026/04/19 03:01:26 DEBUG : removing 1 level 0 directories 2026/04/19 03:01:26 INFO : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: Removing directory 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:31129") 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:41164->172.17.0.2:31129, err= 2026/04/19 03:01:26 ERROR : error listing: directory not found 2026/04/19 03:01:26 DEBUG : Waiting for deletions to finish 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:35119") 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:56808->172.17.0.2:35119, err= 2026/04/19 03:01:26 ERROR : error listing: directory not found 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: dial("tcp","172.17.0.2:33795") 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: > dial: conn=172.17.0.1:43640->172.17.0.2:33795, err= 2026/04/19 03:01:26 ERROR : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: Failed to list "": directory not found 2026/04/19 03:01:26 DEBUG : removing 1 level 0 directories 2026/04/19 03:01:26 INFO : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: Removing directory 2026/04/19 03:01:26 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/04/19 03:01:26 DEBUG : ftp://172.17.0.2:21/rclone-test-kawexuc1yusa: closing 2 unused connections 2026/04/19 03:01:26 NOTICE: TestFTPPureftpd: Stopping server --- FAIL: TestIntegration (27.97s) --- 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) --- FAIL: TestIntegration/FsMkdir (24.51s) --- 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.10s) --- 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.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.00s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (3.25s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles (18.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (2.25s) --- 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.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.00s) --- 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 (4.35s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (2.22s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (2.22s) --- 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 (2.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (2.25s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.00s) --- 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.00s) --- 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) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal (1.01s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (1.01s) --- 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.00s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (2.23s) --- 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) FAIL exit status 1 FAIL github.com/rclone/rclone/backend/ftp 27.984s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished ERROR in 28.763489724s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout]