"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPPureftpd:" 2026/04/26 03:26:42 NOTICE: TestFTPPureftpd: Starting server 2026/04/26 03:26:43 NOTICE: TestFTPPureftpd: Attempting to connect to "172.17.0.4:21" try 1/100 2026/04/26 03:26:43 DEBUG : TestFTPPureftpd: Read 1, error: 2026/04/26 03:26:43 NOTICE: TestFTPPureftpd: Started server and connected to "172.17.0.4:21" 2026/04/26 03:26:43 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-qepixup9nula" 2026/04/26 03:26:43 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/04/26 03:26:43 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/26 03:26:43 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:26:43 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:26:43 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:26:43 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:26:43 DEBUG : TestFTPPureftpd: detected overridden config - adding "{50RiW}" suffix to name 2026/04/26 03:26:43 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:26:43 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:26:43 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:26:43 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:26:43 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: Connecting to FTP server 2026/04/26 03:26:43 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:21") 2026/04/26 03:26:43 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:44648->172.17.0.4:21, err= 2026/04/26 03:26:45 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/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:30700") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:56706->172.17.0.4:30700, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32339") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:55436->172.17.0.4:32339, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/04/26 03:26:45 INFO : dir/subdir: Making directory 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39707") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:37346->172.17.0.4:39707, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37084") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:33258->172.17.0.4:37084, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:30580") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:37528->172.17.0.4:30580, err= 2026/04/26 03:26:45 INFO : dir/subdir: Removing directory 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35991") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:60520->172.17.0.4:35991, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39595") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:49268->172.17.0.4:39595, err= 2026/04/26 03:26:45 INFO : dir: Removing directory 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38007") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:58396->172.17.0.4:38007, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32048") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:43412->172.17.0.4:32048, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37185") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:48586->172.17.0.4:37185, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35835") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:51572->172.17.0.4:35835, err= 2026/04/26 03:26:45 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/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38529") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:50764->172.17.0.4:38529, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:708: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37959") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:60388->172.17.0.4:37959, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39269") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:46502->172.17.0.4:39269, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37565") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:53216->172.17.0.4:37565, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:31184") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:34204->172.17.0.4:31184, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:708: testing "." 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32287") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:53996->172.17.0.4:32287, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:30351") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:51534->172.17.0.4:30351, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34278") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:48356->172.17.0.4:34278, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38054") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:34498->172.17.0.4:38054, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:708: testing ".." 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37858") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:40094->172.17.0.4:37858, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34929") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:35450->172.17.0.4:34929, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:31801") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:55384->172.17.0.4:31801, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39909") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:42106->172.17.0.4:39909, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:708: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37673") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:56622->172.17.0.4:37673, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35126") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:48626->172.17.0.4:35126, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37272") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:53096->172.17.0.4:37272, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32404") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:40448->172.17.0.4:32404, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:708: testing " leading space" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34517") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:58780->172.17.0.4:34517, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:33635") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:54928->172.17.0.4:33635, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:31572") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:49588->172.17.0.4:31572, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38971") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:40552->172.17.0.4:38971, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:708: testing "~leading tilde" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37175") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:58048->172.17.0.4:37175, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37494") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:59336->172.17.0.4:37494, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32346") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:34544->172.17.0.4:32346, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:33724") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:49530->172.17.0.4:33724, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:708: testing "␍leading CR" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:36704") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:45008->172.17.0.4:36704, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37947") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:41468->172.17.0.4:37947, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:33943") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:35208->172.17.0.4:33943, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:30136") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:57724->172.17.0.4:30136, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:708: testing "␊leading LF" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39375") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:35126->172.17.0.4:39375, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32033") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:51942->172.17.0.4:32033, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39680") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:47676->172.17.0.4:39680, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32964") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:42332->172.17.0.4:32964, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:708: testing "␉leading HT" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:36636") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:56982->172.17.0.4:36636, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:30875") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:50532->172.17.0.4:30875, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:33976") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:45216->172.17.0.4:33976, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38523") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:41066->172.17.0.4:38523, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:708: testing "␋leading VT" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39461") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:47728->172.17.0.4:39461, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39715") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:34098->172.17.0.4:39715, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38307") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:40048->172.17.0.4:38307, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:30593") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:57890->172.17.0.4:30593, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:708: testing ".leading dot" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34721") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:53584->172.17.0.4:34721, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37340") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:56786->172.17.0.4:37340, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39667") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:55028->172.17.0.4:39667, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:31372") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:58586->172.17.0.4:31372, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:708: testing "trailing space " 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39891") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:50744->172.17.0.4:39891, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35206") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:60262->172.17.0.4:35206, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38989") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:46954->172.17.0.4:38989, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:36167") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:60084->172.17.0.4:36167, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:708: testing "trailing CR␍" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37715") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:46930->172.17.0.4:37715, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35852") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:37160->172.17.0.4:35852, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32768") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:57446->172.17.0.4:32768, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:30844") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:60726->172.17.0.4:30844, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:708: testing "trailing LF␊" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37421") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:33154->172.17.0.4:37421, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39046") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:34584->172.17.0.4:39046, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39273") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:58956->172.17.0.4:39273, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34476") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:60294->172.17.0.4:34476, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:708: testing "trailing HT␉" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35415") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:58878->172.17.0.4:35415, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39149") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:39146->172.17.0.4:39149, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34639") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:49750->172.17.0.4:34639, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38205") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:38984->172.17.0.4:38205, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:708: testing "trailing VT␋" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37739") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:38980->172.17.0.4:37739, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34538") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:57426->172.17.0.4:34538, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35691") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:58598->172.17.0.4:35691, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35547") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:53040->172.17.0.4:35547, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:708: testing "trailing dot." 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37759") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:49340->172.17.0.4:37759, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:33475") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:36272->172.17.0.4:33475, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35910") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:45664->172.17.0.4:35910, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35515") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:40372->172.17.0.4:35515, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:708: testing "invalid utf-8\xfe" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:30829") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:48388->172.17.0.4:30829, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39050") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:35098->172.17.0.4:39050, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:30461") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:41338->172.17.0.4:30461, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37513") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:53294->172.17.0.4:37513, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:708: testing "test%46.txt" 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32502") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:46264->172.17.0.4:32502, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:36658") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:56604->172.17.0.4:36658, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39315") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:51552->172.17.0.4:39315, err= 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37511") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:36928->172.17.0.4:37511, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32657") 2026/04/26 03:26:45 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:54048->172.17.0.4:32657, err= 2026/04/26 03:26:46 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: Connecting to FTP server 2026/04/26 03:26:46 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:21") 2026/04/26 03:26:46 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:44658->172.17.0.4:21, err= 2026/04/26 03:26:49 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32446") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:39452->172.17.0.4:32446, err= 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37427") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:41214->172.17.0.4:37427, 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:873: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38357") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:37692->172.17.0.4:38357, err= 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38543") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:56386->172.17.0.4:38543, err= 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:30480") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:55914->172.17.0.4:30480, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37125") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:39392->172.17.0.4:37125, err= 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:30373") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:49698->172.17.0.4:30373, err= 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:36226") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:36926->172.17.0.4:36226, err= 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:30619") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:38838->172.17.0.4:30619, err= 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:30869") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:50796->172.17.0.4:30869, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32937") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:38086->172.17.0.4:32937, err= 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:31314") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:35672->172.17.0.4:31314, err= 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:31103") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:43192->172.17.0.4:31103, err= 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35141") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:45764->172.17.0.4:35141, err= 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38968") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:34786->172.17.0.4:38968, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34904") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:41230->172.17.0.4:34904, err= 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:33575") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:59352->172.17.0.4:33575, err= 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34062") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:46984->172.17.0.4:34062, err= 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37693") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:37008->172.17.0.4:37693, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/04/26 03:26:49 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2026/04/26 03:26:49 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/26 03:26:49 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:26:49 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:26:49 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:26:49 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:26:49 DEBUG : TestFTPPureftpd: detected overridden config - adding "{50RiW}" suffix to name 2026/04/26 03:26:49 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:26:49 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:26:49 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:26:49 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2026/04/26 03:26:49 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44666->172.17.0.4:21, err= 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:39546") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:52314->172.17.0.4:39546, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:33355") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:54672->172.17.0.4:33355, err= 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:36491") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:53590->172.17.0.4:36491, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35038") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:41792->172.17.0.4:35038, err= 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35174") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:37514->172.17.0.4:35174, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34195") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:54944->172.17.0.4:34195, err= 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:36444") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:47760->172.17.0.4:36444, err= 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37895") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:53600->172.17.0.4:37895, err= 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34735") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:37636->172.17.0.4:34735, err= 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:31637") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:33864->172.17.0.4:31637, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1126: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:31641") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:59870->172.17.0.4:31641, err= 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:33747") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:47054->172.17.0.4:33747, err= 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:36329") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:48896->172.17.0.4:36329, err= 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39961") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:39354->172.17.0.4:39961, err= 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34939") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:58448->172.17.0.4:34939, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1158: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1195: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/04/26 03:26:51 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-qepixup9nula/hello? sausage/êé" 2026/04/26 03:26:51 DEBUG : Config file has changed externally - reloading 2026/04/26 03:26:51 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/26 03:26:51 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:26:51 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:26:51 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:26:51 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:26:51 DEBUG : TestFTPPureftpd: detected overridden config - adding "{50RiW}" suffix to name 2026/04/26 03:26:51 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:26:51 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:26:51 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:26:51 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: Connecting to FTP server 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2026/04/26 03:26:51 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:47678->172.17.0.4:21, err= 2026/04/26 03:26:54 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-qepixup9nula/hello? sausage/êé" to be canonical "TestFTPPureftpd{50RiW}:rclone-test-qepixup9nula/hello? sausage/êé" 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:30299") 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:36914->172.17.0.4:30299, err= 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:33282") 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:42142->172.17.0.4:33282, err= 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: Connecting to FTP server 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:37195") 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:47680->172.17.0.4:21, err= 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:52592->172.17.0.4:37195, err= 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:35721") 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:53150->172.17.0.4:35721, err= 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:30886") 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:58468->172.17.0.4:30886, err= 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:37860") 2026/04/26 03:26:54 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:42356->172.17.0.4:37860, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:35279") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:56950->172.17.0.4:35279, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:34602") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:43708->172.17.0.4:34602, err= 2026/04/26 03:26:56 DEBUG : Waiting for deletions to finish 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:39127") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:55200->172.17.0.4:39127, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:38905") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:46926->172.17.0.4:38905, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:33680") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:46138->172.17.0.4:33680, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:32264") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:55844->172.17.0.4:32264, err= 2026/04/26 03:26:56 INFO : a/b/c/d/e.txt: Deleted 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:34188") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:52204->172.17.0.4:34188, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:37122") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:33392->172.17.0.4:37122, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:38276") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:36680->172.17.0.4:38276, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: dial("tcp","172.17.0.4:38665") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé: > dial: conn=172.17.0.1:51908->172.17.0.4:38665, err= 2026/04/26 03:26:56 DEBUG : removing 1 level 4 directories 2026/04/26 03:26:56 INFO : a/b/c/d: Removing directory 2026/04/26 03:26:56 DEBUG : removing 1 level 3 directories 2026/04/26 03:26:56 INFO : a/b/c: Removing directory 2026/04/26 03:26:56 DEBUG : removing 1 level 2 directories 2026/04/26 03:26:56 INFO : a/b: Removing directory 2026/04/26 03:26:56 DEBUG : removing 1 level 1 directories 2026/04/26 03:26:56 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1259: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38192") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:43532->172.17.0.4:38192, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39893") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:60510->172.17.0.4:39893, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:36114") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:52038->172.17.0.4:36114, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:31046") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:37826->172.17.0.4:31046, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38735") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:58092->172.17.0.4:38735, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:36761") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:39782->172.17.0.4:36761, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: Connecting to FTP server 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:21") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35609") 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:52736->172.17.0.4:35609, err= 2026/04/26 03:26:56 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:47684->172.17.0.4:21, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39250") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:41942->172.17.0.4:39250, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37910") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:54742->172.17.0.4:37910, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34562") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:53026->172.17.0.4:34562, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32653") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:42586->172.17.0.4:32653, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39379") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:50210->172.17.0.4:39379, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38749") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:56914->172.17.0.4:38749, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37363") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:50302->172.17.0.4:37363, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35526") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:50088->172.17.0.4:35526, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39957") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:35604->172.17.0.4:39957, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32735") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:33294->172.17.0.4:32735, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38948") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:42834->172.17.0.4:38948, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:33782") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38768") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:56588->172.17.0.4:33782, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:36686->172.17.0.4:38768, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:33031") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:39396->172.17.0.4:33031, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:30822") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:42470->172.17.0.4:30822, err= 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38955") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:40650->172.17.0.4:38955, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1407: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/04/26 03:26:58 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-neqelor8gupo" 2026/04/26 03:26:58 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/26 03:26:58 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:26:58 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:26:58 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:26:58 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:26:58 DEBUG : TestFTPPureftpd: detected overridden config - adding "{50RiW}" suffix to name 2026/04/26 03:26:58 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:26:58 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:26:58 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:26:58 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: Connecting to FTP server 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: dial("tcp","172.17.0.4:21") 2026/04/26 03:26:58 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: > dial: conn=172.17.0.1:47690->172.17.0.4:21, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38883") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:40428->172.17.0.4:38883, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: dial("tcp","172.17.0.4:34717") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: > dial: conn=172.17.0.1:33996->172.17.0.4:34717, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: dial("tcp","172.17.0.4:33066") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: > dial: conn=172.17.0.1:49204->172.17.0.4:33066, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: dial("tcp","172.17.0.4:36514") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: > dial: conn=172.17.0.1:48436->172.17.0.4:36514, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: dial("tcp","172.17.0.4:30229") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: > dial: conn=172.17.0.1:48804->172.17.0.4:30229, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: dial("tcp","172.17.0.4:33432") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: > dial: conn=172.17.0.1:34712->172.17.0.4:33432, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: dial("tcp","172.17.0.4:38983") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: > dial: conn=172.17.0.1:36606->172.17.0.4:38983, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: dial("tcp","172.17.0.4:37119") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: > dial: conn=172.17.0.1:40314->172.17.0.4:37119, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32478") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:52932->172.17.0.4:32478, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38401") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:46742->172.17.0.4:38401, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37075") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:44788->172.17.0.4:37075, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:33680") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:46144->172.17.0.4:33680, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39953") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:54634->172.17.0.4:39953, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: dial("tcp","172.17.0.4:33375") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: > dial: conn=172.17.0.1:55316->172.17.0.4:33375, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: dial("tcp","172.17.0.4:36555") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: > dial: conn=172.17.0.1:60650->172.17.0.4:36555, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: dial("tcp","172.17.0.4:36300") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: > dial: conn=172.17.0.1:42480->172.17.0.4:36300, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: dial("tcp","172.17.0.4:35355") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: > dial: conn=172.17.0.1:50042->172.17.0.4:35355, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: Purge dir "new_name" 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-neqelor8gupo: 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:1601: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1632: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1703: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:36317") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:39498->172.17.0.4:36317, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34740") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:49816->172.17.0.4:34740, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:33090") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:34498->172.17.0.4:33090, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39289") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:60458->172.17.0.4:39289, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34064") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:43722->172.17.0.4:34064, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35998") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:58692->172.17.0.4:35998, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39142") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:33788->172.17.0.4:39142, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35480") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:60326->172.17.0.4:35480, err= 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34106") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:36040->172.17.0.4:34106, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/04/26 03:27:00 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-qepixup9nula/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/04/26 03:27:00 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/26 03:27:00 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:27:00 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:27:00 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:27:00 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:27:00 DEBUG : TestFTPPureftpd: detected overridden config - adding "{50RiW}" suffix to name 2026/04/26 03:27:00 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:27:00 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:27:00 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:27:00 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2026/04/26 03:27:00 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:47706->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/04/26 03:27:03 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:39356") 2026/04/26 03:27:03 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:41774->172.17.0.4:39356, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/04/26 03:27:03 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-qepixup9nula/not found.txt" 2026/04/26 03:27:03 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/26 03:27:03 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:27:03 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:27:03 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:27:03 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:27:03 DEBUG : TestFTPPureftpd: detected overridden config - adding "{50RiW}" suffix to name 2026/04/26 03:27:03 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:27:03 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:27:03 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:27:03 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:27:03 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/not found.txt: Connecting to FTP server 2026/04/26 03:27:03 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/not found.txt: dial("tcp","172.17.0.4:21") 2026/04/26 03:27:03 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/not found.txt: > dial: conn=172.17.0.1:57444->172.17.0.4:21, err= 2026/04/26 03:27:05 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/not found.txt: dial("tcp","172.17.0.4:38889") 2026/04/26 03:27:05 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/not found.txt: > dial: conn=172.17.0.1:46182->172.17.0.4:38889, err= 2026/04/26 03:27:05 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1920: Opening root remote "TestFTPPureftpd:" path "rclone-test-qepixup9nula" from "TestFTPPureftpd:rclone-test-qepixup9nula" 2026/04/26 03:27:05 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2026/04/26 03:27:05 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/26 03:27:05 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:27:05 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:27:05 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:27:05 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:27:05 DEBUG : TestFTPPureftpd: detected overridden config - adding "{50RiW}" suffix to name 2026/04/26 03:27:05 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:27:05 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:27:05 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:27:05 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:27:05 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2026/04/26 03:27:05 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2026/04/26 03:27:05 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:57448->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:39355") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37398->172.17.0.4:39355, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:32442") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:52838->172.17.0.4:32442, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:38372") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:41006->172.17.0.4:38372, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35325") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:59910->172.17.0.4:35325, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:36089") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37380->172.17.0.4:36089, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:38380") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34794->172.17.0.4:38380, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1957: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35827") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58746->172.17.0.4:35827, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:31959") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:48972->172.17.0.4:31959, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:32265") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:33754->172.17.0.4:32265, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:31113") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:53812->172.17.0.4:31113, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:32353") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:48100->172.17.0.4:32353, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:31433") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44012->172.17.0.4:31433, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:36562") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44442->172.17.0.4:36562, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37035") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:48096->172.17.0.4:37035, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:33459") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:41026->172.17.0.4:33459, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37339") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:52512->172.17.0.4:37339, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30162") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:41644->172.17.0.4:30162, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2016: 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:2121: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2137: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:33786") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:58236->172.17.0.4:33786, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:31423") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:45484->172.17.0.4:31423, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32808") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:46598->172.17.0.4:32808, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35966") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:43216->172.17.0.4:35966, err= 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39026") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:59146->172.17.0.4:39026, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2293: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:33641") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:57272->172.17.0.4:33641, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37509") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:52642->172.17.0.4:37509, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/04/26 03:27:07 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-qepixup9nula" 2026/04/26 03:27:07 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/26 03:27:07 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:27:07 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:27:07 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:27:07 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:27:07 DEBUG : TestFTPPureftpd: detected overridden config - adding "{KoP1f}" suffix to name 2026/04/26 03:27:07 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:27:07 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:27:07 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:27:07 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: Connecting to FTP server 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:21") 2026/04/26 03:27:07 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:57464->172.17.0.4:21, err= 2026/04/26 03:27:08 DEBUG : pacer: low level retry 1/1 (error read tcp 172.17.0.1:57464->172.17.0.4:21: i/o timeout) 2026/04/26 03:27:08 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.4:21": read tcp 172.17.0.1:57464->172.17.0.4:21: i/o timeout Test: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2376: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2488: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/04/26 03:27:08 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:31166") 2026/04/26 03:27:08 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:33406->172.17.0.4:31166, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/04/26 03:27:08 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35601") 2026/04/26 03:27:08 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:53464->172.17.0.4:35601, err= 2026/04/26 03:27:08 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:38473") 2026/04/26 03:27:08 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:39624->172.17.0.4:38473, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/04/26 03:27:08 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-qepixup9nula/deeper/nonexisting/directory" 2026/04/26 03:27:08 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/04/26 03:27:08 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:27:08 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:27:08 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:27:08 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:27:08 DEBUG : TestFTPPureftpd: detected overridden config - adding "{50RiW}" suffix to name 2026/04/26 03:27:08 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/04/26 03:27:08 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/04/26 03:27:08 DEBUG : Setting pass="sXX3whv5Ftspn5feMrYT-xwmwwDIwcWdICnksz7_bgk" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/04/26 03:27:08 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/04/26 03:27:08 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/deeper/nonexisting/directory: Connecting to FTP server 2026/04/26 03:27:08 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2026/04/26 03:27:08 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula/deeper/nonexisting/directory: > dial: conn=172.17.0.1:57478->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2637: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2680: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2737: FS has no Directory methods and doesn't Wrap 2026/04/26 03:27:10 DEBUG : Waiting for deletions to finish 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34719") 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:45586->172.17.0.4:34719, err= 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32074") 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:40390->172.17.0.4:32074, err= 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:31333") 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:46714->172.17.0.4:31333, err= 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34812") 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:52918->172.17.0.4:34812, err= 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:36220") 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:51226->172.17.0.4:36220, err= 2026/04/26 03:27:10 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:34096") 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:43130->172.17.0.4:34096, err= 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:36112") 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:54382->172.17.0.4:36112, err= 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37978") 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:48998->172.17.0.4:37978, err= 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:37686") 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:52432->172.17.0.4:37686, err= 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:32082") 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:57966->172.17.0.4:32082, err= 2026/04/26 03:27:10 DEBUG : removing 1 level 4 directories 2026/04/26 03:27:10 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/04/26 03:27:10 DEBUG : removing 1 level 3 directories 2026/04/26 03:27:10 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/04/26 03:27:10 DEBUG : removing 1 level 2 directories 2026/04/26 03:27:10 INFO : hello? sausage/êé: Removing directory 2026/04/26 03:27:10 DEBUG : removing 1 level 1 directories 2026/04/26 03:27:10 INFO : hello? sausage: Removing directory 2026/04/26 03:27:10 DEBUG : removing 1 level 0 directories 2026/04/26 03:27:10 INFO : ftp://172.17.0.4:21/rclone-test-qepixup9nula: Removing directory 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:39385") 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:42976->172.17.0.4:39385, err= 2026/04/26 03:27:10 ERROR : error listing: directory not found 2026/04/26 03:27:10 DEBUG : Waiting for deletions to finish 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35814") 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:54102->172.17.0.4:35814, err= 2026/04/26 03:27:10 ERROR : error listing: directory not found 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: dial("tcp","172.17.0.4:35449") 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: > dial: conn=172.17.0.1:48118->172.17.0.4:35449, err= 2026/04/26 03:27:10 ERROR : ftp://172.17.0.4:21/rclone-test-qepixup9nula: Failed to list "": directory not found 2026/04/26 03:27:10 DEBUG : removing 1 level 0 directories 2026/04/26 03:27:10 INFO : ftp://172.17.0.4:21/rclone-test-qepixup9nula: Removing directory 2026/04/26 03:27:10 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/04/26 03:27:10 DEBUG : ftp://172.17.0.4:21/rclone-test-qepixup9nula: closing 2 unused connections 2026/04/26 03:27:10 NOTICE: TestFTPPureftpd: Stopping server --- FAIL: TestIntegration (28.70s) --- 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 (25.30s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.00s) --- 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.08s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.00s) --- 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.49s) --- 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 (19.47s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (2.47s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (4.57s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (2.38s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (2.24s) --- 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.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (2.27s) --- 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.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- 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.22s) --- 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 28.710s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished ERROR in 30.047376533s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout]