"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPPureftpd:" 2025/11/02 02:59:06 NOTICE: TestFTPPureftpd: Stopping server 2025/11/02 02:59:07 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 2/10 2025/11/02 02:59:07 NOTICE: TestFTPPureftpd: Stopping server 2025/11/02 02:59:08 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 3/10 2025/11/02 02:59:08 NOTICE: TestFTPPureftpd: Stopping server 2025/11/02 02:59:09 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 4/10 2025/11/02 02:59:09 NOTICE: TestFTPPureftpd: Stopping server 2025/11/02 02:59:10 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 5/10 2025/11/02 02:59:10 NOTICE: TestFTPPureftpd: Stopping server 2025/11/02 02:59:11 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 6/10 2025/11/02 02:59:11 NOTICE: TestFTPPureftpd: Stopping server 2025/11/02 02:59:12 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 7/10 2025/11/02 02:59:12 NOTICE: TestFTPPureftpd: Stopping server 2025/11/02 02:59:13 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 8/10 2025/11/02 02:59:13 NOTICE: TestFTPPureftpd: Stopping server 2025/11/02 02:59:14 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 9/10 2025/11/02 02:59:14 NOTICE: TestFTPPureftpd: Stopping server 2025/11/02 02:59:16 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 10/10 2025/11/02 02:59:16 NOTICE: TestFTPPureftpd: Stopping server 2025/11/02 02:59:16 NOTICE: TestFTPPureftpd: Starting server 2025/11/02 02:59:17 NOTICE: TestFTPPureftpd: Attempting to connect to "172.17.0.4:21" try 1/100 2025/11/02 02:59:17 DEBUG : TestFTPPureftpd: Read 1, error: 2025/11/02 02:59:17 NOTICE: TestFTPPureftpd: Started server and connected to "172.17.0.4:21" 2025/11/02 02:59:17 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-fibojih6muwo" 2025/11/02 02:59:17 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/11/02 02:59:17 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/11/02 02:59:17 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:17 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:17 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:17 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:17 DEBUG : TestFTPPureftpd: detected overridden config - adding "{z_Po9}" suffix to name 2025/11/02 02:59:17 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:17 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:17 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:17 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: Connecting to FTP server 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:21") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:42444->172.17.0.4:21, err= 2025/11/02 02:59:17 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/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34543") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:58422->172.17.0.4:34543, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38631") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:42966->172.17.0.4:38631, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/11/02 02:59:17 INFO : dir/subdir: Making directory 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33291") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:57506->172.17.0.4:33291, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30883") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:35546->172.17.0.4:30883, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35007") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:37624->172.17.0.4:35007, err= 2025/11/02 02:59:17 INFO : dir/subdir: Removing directory 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31469") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:39820->172.17.0.4:31469, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38182") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:57414->172.17.0.4:38182, err= 2025/11/02 02:59:17 INFO : dir: Removing directory 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32394") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:38764->172.17.0.4:32394, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36482") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:34506->172.17.0.4:36482, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39935") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:50826->172.17.0.4:39935, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30988") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:59712->172.17.0.4:30988, err= 2025/11/02 02:59:17 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/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31811") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:58680->172.17.0.4:31811, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39309") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:45148->172.17.0.4:39309, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36845") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:37332->172.17.0.4:36845, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32898") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:35982->172.17.0.4:32898, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34615") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:35474->172.17.0.4:34615, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34027") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:57076->172.17.0.4:34027, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31208") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:36078->172.17.0.4:31208, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34871") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:55140->172.17.0.4:34871, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34107") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:41208->172.17.0.4:34107, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30475") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:47518->172.17.0.4:30475, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30915") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:54290->172.17.0.4:30915, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36884") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:52990->172.17.0.4:36884, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33345") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:37892->172.17.0.4:33345, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38045") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:40384->172.17.0.4:38045, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31541") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:48482->172.17.0.4:31541, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31693") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:43590->172.17.0.4:31693, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36333") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:53770->172.17.0.4:36333, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35942") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:51834->172.17.0.4:35942, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32967") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:43250->172.17.0.4:32967, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35235") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:42872->172.17.0.4:35235, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32345") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:56490->172.17.0.4:32345, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36322") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:46850->172.17.0.4:36322, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31961") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:39936->172.17.0.4:31961, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33959") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:35268->172.17.0.4:33959, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37636") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:53100->172.17.0.4:37636, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39445") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:52976->172.17.0.4:39445, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30131") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:57286->172.17.0.4:30131, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39464") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:58158->172.17.0.4:39464, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37876") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:60094->172.17.0.4:37876, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31349") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:46344->172.17.0.4:31349, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34773") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:34116->172.17.0.4:34773, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35398") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:48518->172.17.0.4:35398, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39828") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:59784->172.17.0.4:39828, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30877") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:40348->172.17.0.4:30877, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31906") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:48344->172.17.0.4:31906, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38060") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:60586->172.17.0.4:38060, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30447") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:47104->172.17.0.4:30447, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38351") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:53924->172.17.0.4:38351, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36478") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:37628->172.17.0.4:36478, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35439") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:37256->172.17.0.4:35439, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37547") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:54642->172.17.0.4:37547, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30773") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:58092->172.17.0.4:30773, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32826") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:36326->172.17.0.4:32826, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30321") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:45548->172.17.0.4:30321, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32549") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:53838->172.17.0.4:32549, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37789") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:52130->172.17.0.4:37789, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31184") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:35350->172.17.0.4:31184, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32767") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:51148->172.17.0.4:32767, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32955") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:52594->172.17.0.4:32955, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31348") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:56536->172.17.0.4:31348, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30661") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:35384->172.17.0.4:30661, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38334") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:52136->172.17.0.4:38334, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37949") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:54722->172.17.0.4:37949, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35408") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:47996->172.17.0.4:35408, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34847") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:55568->172.17.0.4:34847, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34294") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:43484->172.17.0.4:34294, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30818") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:45444->172.17.0.4:30818, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32681") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:56350->172.17.0.4:32681, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31897") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:39150->172.17.0.4:31897, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31537") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:44870->172.17.0.4:31537, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39882") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:48792->172.17.0.4:39882, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35309") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:45132->172.17.0.4:35309, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39361") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:38580->172.17.0.4:39361, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37145") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:39540->172.17.0.4:37145, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33546") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:55610->172.17.0.4:33546, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39967") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:60322->172.17.0.4:39967, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36519") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:53882->172.17.0.4:36519, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38783") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:56164->172.17.0.4:38783, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35947") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:51042->172.17.0.4:35947, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30647") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:60434->172.17.0.4:30647, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31184") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:35358->172.17.0.4:31184, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35712") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:34854->172.17.0.4:35712, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32311") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:45392->172.17.0.4:32311, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31861") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:51208->172.17.0.4:31861, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32658") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:34324->172.17.0.4:32658, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39015") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:57228->172.17.0.4:39015, err= 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36080") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:40576->172.17.0.4:36080, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35026") 2025/11/02 02:59:17 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:53342->172.17.0.4:35026, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: Connecting to FTP server 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:21") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:42452->172.17.0.4:21, err= 2025/11/02 02:59:18 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32893") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:39962->172.17.0.4:32893, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31301") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:55574->172.17.0.4:31301, 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/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34767") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:39918->172.17.0.4:34767, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32764") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:40304->172.17.0.4:32764, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36842") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:52890->172.17.0.4:36842, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32712") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:32822->172.17.0.4:32712, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33077") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:57966->172.17.0.4:33077, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31249") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:46336->172.17.0.4:31249, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39064") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:57200->172.17.0.4:39064, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36477") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:34122->172.17.0.4:36477, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35320") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:47912->172.17.0.4:35320, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30459") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:35080->172.17.0.4:30459, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31228") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:42692->172.17.0.4:31228, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34240") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:55002->172.17.0.4:34240, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35452") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:33960->172.17.0.4:35452, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33693") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:58514->172.17.0.4:33693, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33158") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:42166->172.17.0.4:33158, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34843") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:35122->172.17.0.4:34843, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32885") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:49790->172.17.0.4:32885, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/11/02 02:59:18 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/11/02 02:59:18 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/11/02 02:59:18 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:18 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:18 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:18 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:18 DEBUG : TestFTPPureftpd: detected overridden config - adding "{z_Po9}" suffix to name 2025/11/02 02:59:18 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:18 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:18 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:18 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:42456->172.17.0.4:21, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:36213") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:54750->172.17.0.4:36213, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34762") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:43392->172.17.0.4:34762, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35486") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:37616->172.17.0.4:35486, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33369") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:36780->172.17.0.4:33369, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31195") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:52076->172.17.0.4:31195, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32310") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:46472->172.17.0.4:32310, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38876") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:60966->172.17.0.4:38876, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30023") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:45232->172.17.0.4:30023, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38773") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:40124->172.17.0.4:38773, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35067") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:55860->172.17.0.4:35067, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36940") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:34962->172.17.0.4:36940, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33204") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:39082->172.17.0.4:33204, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38431") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:55484->172.17.0.4:38431, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30059") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:54208->172.17.0.4:30059, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38971") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:36334->172.17.0.4:38971, 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/11/02 02:59:18 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-fibojih6muwo/hello? sausage/êé" 2025/11/02 02:59:18 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/11/02 02:59:18 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:18 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:18 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:18 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:18 DEBUG : TestFTPPureftpd: detected overridden config - adding "{z_Po9}" suffix to name 2025/11/02 02:59:18 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:18 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:18 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:18 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: Connecting to FTP server 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:42462->172.17.0.4:21, err= 2025/11/02 02:59:18 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-fibojih6muwo/hello? sausage/êé" to be canonical "TestFTPPureftpd{z_Po9}:rclone-test-fibojih6muwo/hello? sausage/êé" 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:38199") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:47246->172.17.0.4:38199, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:39950") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:48098->172.17.0.4:39950, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: Connecting to FTP server 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:21") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:37732") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:42468->172.17.0.4:21, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:50138->172.17.0.4:37732, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:36884") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:52998->172.17.0.4:36884, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:33427") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:54588->172.17.0.4:33427, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:33347") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:37188->172.17.0.4:33347, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:34530") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:52890->172.17.0.4:34530, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:38956") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:59034->172.17.0.4:38956, err= 2025/11/02 02:59:18 DEBUG : Waiting for deletions to finish 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:33876") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:53082->172.17.0.4:33876, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:39677") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:38072->172.17.0.4:39677, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:32649") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:43744->172.17.0.4:32649, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:34927") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:53224->172.17.0.4:34927, err= 2025/11/02 02:59:18 INFO : a/b/c/d/e.txt: Deleted 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:36461") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:48628->172.17.0.4:36461, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:39471") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:39718->172.17.0.4:39471, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:36428") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:46216->172.17.0.4:36428, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: dial("tcp","172.17.0.4:38016") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé: > dial: conn=172.17.0.1:49106->172.17.0.4:38016, err= 2025/11/02 02:59:18 DEBUG : removing 1 level 4 directories 2025/11/02 02:59:18 INFO : a/b/c/d: Removing directory 2025/11/02 02:59:18 DEBUG : removing 1 level 3 directories 2025/11/02 02:59:18 INFO : a/b/c: Removing directory 2025/11/02 02:59:18 DEBUG : removing 1 level 2 directories 2025/11/02 02:59:18 INFO : a/b: Removing directory 2025/11/02 02:59:18 DEBUG : removing 1 level 1 directories 2025/11/02 02:59:18 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33776") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:36032->172.17.0.4:33776, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34593") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:54320->172.17.0.4:34593, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33421") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:54582->172.17.0.4:33421, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36500") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:53158->172.17.0.4:36500, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37838") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:36276->172.17.0.4:37838, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32194") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:35158->172.17.0.4:32194, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: Connecting to FTP server 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:21") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:42484->172.17.0.4:21, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38672") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:58478->172.17.0.4:38672, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37322") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:59506->172.17.0.4:37322, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35737") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:40478->172.17.0.4:35737, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38384") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:44744->172.17.0.4:38384, err= 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32898") 2025/11/02 02:59:18 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:35984->172.17.0.4:32898, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30801") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:59716->172.17.0.4:30801, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37716") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:44480->172.17.0.4:37716, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33254") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39711") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:32948->172.17.0.4:39711, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:46710->172.17.0.4:33254, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39309") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:45162->172.17.0.4:39309, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30725") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:41090->172.17.0.4:30725, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38913") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:40854->172.17.0.4:38913, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37177") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:60264->172.17.0.4:37177, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39248") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:33244->172.17.0.4:39248, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35791") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:44354->172.17.0.4:35791, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37829") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:38040->172.17.0.4:37829, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39371") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:56504->172.17.0.4:39371, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/11/02 02:59:19 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-fudedok8xeco" 2025/11/02 02:59:19 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/11/02 02:59:19 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:19 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:19 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:19 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:19 DEBUG : TestFTPPureftpd: detected overridden config - adding "{z_Po9}" suffix to name 2025/11/02 02:59:19 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:19 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:19 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:19 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: Connecting to FTP server 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: dial("tcp","172.17.0.4:21") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: > dial: conn=172.17.0.1:42494->172.17.0.4:21, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30622") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:52412->172.17.0.4:30622, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: dial("tcp","172.17.0.4:34220") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: > dial: conn=172.17.0.1:39552->172.17.0.4:34220, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: dial("tcp","172.17.0.4:38342") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: > dial: conn=172.17.0.1:48746->172.17.0.4:38342, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: dial("tcp","172.17.0.4:39370") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: > dial: conn=172.17.0.1:46354->172.17.0.4:39370, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: dial("tcp","172.17.0.4:33241") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: > dial: conn=172.17.0.1:57210->172.17.0.4:33241, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: dial("tcp","172.17.0.4:37314") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: > dial: conn=172.17.0.1:40972->172.17.0.4:37314, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: dial("tcp","172.17.0.4:35783") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: > dial: conn=172.17.0.1:34852->172.17.0.4:35783, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: dial("tcp","172.17.0.4:39133") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: > dial: conn=172.17.0.1:48218->172.17.0.4:39133, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31593") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:60108->172.17.0.4:31593, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34996") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:33822->172.17.0.4:34996, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36828") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:37076->172.17.0.4:36828, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38569") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:41662->172.17.0.4:38569, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30179") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:41840->172.17.0.4:30179, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: dial("tcp","172.17.0.4:39287") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: > dial: conn=172.17.0.1:59326->172.17.0.4:39287, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: dial("tcp","172.17.0.4:33512") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: > dial: conn=172.17.0.1:42830->172.17.0.4:33512, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: dial("tcp","172.17.0.4:35310") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: > dial: conn=172.17.0.1:51100->172.17.0.4:35310, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: dial("tcp","172.17.0.4:37181") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: > dial: conn=172.17.0.1:43776->172.17.0.4:37181, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: Purge dir "new_name" 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fudedok8xeco: 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/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32080") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:42058->172.17.0.4:32080, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36291") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:50022->172.17.0.4:36291, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33742") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:57008->172.17.0.4:33742, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30936") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:59644->172.17.0.4:30936, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34206") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:49908->172.17.0.4:34206, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34679") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:58288->172.17.0.4:34679, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37242") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:44000->172.17.0.4:37242, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:30884") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:54232->172.17.0.4:30884, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39841") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:46094->172.17.0.4:39841, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/11/02 02:59:19 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-fibojih6muwo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/11/02 02:59:19 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/11/02 02:59:19 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:19 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:19 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:19 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:19 DEBUG : TestFTPPureftpd: detected overridden config - adding "{z_Po9}" suffix to name 2025/11/02 02:59:19 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:19 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:19 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:19 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:21") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:42504->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.4:35768") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:44362->172.17.0.4:35768, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/11/02 02:59:19 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-fibojih6muwo/not found.txt" 2025/11/02 02:59:19 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/11/02 02:59:19 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:19 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:19 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:19 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:19 DEBUG : TestFTPPureftpd: detected overridden config - adding "{z_Po9}" suffix to name 2025/11/02 02:59:19 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:19 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:19 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:19 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/not found.txt: Connecting to FTP server 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/not found.txt: dial("tcp","172.17.0.4:21") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/not found.txt: > dial: conn=172.17.0.1:42520->172.17.0.4:21, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/not found.txt: dial("tcp","172.17.0.4:38032") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/not found.txt: > dial: conn=172.17.0.1:36440->172.17.0.4:38032, err= 2025/11/02 02:59:19 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPPureftpd:" path "rclone-test-fibojih6muwo" from "TestFTPPureftpd:rclone-test-fibojih6muwo" 2025/11/02 02:59:19 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/11/02 02:59:19 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/11/02 02:59:19 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:19 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:19 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:19 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:19 DEBUG : TestFTPPureftpd: detected overridden config - adding "{z_Po9}" suffix to name 2025/11/02 02:59:19 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:19 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:19 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:19 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: Connecting to FTP server 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:21") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:42532->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:36923") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34306->172.17.0.4:36923, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:38345") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:60470->172.17.0.4:38345, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:34819") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:59458->172.17.0.4:34819, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:34408") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34238->172.17.0.4:34408, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:39103") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:38070->172.17.0.4:39103, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:31360") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:34854->172.17.0.4:31360, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:38912") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:49326->172.17.0.4:38912, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35411") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44938->172.17.0.4:35411, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:32841") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:54356->172.17.0.4:32841, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:31714") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:46642->172.17.0.4:31714, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30267") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:56712->172.17.0.4:30267, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:33400") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:58466->172.17.0.4:33400, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:35899") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:52284->172.17.0.4:35899, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:38757") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:37326->172.17.0.4:38757, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:38008") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:52830->172.17.0.4:38008, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:30185") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:52638->172.17.0.4:30185, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: dial("tcp","172.17.0.4:37954") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21: > dial: conn=172.17.0.1:44692->172.17.0.4:37954, 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/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32536") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:48294->172.17.0.4:32536, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34785") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:43278->172.17.0.4:34785, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34284") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:36226->172.17.0.4:34284, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:32960") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:53262->172.17.0.4:32960, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35656") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:41142->172.17.0.4:35656, 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/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:39524") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:53042->172.17.0.4:39524, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35018") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:45976->172.17.0.4:35018, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/11/02 02:59:19 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-fibojih6muwo" 2025/11/02 02:59:19 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/11/02 02:59:19 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:19 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:19 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:19 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:19 DEBUG : TestFTPPureftpd: detected overridden config - adding "{1dIBf}" suffix to name 2025/11/02 02:59:19 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:19 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:19 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:19 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: Connecting to FTP server 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:21") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:42546->172.17.0.4:21, err= 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33362") 2025/11/02 02:59:19 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:42742->172.17.0.4:33362, 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/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33023") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:43992->172.17.0.4:33023, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37670") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:34516->172.17.0.4:37670, err= 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37053") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:44740->172.17.0.4:37053, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/11/02 02:59:20 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-fibojih6muwo/deeper/nonexisting/directory" 2025/11/02 02:59:20 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/11/02 02:59:20 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:20 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:20 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:20 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:20 DEBUG : TestFTPPureftpd: detected overridden config - adding "{z_Po9}" suffix to name 2025/11/02 02:59:20 DEBUG : Setting host="172.17.0.4" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/11/02 02:59:20 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/11/02 02:59:20 DEBUG : Setting pass="4vb4LmEsVQJTG7XM5ElKjg_JzjWkQu40yo_qxG9GE-g" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/11/02 02:59:20 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/deeper/nonexisting/directory: Connecting to FTP server 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/deeper/nonexisting/directory: dial("tcp","172.17.0.4:21") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo/deeper/nonexisting/directory: > dial: conn=172.17.0.1:42550->172.17.0.4:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/11/02 02:59:20 DEBUG : Waiting for deletions to finish 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37186") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:38416->172.17.0.4:37186, err= 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:35820") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:33736->172.17.0.4:35820, err= 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33056") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:58248->172.17.0.4:33056, err= 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:37974") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:40866->172.17.0.4:37974, err= 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36094") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:42104->172.17.0.4:36094, err= 2025/11/02 02:59:20 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31731") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:40000->172.17.0.4:31731, err= 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:34443") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:50564->172.17.0.4:34443, err= 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:38674") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:36360->172.17.0.4:38674, err= 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36243") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:37096->172.17.0.4:36243, err= 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36204") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:56878->172.17.0.4:36204, err= 2025/11/02 02:59:20 DEBUG : removing 1 level 4 directories 2025/11/02 02:59:20 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/11/02 02:59:20 DEBUG : removing 1 level 3 directories 2025/11/02 02:59:20 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/11/02 02:59:20 DEBUG : removing 1 level 2 directories 2025/11/02 02:59:20 INFO : hello? sausage/êé: Removing directory 2025/11/02 02:59:20 DEBUG : removing 1 level 1 directories 2025/11/02 02:59:20 INFO : hello? sausage: Removing directory 2025/11/02 02:59:20 DEBUG : removing 1 level 0 directories 2025/11/02 02:59:20 INFO : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: Removing directory 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:33725") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:34444->172.17.0.4:33725, err= 2025/11/02 02:59:20 ERROR : error listing: directory not found 2025/11/02 02:59:20 DEBUG : Waiting for deletions to finish 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:31744") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:50238->172.17.0.4:31744, err= 2025/11/02 02:59:20 ERROR : error listing: directory not found 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: dial("tcp","172.17.0.4:36464") 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: > dial: conn=172.17.0.1:50682->172.17.0.4:36464, err= 2025/11/02 02:59:20 ERROR : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: Failed to list "": directory not found 2025/11/02 02:59:20 DEBUG : removing 1 level 0 directories 2025/11/02 02:59:20 INFO : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: Removing directory 2025/11/02 02:59:20 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/11/02 02:59:20 DEBUG : ftp://172.17.0.4:21/rclone-test-fibojih6muwo: closing 2 unused connections 2025/11/02 02:59:30 NOTICE: TestFTPPureftpd: Stopping server --- PASS: TestIntegration (34.18s) --- 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.42s) --- 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.16s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.17s) --- 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.00s) --- 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.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.01s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- 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 34.195s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished OK in 35.041634091s (try 1/5)