"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPPureftpd:" 2025/10/18 02:59:09 NOTICE: TestFTPPureftpd: Stopping server 2025/10/18 02:59:10 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 2/10 2025/10/18 02:59:11 NOTICE: TestFTPPureftpd: Stopping server 2025/10/18 02:59:12 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 3/10 2025/10/18 02:59:12 NOTICE: TestFTPPureftpd: Stopping server 2025/10/18 02:59:13 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 4/10 2025/10/18 02:59:13 NOTICE: TestFTPPureftpd: Stopping server 2025/10/18 02:59:14 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 5/10 2025/10/18 02:59:14 NOTICE: TestFTPPureftpd: Stopping server 2025/10/18 02:59:15 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 6/10 2025/10/18 02:59:15 NOTICE: TestFTPPureftpd: Stopping server 2025/10/18 02:59:16 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 7/10 2025/10/18 02:59:16 NOTICE: TestFTPPureftpd: Stopping server 2025/10/18 02:59:17 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 8/10 2025/10/18 02:59:17 NOTICE: TestFTPPureftpd: Stopping server 2025/10/18 02:59:18 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 9/10 2025/10/18 02:59:18 NOTICE: TestFTPPureftpd: Stopping server 2025/10/18 02:59:19 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 10/10 2025/10/18 02:59:19 NOTICE: TestFTPPureftpd: Stopping server 2025/10/18 02:59:19 NOTICE: TestFTPPureftpd: Starting server 2025/10/18 02:59:20 NOTICE: TestFTPPureftpd: Attempting to connect to "172.17.0.2:21" try 1/100 2025/10/18 02:59:20 DEBUG : TestFTPPureftpd: Read 1, error: 2025/10/18 02:59:20 NOTICE: TestFTPPureftpd: Started server and connected to "172.17.0.2:21" 2025/10/18 02:59:20 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-yufeqom4ruvu" 2025/10/18 02:59:20 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/18 02:59:20 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/18 02:59:20 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:20 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:20 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:20 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:20 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PXrWH}" suffix to name 2025/10/18 02:59:20 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:20 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:20 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:20 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: Connecting to FTP server 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:21") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:58542->172.17.0.2:21, err= 2025/10/18 02:59:20 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35930") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:47898->172.17.0.2:35930, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39144") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:38172->172.17.0.2:39144, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/10/18 02:59:20 INFO : dir/subdir: Making directory 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36188") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:45064->172.17.0.2:36188, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38866") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:36264->172.17.0.2:38866, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39394") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:55598->172.17.0.2:39394, err= 2025/10/18 02:59:20 INFO : dir/subdir: Removing directory 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36227") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:42604->172.17.0.2:36227, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31115") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:58840->172.17.0.2:31115, err= 2025/10/18 02:59:20 INFO : dir: Removing directory 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38745") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:38750->172.17.0.2:38745, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36872") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:39930->172.17.0.2:36872, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36319") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:50298->172.17.0.2:36319, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:33526") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:41520->172.17.0.2:33526, err= 2025/10/18 02:59:20 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38842") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:60740->172.17.0.2:38842, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36761") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:48420->172.17.0.2:36761, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:37814") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:51602->172.17.0.2:37814, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38874") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:40086->172.17.0.2:38874, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36382") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:41942->172.17.0.2:36382, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31686") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:54290->172.17.0.2:31686, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36081") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:33336->172.17.0.2:36081, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35965") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:38908->172.17.0.2:35965, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:33646") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:59922->172.17.0.2:33646, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31298") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:51978->172.17.0.2:31298, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:37588") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:54232->172.17.0.2:37588, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36734") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:49844->172.17.0.2:36734, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34075") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:53116->172.17.0.2:34075, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30549") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:35660->172.17.0.2:30549, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32005") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:52266->172.17.0.2:32005, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:37821") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:47984->172.17.0.2:37821, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31930") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:53976->172.17.0.2:31930, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:37238") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:55618->172.17.0.2:37238, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38258") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:53424->172.17.0.2:38258, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:37408") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:33214->172.17.0.2:37408, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30258") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:35058->172.17.0.2:30258, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34525") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:33582->172.17.0.2:34525, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39306") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:52668->172.17.0.2:39306, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34761") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:53766->172.17.0.2:34761, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30520") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:43206->172.17.0.2:30520, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30800") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:51162->172.17.0.2:30800, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35646") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:34790->172.17.0.2:35646, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34170") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:53632->172.17.0.2:34170, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32772") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:52120->172.17.0.2:32772, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35742") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:50478->172.17.0.2:35742, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34688") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:38308->172.17.0.2:34688, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38352") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:33896->172.17.0.2:38352, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38087") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:60330->172.17.0.2:38087, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36325") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:60432->172.17.0.2:36325, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39638") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:36042->172.17.0.2:39638, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31749") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:41302->172.17.0.2:31749, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36192") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:50330->172.17.0.2:36192, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30002") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:45508->172.17.0.2:30002, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:33159") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:55222->172.17.0.2:33159, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30235") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:34840->172.17.0.2:30235, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:37814") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:51606->172.17.0.2:37814, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39662") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:49596->172.17.0.2:39662, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:33385") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:45826->172.17.0.2:33385, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35783") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:47770->172.17.0.2:35783, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38450") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:58288->172.17.0.2:38450, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:33964") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:53722->172.17.0.2:33964, err= 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39050") 2025/10/18 02:59:20 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:45648->172.17.0.2:39050, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38746") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:50872->172.17.0.2:38746, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:33148") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:39438->172.17.0.2:33148, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35284") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:39666->172.17.0.2:35284, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31315") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:52198->172.17.0.2:31315, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:33852") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:36598->172.17.0.2:33852, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34702") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:34042->172.17.0.2:34702, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32433") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:53864->172.17.0.2:32433, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38721") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:56480->172.17.0.2:38721, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36732") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:51916->172.17.0.2:36732, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38343") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:45846->172.17.0.2:38343, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39391") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:38896->172.17.0.2:39391, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35005") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:49744->172.17.0.2:35005, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32089") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:48370->172.17.0.2:32089, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30756") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:56244->172.17.0.2:30756, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30520") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:43208->172.17.0.2:30520, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38734") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:51642->172.17.0.2:38734, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32913") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:43352->172.17.0.2:32913, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39842") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:56644->172.17.0.2:39842, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:37658") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:60442->172.17.0.2:37658, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34443") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:59388->172.17.0.2:34443, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39042") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:41164->172.17.0.2:39042, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31661") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:33926->172.17.0.2:31661, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35100") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:33496->172.17.0.2:35100, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32423") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:47398->172.17.0.2:32423, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36671") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:50830->172.17.0.2:36671, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31482") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:46408->172.17.0.2:31482, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31406") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:49380->172.17.0.2:31406, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38165") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:45840->172.17.0.2:38165, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:37066") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:53026->172.17.0.2:37066, err= 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35580") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:50826->172.17.0.2:35580, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39263") 2025/10/18 02:59:21 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:51280->172.17.0.2:39263, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: Connecting to FTP server 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:21") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:58552->172.17.0.2:21, err= 2025/10/18 02:59:22 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32959") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:44454->172.17.0.2:32959, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38971") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:43536->172.17.0.2:38971, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34354") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:34498->172.17.0.2:34354, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38247") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:47862->172.17.0.2:38247, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32709") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:53386->172.17.0.2:32709, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31292") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:32970->172.17.0.2:31292, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32303") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:60092->172.17.0.2:32303, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36075") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:53502->172.17.0.2:36075, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34311") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:36678->172.17.0.2:34311, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34168") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:44356->172.17.0.2:34168, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35415") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:55986->172.17.0.2:35415, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:33686") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:37754->172.17.0.2:33686, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39258") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:53188->172.17.0.2:39258, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38312") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:53128->172.17.0.2:38312, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31053") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:33906->172.17.0.2:31053, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38480") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:44370->172.17.0.2:38480, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32840") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:60316->172.17.0.2:32840, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35078") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:56370->172.17.0.2:35078, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38686") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:45874->172.17.0.2:38686, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/10/18 02:59:22 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/10/18 02:59:22 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/18 02:59:22 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:22 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:22 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PXrWH}" suffix to name 2025/10/18 02:59:22 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:22 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:58558->172.17.0.2:21, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:32262") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:34008->172.17.0.2:32262, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36884") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:54512->172.17.0.2:36884, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34446") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:38274->172.17.0.2:34446, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35090") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:34382->172.17.0.2:35090, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34689") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:45682->172.17.0.2:34689, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36246") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:33628->172.17.0.2:36246, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36278") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:42404->172.17.0.2:36278, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38877") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:33398->172.17.0.2:38877, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38621") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:59746->172.17.0.2:38621, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:37155") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:55438->172.17.0.2:37155, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31309") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:40270->172.17.0.2:31309, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38808") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:32976->172.17.0.2:38808, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30626") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:34262->172.17.0.2:30626, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38927") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:53148->172.17.0.2:38927, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34222") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:36740->172.17.0.2:34222, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1153: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1190: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/10/18 02:59:22 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-yufeqom4ruvu/hello? sausage/êé" 2025/10/18 02:59:22 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/18 02:59:22 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:22 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:22 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PXrWH}" suffix to name 2025/10/18 02:59:22 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:22 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: Connecting to FTP server 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:58566->172.17.0.2:21, err= 2025/10/18 02:59:22 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-yufeqom4ruvu/hello? sausage/êé" to be canonical "TestFTPPureftpd{PXrWH}:rclone-test-yufeqom4ruvu/hello? sausage/êé" 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:35868") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:45570->172.17.0.2:35868, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:31744") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:40076->172.17.0.2:31744, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: Connecting to FTP server 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:58568->172.17.0.2:21, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:34037") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:36154->172.17.0.2:34037, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:37769") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:41092->172.17.0.2:37769, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:38253") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:42530->172.17.0.2:38253, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:35358") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:41046->172.17.0.2:35358, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:35605") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:49894->172.17.0.2:35605, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:30211") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:54354->172.17.0.2:30211, err= 2025/10/18 02:59:22 DEBUG : Waiting for deletions to finish 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:38225") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:53416->172.17.0.2:38225, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:34791") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:48708->172.17.0.2:34791, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:35971") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:50984->172.17.0.2:35971, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:33996") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:48594->172.17.0.2:33996, err= 2025/10/18 02:59:22 INFO : a/b/c/d/e.txt: Deleted 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:34211") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:57410->172.17.0.2:34211, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:36442") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:53674->172.17.0.2:36442, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:39313") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:43852->172.17.0.2:39313, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: dial("tcp","172.17.0.2:33887") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé: > dial: conn=172.17.0.1:35154->172.17.0.2:33887, err= 2025/10/18 02:59:22 DEBUG : removing 1 level 4 directories 2025/10/18 02:59:22 INFO : a/b/c/d: Removing directory 2025/10/18 02:59:22 DEBUG : removing 1 level 3 directories 2025/10/18 02:59:22 INFO : a/b/c: Removing directory 2025/10/18 02:59:22 DEBUG : removing 1 level 2 directories 2025/10/18 02:59:22 INFO : a/b: Removing directory 2025/10/18 02:59:22 DEBUG : removing 1 level 1 directories 2025/10/18 02:59:22 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:33027") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:49892->172.17.0.2:33027, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30546") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:44180->172.17.0.2:30546, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39782") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:42086->172.17.0.2:39782, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32256") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:38454->172.17.0.2:32256, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38953") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:58950->172.17.0.2:38953, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:37529") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:52748->172.17.0.2:37529, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: Connecting to FTP server 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:21") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:37126") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:58582->172.17.0.2:21, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:59316->172.17.0.2:37126, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30363") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:43106->172.17.0.2:30363, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:37225") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:36036->172.17.0.2:37225, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32834") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:33878->172.17.0.2:32834, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34841") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:50812->172.17.0.2:34841, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36104") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:51166->172.17.0.2:36104, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32819") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31923") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:40302->172.17.0.2:32819, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:35318->172.17.0.2:31923, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35950") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:39494->172.17.0.2:35950, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31224") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:38444->172.17.0.2:31224, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39522") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:54958->172.17.0.2:39522, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35792") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:37878->172.17.0.2:35792, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38359") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36572") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:57598->172.17.0.2:38359, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:34714->172.17.0.2:36572, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32004") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:46790->172.17.0.2:32004, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:37354") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:40750->172.17.0.2:37354, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31622") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:43734->172.17.0.2:31622, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/10/18 02:59:22 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-maqagum9jija" 2025/10/18 02:59:22 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/18 02:59:22 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:22 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:22 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PXrWH}" suffix to name 2025/10/18 02:59:22 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:22 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: Connecting to FTP server 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: dial("tcp","172.17.0.2:21") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: > dial: conn=172.17.0.1:58594->172.17.0.2:21, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39818") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:45018->172.17.0.2:39818, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: dial("tcp","172.17.0.2:32166") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: > dial: conn=172.17.0.1:35108->172.17.0.2:32166, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: dial("tcp","172.17.0.2:33493") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: > dial: conn=172.17.0.1:46294->172.17.0.2:33493, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: dial("tcp","172.17.0.2:32218") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: > dial: conn=172.17.0.1:48594->172.17.0.2:32218, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: dial("tcp","172.17.0.2:33897") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: > dial: conn=172.17.0.1:53906->172.17.0.2:33897, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: dial("tcp","172.17.0.2:39973") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: > dial: conn=172.17.0.1:41794->172.17.0.2:39973, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: dial("tcp","172.17.0.2:34419") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: > dial: conn=172.17.0.1:34750->172.17.0.2:34419, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: dial("tcp","172.17.0.2:34667") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: > dial: conn=172.17.0.1:48804->172.17.0.2:34667, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31874") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:40742->172.17.0.2:31874, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34402") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:50676->172.17.0.2:34402, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31910") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:57336->172.17.0.2:31910, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:33705") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:50988->172.17.0.2:33705, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35622") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:54538->172.17.0.2:35622, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: dial("tcp","172.17.0.2:36097") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: > dial: conn=172.17.0.1:38436->172.17.0.2:36097, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: dial("tcp","172.17.0.2:36088") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: > dial: conn=172.17.0.1:55572->172.17.0.2:36088, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: dial("tcp","172.17.0.2:35238") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: > dial: conn=172.17.0.1:50344->172.17.0.2:35238, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: dial("tcp","172.17.0.2:37613") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: > dial: conn=172.17.0.1:54176->172.17.0.2:37613, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: Purge dir "new_name" 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-maqagum9jija: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35829") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:40912->172.17.0.2:35829, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31112") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:35170->172.17.0.2:31112, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30385") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:51760->172.17.0.2:30385, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:33213") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:45950->172.17.0.2:33213, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35871") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:50702->172.17.0.2:35871, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39599") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:41530->172.17.0.2:39599, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30573") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:43170->172.17.0.2:30573, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:37214") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:49466->172.17.0.2:37214, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36921") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:38734->172.17.0.2:36921, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/10/18 02:59:22 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-yufeqom4ruvu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/10/18 02:59:22 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/18 02:59:22 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:22 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:22 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PXrWH}" suffix to name 2025/10/18 02:59:22 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:22 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:21") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:58604->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:30149") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:55730->172.17.0.2:30149, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/10/18 02:59:22 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-yufeqom4ruvu/not found.txt" 2025/10/18 02:59:22 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/18 02:59:22 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:22 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:22 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PXrWH}" suffix to name 2025/10/18 02:59:22 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:22 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/not found.txt: Connecting to FTP server 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/not found.txt: dial("tcp","172.17.0.2:21") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/not found.txt: > dial: conn=172.17.0.1:58610->172.17.0.2:21, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/not found.txt: dial("tcp","172.17.0.2:30428") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/not found.txt: > dial: conn=172.17.0.1:60668->172.17.0.2:30428, err= 2025/10/18 02:59:22 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPPureftpd:" path "rclone-test-yufeqom4ruvu" from "TestFTPPureftpd:rclone-test-yufeqom4ruvu" 2025/10/18 02:59:22 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/10/18 02:59:22 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/18 02:59:22 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:22 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:22 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PXrWH}" suffix to name 2025/10/18 02:59:22 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:22 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:58614->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:32684") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:60854->172.17.0.2:32684, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:30714") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:60412->172.17.0.2:30714, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:33637") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:44880->172.17.0.2:33637, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:33590") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:34370->172.17.0.2:33590, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:35114") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:53824->172.17.0.2:35114, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:37301") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:36206->172.17.0.2:37301, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:34670") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:36212->172.17.0.2:34670, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:39323") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:45690->172.17.0.2:39323, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:34250") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:34058->172.17.0.2:34250, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:30261") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:33386->172.17.0.2:30261, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:39124") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:57582->172.17.0.2:39124, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:37173") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:39346->172.17.0.2:37173, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:33989") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:60440->172.17.0.2:33989, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:33379") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:49034->172.17.0.2:33379, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:32614") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:58218->172.17.0.2:32614, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:34138") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:38560->172.17.0.2:34138, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:30909") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50508->172.17.0.2:30909, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2004: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2109: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32379") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:33562->172.17.0.2:32379, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30615") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:55550->172.17.0.2:30615, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39742") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:55096->172.17.0.2:39742, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30920") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:55194->172.17.0.2:30920, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35453") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:32960->172.17.0.2:35453, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2281: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38581") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:35190->172.17.0.2:38581, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31938") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:50280->172.17.0.2:31938, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/10/18 02:59:22 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-yufeqom4ruvu" 2025/10/18 02:59:22 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/18 02:59:22 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:22 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:22 DEBUG : TestFTPPureftpd: detected overridden config - adding "{kLl6v}" suffix to name 2025/10/18 02:59:22 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:22 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:22 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:22 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: Connecting to FTP server 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:21") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:58626->172.17.0.2:21, err= 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:31434") 2025/10/18 02:59:22 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:56678->172.17.0.2:31434, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2476: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:36329") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:44338->172.17.0.2:36329, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38599") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:35980->172.17.0.2:38599, err= 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38709") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:50158->172.17.0.2:38709, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/18 02:59:23 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-yufeqom4ruvu/deeper/nonexisting/directory" 2025/10/18 02:59:23 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/18 02:59:23 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:23 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:23 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:23 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:23 DEBUG : TestFTPPureftpd: detected overridden config - adding "{PXrWH}" suffix to name 2025/10/18 02:59:23 DEBUG : Setting host="172.17.0.2" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/18 02:59:23 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/18 02:59:23 DEBUG : Setting pass="up1JcJ1C10Ol3lQBn9rD0M0fRTwrOWlzShruNB-E1fA" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/18 02:59:23 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/deeper/nonexisting/directory: Connecting to FTP server 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/deeper/nonexisting/directory: dial("tcp","172.17.0.2:21") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:58628->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/10/18 02:59:23 DEBUG : Waiting for deletions to finish 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32707") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:57420->172.17.0.2:32707, err= 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:34332") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:40936->172.17.0.2:34332, err= 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32457") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:53874->172.17.0.2:32457, err= 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32058") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:47332->172.17.0.2:32058, err= 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:30195") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:48112->172.17.0.2:30195, err= 2025/10/18 02:59:23 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:38102") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:37488->172.17.0.2:38102, err= 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32004") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:46792->172.17.0.2:32004, err= 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39038") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:42872->172.17.0.2:39038, err= 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:39920") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:42712->172.17.0.2:39920, err= 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32729") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:44716->172.17.0.2:32729, err= 2025/10/18 02:59:23 DEBUG : removing 1 level 4 directories 2025/10/18 02:59:23 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/10/18 02:59:23 DEBUG : removing 1 level 3 directories 2025/10/18 02:59:23 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/10/18 02:59:23 DEBUG : removing 1 level 2 directories 2025/10/18 02:59:23 INFO : hello? sausage/êé: Removing directory 2025/10/18 02:59:23 DEBUG : removing 1 level 1 directories 2025/10/18 02:59:23 INFO : hello? sausage: Removing directory 2025/10/18 02:59:23 DEBUG : removing 1 level 0 directories 2025/10/18 02:59:23 INFO : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: Removing directory 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:32555") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:47512->172.17.0.2:32555, err= 2025/10/18 02:59:23 ERROR : error listing: directory not found 2025/10/18 02:59:23 DEBUG : Waiting for deletions to finish 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:33118") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:57152->172.17.0.2:33118, err= 2025/10/18 02:59:23 ERROR : error listing: directory not found 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: dial("tcp","172.17.0.2:35341") 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: > dial: conn=172.17.0.1:50726->172.17.0.2:35341, err= 2025/10/18 02:59:23 ERROR : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: Failed to list "": directory not found 2025/10/18 02:59:23 DEBUG : removing 1 level 0 directories 2025/10/18 02:59:23 INFO : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: Removing directory 2025/10/18 02:59:23 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/10/18 02:59:23 DEBUG : ftp://172.17.0.2:21/rclone-test-yufeqom4ruvu: closing 2 unused connections 2025/10/18 02:59:33 NOTICE: TestFTPPureftpd: Stopping server --- PASS: TestIntegration (34.11s) --- 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.57s) --- 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.14s) --- 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.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.03s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.07s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.05s) --- 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.91s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.91s) --- 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.131s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished OK in 35.200836459s (try 1/5)