"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPPureftpd:" 2025/10/13 01:19:32 NOTICE: TestFTPPureftpd: Stopping server 2025/10/13 01:19:33 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 2/10 2025/10/13 01:19:33 NOTICE: TestFTPPureftpd: Stopping server 2025/10/13 01:19:34 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 3/10 2025/10/13 01:19:34 NOTICE: TestFTPPureftpd: Stopping server 2025/10/13 01:19:35 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 4/10 2025/10/13 01:19:35 NOTICE: TestFTPPureftpd: Stopping server 2025/10/13 01:19:36 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 5/10 2025/10/13 01:19:36 NOTICE: TestFTPPureftpd: Stopping server 2025/10/13 01:19:37 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 6/10 2025/10/13 01:19:37 NOTICE: TestFTPPureftpd: Stopping server 2025/10/13 01:19:38 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 7/10 2025/10/13 01:19:38 NOTICE: TestFTPPureftpd: Stopping server 2025/10/13 01:19:39 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 8/10 2025/10/13 01:19:39 NOTICE: TestFTPPureftpd: Stopping server 2025/10/13 01:19:40 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 9/10 2025/10/13 01:19:40 NOTICE: TestFTPPureftpd: Stopping server 2025/10/13 01:19:41 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 10/10 2025/10/13 01:19:41 NOTICE: TestFTPPureftpd: Stopping server 2025/10/13 01:19:41 NOTICE: TestFTPPureftpd: Starting server 2025/10/13 01:19:42 NOTICE: TestFTPPureftpd: Attempting to connect to "172.17.0.2:21" try 1/100 2025/10/13 01:19:42 DEBUG : TestFTPPureftpd: Read 1, error: 2025/10/13 01:19:42 NOTICE: TestFTPPureftpd: Started server and connected to "172.17.0.2:21" 2025/10/13 01:19:42 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-rufoqed0duja" 2025/10/13 01:19:42 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/13 01:19:42 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/13 01:19:42 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:42 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:42 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:42 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:42 DEBUG : TestFTPPureftpd: detected overridden config - adding "{b4X_I}" suffix to name 2025/10/13 01:19:42 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:42 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:42 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:42 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:42 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: Connecting to FTP server 2025/10/13 01:19:42 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:21") 2025/10/13 01:19:42 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:51952->172.17.0.2:21, err= 2025/10/13 01:19:43 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 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33858") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:44368->172.17.0.2:33858, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33689") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:39168->172.17.0.2:33689, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/10/13 01:19:43 INFO : dir/subdir: Making directory 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30318") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:33318->172.17.0.2:30318, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:37589") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:43598->172.17.0.2:37589, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30563") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:52810->172.17.0.2:30563, err= 2025/10/13 01:19:43 INFO : dir/subdir: Removing directory 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32505") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:36816->172.17.0.2:32505, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30821") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:54446->172.17.0.2:30821, err= 2025/10/13 01:19:43 INFO : dir: Removing directory 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:37605") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:47878->172.17.0.2:37605, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:37381") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:51054->172.17.0.2:37381, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39597") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:47268->172.17.0.2:39597, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34486") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:60212->172.17.0.2:34486, err= 2025/10/13 01:19:43 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34371") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:45914->172.17.0.2:34371, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33645") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:55194->172.17.0.2:33645, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34790") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:53362->172.17.0.2:34790, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38420") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:54652->172.17.0.2:38420, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30849") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:44498->172.17.0.2:30849, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31630") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:51404->172.17.0.2:31630, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31873") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:52500->172.17.0.2:31873, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30977") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:45342->172.17.0.2:30977, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33537") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:57216->172.17.0.2:33537, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33885") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:46252->172.17.0.2:33885, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30285") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:37922->172.17.0.2:30285, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33213") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:53764->172.17.0.2:33213, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31142") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:37412->172.17.0.2:31142, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30349") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:56686->172.17.0.2:30349, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34031") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:37670->172.17.0.2:34031, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34205") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:38260->172.17.0.2:34205, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31096") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:49342->172.17.0.2:31096, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31272") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:51264->172.17.0.2:31272, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32445") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:52902->172.17.0.2:32445, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:36813") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:44584->172.17.0.2:36813, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34999") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:52982->172.17.0.2:34999, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30881") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:34616->172.17.0.2:30881, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33748") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:37204->172.17.0.2:33748, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35323") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:35406->172.17.0.2:35323, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34572") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:46570->172.17.0.2:34572, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39099") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:52150->172.17.0.2:39099, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35848") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:52766->172.17.0.2:35848, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31136") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:37274->172.17.0.2:31136, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38515") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:40142->172.17.0.2:38515, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39860") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:38286->172.17.0.2:39860, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35980") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:51610->172.17.0.2:35980, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33102") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:48892->172.17.0.2:33102, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35934") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:47062->172.17.0.2:35934, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:36484") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:55990->172.17.0.2:36484, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31397") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:46956->172.17.0.2:31397, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34274") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:38952->172.17.0.2:34274, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30921") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:43154->172.17.0.2:30921, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39430") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:60046->172.17.0.2:39430, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39827") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:36214->172.17.0.2:39827, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34248") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:52254->172.17.0.2:34248, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35544") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:57712->172.17.0.2:35544, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32651") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:40122->172.17.0.2:32651, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39709") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:48648->172.17.0.2:39709, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:37492") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:45038->172.17.0.2:37492, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30029") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:60832->172.17.0.2:30029, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33103") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:43690->172.17.0.2:33103, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38822") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:37214->172.17.0.2:38822, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31738") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:35898->172.17.0.2:31738, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38010") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:37684->172.17.0.2:38010, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35125") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:41310->172.17.0.2:35125, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32252") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:46182->172.17.0.2:32252, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38426") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:54600->172.17.0.2:38426, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30250") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:48618->172.17.0.2:30250, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31134") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:41948->172.17.0.2:31134, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32843") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:54644->172.17.0.2:32843, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32238") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:56692->172.17.0.2:32238, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39570") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:36378->172.17.0.2:39570, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30613") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:47286->172.17.0.2:30613, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:36924") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:35346->172.17.0.2:36924, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31337") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:34168->172.17.0.2:31337, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35344") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:47662->172.17.0.2:35344, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30356") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:52324->172.17.0.2:30356, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39657") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:43082->172.17.0.2:39657, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38021") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:58126->172.17.0.2:38021, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33342") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:33242->172.17.0.2:33342, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32846") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:43686->172.17.0.2:32846, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30484") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:33800->172.17.0.2:30484, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32568") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:39076->172.17.0.2:32568, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:36453") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:55928->172.17.0.2:36453, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33872") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:59836->172.17.0.2:33872, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35750") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:44638->172.17.0.2:35750, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:37823") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:53528->172.17.0.2:37823, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35918") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:57694->172.17.0.2:35918, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:37420") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:58140->172.17.0.2:37420, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38966") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:48460->172.17.0.2:38966, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39754") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:38226->172.17.0.2:39754, err= 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34145") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:55258->172.17.0.2:34145, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31504") 2025/10/13 01:19:43 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:56532->172.17.0.2:31504, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: Connecting to FTP server 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:21") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:51958->172.17.0.2:21, err= 2025/10/13 01:19:44 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:37204") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:51332->172.17.0.2:37204, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33089") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:37708->172.17.0.2:33089, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:36773") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:49712->172.17.0.2:36773, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31848") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:42822->172.17.0.2:31848, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38341") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:32784->172.17.0.2:38341, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:37058") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:53906->172.17.0.2:37058, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31305") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:46792->172.17.0.2:31305, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34538") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:48874->172.17.0.2:34538, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38882") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:57852->172.17.0.2:38882, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31093") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:43154->172.17.0.2:31093, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38109") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:46276->172.17.0.2:38109, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35195") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:52454->172.17.0.2:35195, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30547") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:46832->172.17.0.2:30547, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38203") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:57162->172.17.0.2:38203, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38170") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:44888->172.17.0.2:38170, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38068") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:45718->172.17.0.2:38068, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32066") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:35692->172.17.0.2:32066, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:36571") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:60256->172.17.0.2:36571, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:37658") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:40734->172.17.0.2:37658, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/10/13 01:19:44 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/10/13 01:19:44 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/13 01:19:44 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:44 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:44 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:44 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:44 DEBUG : TestFTPPureftpd: detected overridden config - adding "{b4X_I}" suffix to name 2025/10/13 01:19:44 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:44 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:44 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:44 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:51960->172.17.0.2:21, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:30709") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:38328->172.17.0.2:30709, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38509") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:39770->172.17.0.2:38509, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34316") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:34650->172.17.0.2:34316, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32893") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:50800->172.17.0.2:32893, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38541") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:36230->172.17.0.2:38541, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38123") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:35722->172.17.0.2:38123, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:36082") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:34142->172.17.0.2:36082, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:37128") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:37418->172.17.0.2:37128, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30522") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:46398->172.17.0.2:30522, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35748") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:42500->172.17.0.2:35748, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32195") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:57026->172.17.0.2:32195, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35335") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:40254->172.17.0.2:35335, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34131") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:60696->172.17.0.2:34131, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35092") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:38564->172.17.0.2:35092, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33010") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:34588->172.17.0.2:33010, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1153: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1190: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/10/13 01:19:44 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-rufoqed0duja/hello? sausage/êé" 2025/10/13 01:19:44 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/13 01:19:44 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:44 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:44 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:44 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:44 DEBUG : TestFTPPureftpd: detected overridden config - adding "{b4X_I}" suffix to name 2025/10/13 01:19:44 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:44 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:44 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:44 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: Connecting to FTP server 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:51964->172.17.0.2:21, err= 2025/10/13 01:19:44 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-rufoqed0duja/hello? sausage/êé" to be canonical "TestFTPPureftpd{b4X_I}:rclone-test-rufoqed0duja/hello? sausage/êé" 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:33250") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:44042->172.17.0.2:33250, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:33241") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:33740->172.17.0.2:33241, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: Connecting to FTP server 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:36477") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:60666->172.17.0.2:36477, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:51970->172.17.0.2:21, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:36790") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:48336->172.17.0.2:36790, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:31190") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:52572->172.17.0.2:31190, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:36348") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:59064->172.17.0.2:36348, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:32595") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:47006->172.17.0.2:32595, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:31481") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:54764->172.17.0.2:31481, err= 2025/10/13 01:19:44 DEBUG : Waiting for deletions to finish 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:31294") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:46996->172.17.0.2:31294, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:31999") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:53230->172.17.0.2:31999, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:30802") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:52308->172.17.0.2:30802, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:37868") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:56408->172.17.0.2:37868, err= 2025/10/13 01:19:44 INFO : a/b/c/d/e.txt: Deleted 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:36857") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:47316->172.17.0.2:36857, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:33092") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:60004->172.17.0.2:33092, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:33370") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:59480->172.17.0.2:33370, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: dial("tcp","172.17.0.2:31880") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé: > dial: conn=172.17.0.1:48576->172.17.0.2:31880, err= 2025/10/13 01:19:44 DEBUG : removing 1 level 4 directories 2025/10/13 01:19:44 INFO : a/b/c/d: Removing directory 2025/10/13 01:19:44 DEBUG : removing 1 level 3 directories 2025/10/13 01:19:44 INFO : a/b/c: Removing directory 2025/10/13 01:19:44 DEBUG : removing 1 level 2 directories 2025/10/13 01:19:44 INFO : a/b: Removing directory 2025/10/13 01:19:44 DEBUG : removing 1 level 1 directories 2025/10/13 01:19:44 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38683") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:33026->172.17.0.2:38683, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39118") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:47032->172.17.0.2:39118, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35618") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:38948->172.17.0.2:35618, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39492") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:47244->172.17.0.2:39492, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34526") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:35546->172.17.0.2:34526, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39174") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:58906->172.17.0.2:39174, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: Connecting to FTP server 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:21") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32634") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:51978->172.17.0.2:21, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:59298->172.17.0.2:32634, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:36001") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:55090->172.17.0.2:36001, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32592") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:45396->172.17.0.2:32592, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33811") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:36710->172.17.0.2:33811, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33898") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:53150->172.17.0.2:33898, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:36855") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:46502->172.17.0.2:36855, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34138") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:41338->172.17.0.2:34138, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38432") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:51808->172.17.0.2:38432, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39052") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:38818->172.17.0.2:39052, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:37061") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:49500->172.17.0.2:37061, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38041") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:55328->172.17.0.2:38041, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31787") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:33628->172.17.0.2:31787, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:37658") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38231") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:40748->172.17.0.2:37658, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:53178->172.17.0.2:38231, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34196") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:60084->172.17.0.2:34196, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:36885") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:38964->172.17.0.2:36885, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30987") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:52234->172.17.0.2:30987, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/10/13 01:19:44 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-bolavup2wuqo" 2025/10/13 01:19:44 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/13 01:19:44 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:44 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:44 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:44 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:44 DEBUG : TestFTPPureftpd: detected overridden config - adding "{b4X_I}" suffix to name 2025/10/13 01:19:44 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:44 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:44 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:44 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: Connecting to FTP server 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: dial("tcp","172.17.0.2:21") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: > dial: conn=172.17.0.1:51984->172.17.0.2:21, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30979") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:41320->172.17.0.2:30979, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: dial("tcp","172.17.0.2:35546") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: > dial: conn=172.17.0.1:50082->172.17.0.2:35546, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: dial("tcp","172.17.0.2:38566") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: > dial: conn=172.17.0.1:52506->172.17.0.2:38566, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: dial("tcp","172.17.0.2:37497") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: > dial: conn=172.17.0.1:36740->172.17.0.2:37497, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: dial("tcp","172.17.0.2:34116") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: > dial: conn=172.17.0.1:45268->172.17.0.2:34116, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: dial("tcp","172.17.0.2:33345") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: > dial: conn=172.17.0.1:46878->172.17.0.2:33345, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: dial("tcp","172.17.0.2:30903") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: > dial: conn=172.17.0.1:43630->172.17.0.2:30903, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: dial("tcp","172.17.0.2:39833") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: > dial: conn=172.17.0.1:42082->172.17.0.2:39833, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35806") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:54996->172.17.0.2:35806, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30509") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:47758->172.17.0.2:30509, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30566") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:59306->172.17.0.2:30566, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39970") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:49336->172.17.0.2:39970, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31449") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:48238->172.17.0.2:31449, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: dial("tcp","172.17.0.2:39759") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: > dial: conn=172.17.0.1:46642->172.17.0.2:39759, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: dial("tcp","172.17.0.2:36867") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: > dial: conn=172.17.0.1:40266->172.17.0.2:36867, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: dial("tcp","172.17.0.2:33990") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: > dial: conn=172.17.0.1:44498->172.17.0.2:33990, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: dial("tcp","172.17.0.2:30597") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: > dial: conn=172.17.0.1:58346->172.17.0.2:30597, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: Purge dir "new_name" 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-bolavup2wuqo: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30319") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:38382->172.17.0.2:30319, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34424") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:51774->172.17.0.2:34424, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:31699") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:55874->172.17.0.2:31699, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32203") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:33530->172.17.0.2:32203, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38218") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:39394->172.17.0.2:38218, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:37894") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:49844->172.17.0.2:37894, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33421") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:59752->172.17.0.2:33421, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32939") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:48648->172.17.0.2:32939, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30770") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:51516->172.17.0.2:30770, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/10/13 01:19:44 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-rufoqed0duja/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/10/13 01:19:44 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/13 01:19:44 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:44 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:44 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:44 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:44 DEBUG : TestFTPPureftpd: detected overridden config - adding "{b4X_I}" suffix to name 2025/10/13 01:19:44 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:44 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:44 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:44 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:21") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:51986->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:34286") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:43218->172.17.0.2:34286, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/10/13 01:19:44 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-rufoqed0duja/not found.txt" 2025/10/13 01:19:44 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/13 01:19:44 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:44 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:44 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:44 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:44 DEBUG : TestFTPPureftpd: detected overridden config - adding "{b4X_I}" suffix to name 2025/10/13 01:19:44 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:44 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:44 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:44 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/not found.txt: Connecting to FTP server 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/not found.txt: dial("tcp","172.17.0.2:21") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/not found.txt: > dial: conn=172.17.0.1:51988->172.17.0.2:21, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/not found.txt: dial("tcp","172.17.0.2:31372") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/not found.txt: > dial: conn=172.17.0.1:48616->172.17.0.2:31372, err= 2025/10/13 01:19:44 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPPureftpd:" path "rclone-test-rufoqed0duja" from "TestFTPPureftpd:rclone-test-rufoqed0duja" 2025/10/13 01:19:44 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/10/13 01:19:44 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/13 01:19:44 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:44 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:44 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:44 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:44 DEBUG : TestFTPPureftpd: detected overridden config - adding "{b4X_I}" suffix to name 2025/10/13 01:19:44 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:44 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:44 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:44 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:52004->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:30600") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:39960->172.17.0.2:30600, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:38479") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:38502->172.17.0.2:38479, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:33562") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:42796->172.17.0.2:33562, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:33431") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:35236->172.17.0.2:33431, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:38572") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:33386->172.17.0.2:38572, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:38474") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:49902->172.17.0.2:38474, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:36078") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:59792->172.17.0.2:36078, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:37946") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50986->172.17.0.2:37946, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:32962") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:58216->172.17.0.2:32962, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:36111") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:34062->172.17.0.2:36111, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:33689") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:39178->172.17.0.2:33689, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:34923") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:56652->172.17.0.2:34923, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:39557") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:41980->172.17.0.2:39557, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:31080") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:53126->172.17.0.2:31080, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:32273") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:43872->172.17.0.2:32273, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:36385") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:33324->172.17.0.2:36385, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:35292") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:51210->172.17.0.2:35292, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2004: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2109: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34333") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:34784->172.17.0.2:34333, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32544") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:47070->172.17.0.2:32544, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32264") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:48746->172.17.0.2:32264, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35827") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:47876->172.17.0.2:35827, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32090") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:43366->172.17.0.2:32090, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2281: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32149") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:44308->172.17.0.2:32149, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35256") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:54890->172.17.0.2:35256, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/10/13 01:19:44 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-rufoqed0duja" 2025/10/13 01:19:44 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/13 01:19:44 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:44 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:44 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:44 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:44 DEBUG : TestFTPPureftpd: detected overridden config - adding "{8Q2do}" suffix to name 2025/10/13 01:19:44 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:44 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:44 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:44 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: Connecting to FTP server 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:21") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:52010->172.17.0.2:21, err= 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:37791") 2025/10/13 01:19:44 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:50428->172.17.0.2:37791, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2476: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34518") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:59936->172.17.0.2:34518, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38648") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:52620->172.17.0.2:38648, err= 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:36204") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:51260->172.17.0.2:36204, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/13 01:19:45 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-rufoqed0duja/deeper/nonexisting/directory" 2025/10/13 01:19:45 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/13 01:19:45 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:45 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:45 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:45 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:45 DEBUG : TestFTPPureftpd: detected overridden config - adding "{b4X_I}" suffix to name 2025/10/13 01:19:45 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/13 01:19:45 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/13 01:19:45 DEBUG : Setting pass="CauiW-sKumJy6u8tsQO4I-eBAF-juNUWW4wGLusscEE" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/13 01:19:45 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/deeper/nonexisting/directory: Connecting to FTP server 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/deeper/nonexisting/directory: dial("tcp","172.17.0.2:21") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja/deeper/nonexisting/directory: > dial: conn=172.17.0.1:52018->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/10/13 01:19:45 DEBUG : Waiting for deletions to finish 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34228") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:44242->172.17.0.2:34228, err= 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:32029") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:51954->172.17.0.2:32029, err= 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:34618") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:35100->172.17.0.2:34618, err= 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33461") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:60344->172.17.0.2:33461, err= 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33753") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:40162->172.17.0.2:33753, err= 2025/10/13 01:19:45 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:30439") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:39842->172.17.0.2:30439, err= 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:33724") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:58636->172.17.0.2:33724, err= 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:36736") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:53970->172.17.0.2:36736, err= 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38469") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:54538->172.17.0.2:38469, err= 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:39928") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:49268->172.17.0.2:39928, err= 2025/10/13 01:19:45 DEBUG : removing 1 level 4 directories 2025/10/13 01:19:45 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/10/13 01:19:45 DEBUG : removing 1 level 3 directories 2025/10/13 01:19:45 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/10/13 01:19:45 DEBUG : removing 1 level 2 directories 2025/10/13 01:19:45 INFO : hello? sausage/êé: Removing directory 2025/10/13 01:19:45 DEBUG : removing 1 level 1 directories 2025/10/13 01:19:45 INFO : hello? sausage: Removing directory 2025/10/13 01:19:45 DEBUG : removing 1 level 0 directories 2025/10/13 01:19:45 INFO : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: Removing directory 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:36387") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:41630->172.17.0.2:36387, err= 2025/10/13 01:19:45 ERROR : error listing: directory not found 2025/10/13 01:19:45 DEBUG : Waiting for deletions to finish 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:38895") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:41430->172.17.0.2:38895, err= 2025/10/13 01:19:45 ERROR : error listing: directory not found 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: dial("tcp","172.17.0.2:35767") 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: > dial: conn=172.17.0.1:46440->172.17.0.2:35767, err= 2025/10/13 01:19:45 ERROR : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: Failed to list "": directory not found 2025/10/13 01:19:45 DEBUG : removing 1 level 0 directories 2025/10/13 01:19:45 INFO : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: Removing directory 2025/10/13 01:19:45 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/10/13 01:19:45 DEBUG : ftp://172.17.0.2:21/rclone-test-rufoqed0duja: closing 2 unused connections 2025/10/13 01:19:55 NOTICE: TestFTPPureftpd: Stopping server --- PASS: TestIntegration (33.91s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.00s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (2.36s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.12s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.00s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.03s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.16s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.06s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.03s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.03s) --- 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.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.79s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.79s) --- 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 (0.02s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 33.928s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished OK in 34.867667968s (try 1/5)