"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPPureftpd:" 2025/12/08 04:38:57 NOTICE: TestFTPPureftpd: Starting server 2025/12/08 04:38:58 NOTICE: TestFTPPureftpd: Attempting to connect to "172.17.0.8:21" try 1/100 2025/12/08 04:38:58 DEBUG : TestFTPPureftpd: Read 1, error: 2025/12/08 04:38:58 NOTICE: TestFTPPureftpd: Started server and connected to "172.17.0.8:21" 2025/12/08 04:38:58 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-cihoriz1wupe" 2025/12/08 04:38:58 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/08 04:38:58 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/12/08 04:38:58 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:58 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:58 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:58 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:58 DEBUG : TestFTPPureftpd: detected overridden config - adding "{xUHHX}" suffix to name 2025/12/08 04:38:58 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:58 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:58 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:58 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: Connecting to FTP server 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:21") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:51936->172.17.0.8:21, err= 2025/12/08 04:38:58 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/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39603") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:53730->172.17.0.8:39603, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30780") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:44446->172.17.0.8:30780, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/12/08 04:38:58 INFO : dir/subdir: Making directory 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35174") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:60712->172.17.0.8:35174, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32775") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:34356->172.17.0.8:32775, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:34492") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:35536->172.17.0.8:34492, err= 2025/12/08 04:38:58 INFO : dir/subdir: Removing directory 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35247") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:42078->172.17.0.8:35247, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30941") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:36610->172.17.0.8:30941, err= 2025/12/08 04:38:58 INFO : dir: Removing directory 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31645") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:40168->172.17.0.8:31645, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33556") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:55072->172.17.0.8:33556, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30695") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:43180->172.17.0.8:30695, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31998") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:45530->172.17.0.8:31998, err= 2025/12/08 04:38:58 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/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30907") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:44310->172.17.0.8:30907, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36673") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:55882->172.17.0.8:36673, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31989") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:39410->172.17.0.8:31989, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38763") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:39264->172.17.0.8:38763, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30613") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:46752->172.17.0.8:30613, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31877") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:41244->172.17.0.8:31877, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38409") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:35214->172.17.0.8:38409, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31652") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:34028->172.17.0.8:31652, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33937") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:60822->172.17.0.8:33937, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37655") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:57968->172.17.0.8:37655, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33452") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:36872->172.17.0.8:33452, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36287") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:42706->172.17.0.8:36287, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36658") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:59174->172.17.0.8:36658, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32818") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:50012->172.17.0.8:32818, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33214") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:45750->172.17.0.8:33214, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30888") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:60354->172.17.0.8:30888, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37894") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:58508->172.17.0.8:37894, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32798") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:50616->172.17.0.8:32798, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:34722") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:39906->172.17.0.8:34722, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31860") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:60834->172.17.0.8:31860, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39036") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:38014->172.17.0.8:39036, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35398") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:32902->172.17.0.8:35398, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35164") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:50636->172.17.0.8:35164, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:34405") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:49322->172.17.0.8:34405, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:34720") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:41578->172.17.0.8:34720, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37354") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:46430->172.17.0.8:37354, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38136") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:42910->172.17.0.8:38136, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33456") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:36772->172.17.0.8:33456, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30826") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:55532->172.17.0.8:30826, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31405") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:50444->172.17.0.8:31405, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37645") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:33780->172.17.0.8:37645, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33020") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:40694->172.17.0.8:33020, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37668") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:36518->172.17.0.8:37668, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37086") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:41524->172.17.0.8:37086, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38809") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:47410->172.17.0.8:38809, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37834") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:49726->172.17.0.8:37834, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32622") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:52578->172.17.0.8:32622, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30425") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:52286->172.17.0.8:30425, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35912") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:32984->172.17.0.8:35912, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30928") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:44554->172.17.0.8:30928, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35144") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:59894->172.17.0.8:35144, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:34068") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:58718->172.17.0.8:34068, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39709") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:39850->172.17.0.8:39709, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:34611") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:34262->172.17.0.8:34611, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37364") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:40044->172.17.0.8:37364, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38483") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:36168->172.17.0.8:38483, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36094") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:32996->172.17.0.8:36094, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35390") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:44148->172.17.0.8:35390, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35182") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:33728->172.17.0.8:35182, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31428") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:50842->172.17.0.8:31428, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31568") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:59368->172.17.0.8:31568, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35040") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:40428->172.17.0.8:35040, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:34279") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:34840->172.17.0.8:34279, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35139") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:37400->172.17.0.8:35139, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30416") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:32772->172.17.0.8:30416, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35552") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:37276->172.17.0.8:35552, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35634") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:42190->172.17.0.8:35634, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38430") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:35732->172.17.0.8:38430, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:34708") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:42652->172.17.0.8:34708, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38737") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:44230->172.17.0.8:38737, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39054") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:50736->172.17.0.8:39054, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32824") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:39470->172.17.0.8:32824, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:34881") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:49428->172.17.0.8:34881, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39597") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:38736->172.17.0.8:39597, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31849") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:42836->172.17.0.8:31849, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31120") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:32910->172.17.0.8:31120, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35726") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:45138->172.17.0.8:35726, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33428") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:50322->172.17.0.8:33428, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37120") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:40274->172.17.0.8:37120, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39397") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:52014->172.17.0.8:39397, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:34267") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:36548->172.17.0.8:34267, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37007") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:56374->172.17.0.8:37007, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38619") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:37174->172.17.0.8:38619, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38158") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:60230->172.17.0.8:38158, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32743") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:45116->172.17.0.8:32743, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:34036") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:56174->172.17.0.8:34036, err= 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31810") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:49830->172.17.0.8:31810, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35161") 2025/12/08 04:38:58 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:48172->172.17.0.8:35161, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: Connecting to FTP server 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:21") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:51942->172.17.0.8:21, err= 2025/12/08 04:38:59 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37070") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:34346->172.17.0.8:37070, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:34693") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:40326->172.17.0.8:34693, 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/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32885") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:58288->172.17.0.8:32885, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36247") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:38442->172.17.0.8:36247, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36108") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:35032->172.17.0.8:36108, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31125") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:51058->172.17.0.8:31125, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39747") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:54650->172.17.0.8:39747, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37514") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:37060->172.17.0.8:37514, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39268") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:50836->172.17.0.8:39268, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32899") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:54918->172.17.0.8:32899, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36893") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:50250->172.17.0.8:36893, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30203") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:56946->172.17.0.8:30203, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32354") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:40662->172.17.0.8:32354, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33382") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:57170->172.17.0.8:33382, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39280") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:52620->172.17.0.8:39280, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30625") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:58176->172.17.0.8:30625, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32485") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:37624->172.17.0.8:32485, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30499") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:60894->172.17.0.8:30499, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30530") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:50614->172.17.0.8:30530, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/12/08 04:38:59 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/12/08 04:38:59 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/12/08 04:38:59 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:59 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:59 DEBUG : TestFTPPureftpd: detected overridden config - adding "{xUHHX}" suffix to name 2025/12/08 04:38:59 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:59 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: Connecting to FTP server 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:21") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:51950->172.17.0.8:21, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:38799") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:50452->172.17.0.8:38799, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36268") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:48000->172.17.0.8:36268, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38254") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:55950->172.17.0.8:38254, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36717") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:38142->172.17.0.8:36717, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36812") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:46052->172.17.0.8:36812, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39034") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:59334->172.17.0.8:39034, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39807") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:50602->172.17.0.8:39807, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38925") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:57800->172.17.0.8:38925, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35717") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:58308->172.17.0.8:35717, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31900") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:51202->172.17.0.8:31900, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31764") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:52430->172.17.0.8:31764, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31910") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:33616->172.17.0.8:31910, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37234") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:60062->172.17.0.8:37234, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31526") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:49984->172.17.0.8:31526, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:34995") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:39722->172.17.0.8:34995, 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/12/08 04:38:59 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-cihoriz1wupe/hello? sausage/êé" 2025/12/08 04:38:59 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/12/08 04:38:59 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:59 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:59 DEBUG : TestFTPPureftpd: detected overridden config - adding "{xUHHX}" suffix to name 2025/12/08 04:38:59 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:59 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: Connecting to FTP server 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:21") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:51960->172.17.0.8:21, err= 2025/12/08 04:38:59 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-cihoriz1wupe/hello? sausage/êé" to be canonical "TestFTPPureftpd{xUHHX}:rclone-test-cihoriz1wupe/hello? sausage/êé" 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:34197") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:60304->172.17.0.8:34197, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:38880") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:35470->172.17.0.8:38880, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: Connecting to FTP server 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:21") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:51968->172.17.0.8:21, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:37516") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:59614->172.17.0.8:37516, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:37351") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:52644->172.17.0.8:37351, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:35174") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:60722->172.17.0.8:35174, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:36858") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:50708->172.17.0.8:36858, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:34322") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:55828->172.17.0.8:34322, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:30514") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:54046->172.17.0.8:30514, err= 2025/12/08 04:38:59 DEBUG : Waiting for deletions to finish 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:38980") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:37276->172.17.0.8:38980, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:31135") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:58106->172.17.0.8:31135, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:30857") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:39572->172.17.0.8:30857, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:33841") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:52242->172.17.0.8:33841, err= 2025/12/08 04:38:59 INFO : a/b/c/d/e.txt: Deleted 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:30557") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:54732->172.17.0.8:30557, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:36004") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:42776->172.17.0.8:36004, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:35288") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:60472->172.17.0.8:35288, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: dial("tcp","172.17.0.8:34577") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé: > dial: conn=172.17.0.1:59972->172.17.0.8:34577, err= 2025/12/08 04:38:59 DEBUG : removing 1 level 4 directories 2025/12/08 04:38:59 INFO : a/b/c/d: Removing directory 2025/12/08 04:38:59 DEBUG : removing 1 level 3 directories 2025/12/08 04:38:59 INFO : a/b/c: Removing directory 2025/12/08 04:38:59 DEBUG : removing 1 level 2 directories 2025/12/08 04:38:59 INFO : a/b: Removing directory 2025/12/08 04:38:59 DEBUG : removing 1 level 1 directories 2025/12/08 04:38:59 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38084") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:51254->172.17.0.8:38084, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36524") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:50504->172.17.0.8:36524, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30315") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:45328->172.17.0.8:30315, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36202") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:45842->172.17.0.8:36202, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38079") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:44198->172.17.0.8:38079, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36171") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:38270->172.17.0.8:36171, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: Connecting to FTP server 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:21") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39428") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:36182->172.17.0.8:39428, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:51984->172.17.0.8:21, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32782") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:48534->172.17.0.8:32782, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39863") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:60894->172.17.0.8:39863, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37589") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:52950->172.17.0.8:37589, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39686") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:45438->172.17.0.8:39686, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38726") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:48790->172.17.0.8:38726, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36054") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:43120->172.17.0.8:36054, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38781") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:56046->172.17.0.8:38781, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30712") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:42892->172.17.0.8:30712, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39649") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:41854->172.17.0.8:39649, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33519") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:40334->172.17.0.8:33519, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39870") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:59238->172.17.0.8:39870, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39308") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:32972->172.17.0.8:39308, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30010") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:55960->172.17.0.8:30010, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38994") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:58684->172.17.0.8:38994, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32018") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:37330->172.17.0.8:32018, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36954") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:42834->172.17.0.8:36954, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/12/08 04:38:59 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-rerixav6bato" 2025/12/08 04:38:59 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/12/08 04:38:59 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:59 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:59 DEBUG : TestFTPPureftpd: detected overridden config - adding "{xUHHX}" suffix to name 2025/12/08 04:38:59 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:59 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: Connecting to FTP server 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: dial("tcp","172.17.0.8:21") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: > dial: conn=172.17.0.1:52000->172.17.0.8:21, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35586") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:49848->172.17.0.8:35586, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: dial("tcp","172.17.0.8:30641") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: > dial: conn=172.17.0.1:39732->172.17.0.8:30641, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: dial("tcp","172.17.0.8:37698") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: > dial: conn=172.17.0.1:42586->172.17.0.8:37698, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: dial("tcp","172.17.0.8:35228") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: > dial: conn=172.17.0.1:37358->172.17.0.8:35228, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: dial("tcp","172.17.0.8:38999") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: > dial: conn=172.17.0.1:34730->172.17.0.8:38999, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: dial("tcp","172.17.0.8:34590") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: > dial: conn=172.17.0.1:39502->172.17.0.8:34590, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: dial("tcp","172.17.0.8:33260") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: > dial: conn=172.17.0.1:42224->172.17.0.8:33260, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: dial("tcp","172.17.0.8:36910") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: > dial: conn=172.17.0.1:43892->172.17.0.8:36910, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33768") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:34420->172.17.0.8:33768, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31815") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:45182->172.17.0.8:31815, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33032") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:57998->172.17.0.8:33032, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38726") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:48796->172.17.0.8:38726, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31084") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:46466->172.17.0.8:31084, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: dial("tcp","172.17.0.8:35537") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: > dial: conn=172.17.0.1:54380->172.17.0.8:35537, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: dial("tcp","172.17.0.8:35786") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: > dial: conn=172.17.0.1:59934->172.17.0.8:35786, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: dial("tcp","172.17.0.8:35453") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: > dial: conn=172.17.0.1:57290->172.17.0.8:35453, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: dial("tcp","172.17.0.8:33480") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: > dial: conn=172.17.0.1:39468->172.17.0.8:33480, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: Purge dir "new_name" 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-rerixav6bato: 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/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38400") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:51778->172.17.0.8:38400, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32594") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:48652->172.17.0.8:32594, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39078") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:38616->172.17.0.8:39078, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37082") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:60638->172.17.0.8:37082, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30223") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:33766->172.17.0.8:30223, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35670") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:50336->172.17.0.8:35670, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35242") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:51636->172.17.0.8:35242, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31331") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:54758->172.17.0.8:31331, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38644") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:53648->172.17.0.8:38644, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/12/08 04:38:59 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-cihoriz1wupe/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/12/08 04:38:59 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/12/08 04:38:59 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:59 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:59 DEBUG : TestFTPPureftpd: detected overridden config - adding "{xUHHX}" suffix to name 2025/12/08 04:38:59 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:59 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.8:21") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:52006->172.17.0.8:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.8:30339") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:39476->172.17.0.8:30339, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/12/08 04:38:59 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-cihoriz1wupe/not found.txt" 2025/12/08 04:38:59 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/12/08 04:38:59 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:59 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:59 DEBUG : TestFTPPureftpd: detected overridden config - adding "{xUHHX}" suffix to name 2025/12/08 04:38:59 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:59 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/not found.txt: Connecting to FTP server 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/not found.txt: dial("tcp","172.17.0.8:21") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/not found.txt: > dial: conn=172.17.0.1:52016->172.17.0.8:21, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/not found.txt: dial("tcp","172.17.0.8:32772") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/not found.txt: > dial: conn=172.17.0.1:40826->172.17.0.8:32772, err= 2025/12/08 04:38:59 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPPureftpd:" path "rclone-test-cihoriz1wupe" from "TestFTPPureftpd:rclone-test-cihoriz1wupe" 2025/12/08 04:38:59 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/12/08 04:38:59 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/12/08 04:38:59 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:59 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:59 DEBUG : TestFTPPureftpd: detected overridden config - adding "{xUHHX}" suffix to name 2025/12/08 04:38:59 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:59 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: Connecting to FTP server 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:21") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:52024->172.17.0.8:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:36316") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:35162->172.17.0.8:36316, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:35428") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:49130->172.17.0.8:35428, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:34743") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:48990->172.17.0.8:34743, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:37014") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:36276->172.17.0.8:37014, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:35622") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:44562->172.17.0.8:35622, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:31046") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:35406->172.17.0.8:31046, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:31072") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:60636->172.17.0.8:31072, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:38244") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:44568->172.17.0.8:38244, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:30530") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:50624->172.17.0.8:30530, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:35275") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:60630->172.17.0.8:35275, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:39485") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:55208->172.17.0.8:39485, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:30169") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:49746->172.17.0.8:30169, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:39795") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:59554->172.17.0.8:39795, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:39047") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:45106->172.17.0.8:39047, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:30985") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:53306->172.17.0.8:30985, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:38999") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:34740->172.17.0.8:38999, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: dial("tcp","172.17.0.8:35714") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21: > dial: conn=172.17.0.1:45876->172.17.0.8:35714, 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/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30238") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:58406->172.17.0.8:30238, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39388") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:51604->172.17.0.8:39388, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32469") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:48700->172.17.0.8:32469, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33550") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:40234->172.17.0.8:33550, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32846") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:32874->172.17.0.8:32846, 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/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36628") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:42910->172.17.0.8:36628, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30291") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:45044->172.17.0.8:30291, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/12/08 04:38:59 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-cihoriz1wupe" 2025/12/08 04:38:59 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/12/08 04:38:59 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:59 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:59 DEBUG : TestFTPPureftpd: detected overridden config - adding "{i-3HN}" suffix to name 2025/12/08 04:38:59 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:38:59 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:38:59 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:38:59 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: Connecting to FTP server 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:21") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:52032->172.17.0.8:21, err= 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38420") 2025/12/08 04:38:59 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:52106->172.17.0.8:38420, 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/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:36068") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:35172->172.17.0.8:36068, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31441") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:50248->172.17.0.8:31441, err= 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:31997") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:40960->172.17.0.8:31997, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/12/08 04:39:00 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-cihoriz1wupe/deeper/nonexisting/directory" 2025/12/08 04:39:00 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/12/08 04:39:00 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:39:00 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:39:00 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:39:00 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:39:00 DEBUG : TestFTPPureftpd: detected overridden config - adding "{xUHHX}" suffix to name 2025/12/08 04:39:00 DEBUG : Setting host="172.17.0.8" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/12/08 04:39:00 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/12/08 04:39:00 DEBUG : Setting pass="ozK_LR_PxS_PWSLNOkPlrRosUzNFAxwU3KYRDvEJ1ag" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/12/08 04:39:00 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/deeper/nonexisting/directory: Connecting to FTP server 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/deeper/nonexisting/directory: dial("tcp","172.17.0.8:21") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe/deeper/nonexisting/directory: > dial: conn=172.17.0.1:52048->172.17.0.8: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/12/08 04:39:00 DEBUG : Waiting for deletions to finish 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33564") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:40046->172.17.0.8:33564, err= 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33316") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:45770->172.17.0.8:33316, err= 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35839") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:59764->172.17.0.8:35839, err= 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32105") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:59528->172.17.0.8:32105, err= 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:38631") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:49190->172.17.0.8:38631, err= 2025/12/08 04:39:00 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39616") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:45818->172.17.0.8:39616, err= 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:37597") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:47492->172.17.0.8:37597, err= 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:30602") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:58666->172.17.0.8:30602, err= 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:34093") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:36414->172.17.0.8:34093, err= 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:33591") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:51288->172.17.0.8:33591, err= 2025/12/08 04:39:00 DEBUG : removing 1 level 4 directories 2025/12/08 04:39:00 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/12/08 04:39:00 DEBUG : removing 1 level 3 directories 2025/12/08 04:39:00 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/12/08 04:39:00 DEBUG : removing 1 level 2 directories 2025/12/08 04:39:00 INFO : hello? sausage/êé: Removing directory 2025/12/08 04:39:00 DEBUG : removing 1 level 1 directories 2025/12/08 04:39:00 INFO : hello? sausage: Removing directory 2025/12/08 04:39:00 DEBUG : removing 1 level 0 directories 2025/12/08 04:39:00 INFO : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: Removing directory 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:32876") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:60940->172.17.0.8:32876, err= 2025/12/08 04:39:00 ERROR : error listing: directory not found 2025/12/08 04:39:00 DEBUG : Waiting for deletions to finish 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:35694") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:33094->172.17.0.8:35694, err= 2025/12/08 04:39:00 ERROR : error listing: directory not found 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: dial("tcp","172.17.0.8:39050") 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: > dial: conn=172.17.0.1:33444->172.17.0.8:39050, err= 2025/12/08 04:39:00 ERROR : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: Failed to list "": directory not found 2025/12/08 04:39:00 DEBUG : removing 1 level 0 directories 2025/12/08 04:39:00 INFO : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: Removing directory 2025/12/08 04:39:00 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/12/08 04:39:00 DEBUG : ftp://172.17.0.8:21/rclone-test-cihoriz1wupe: closing 2 unused connections 2025/12/08 04:39:00 NOTICE: TestFTPPureftpd: Stopping server --- PASS: TestIntegration (3.31s) --- 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.21s) --- 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.11s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.00s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (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.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.74s) --- 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.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) --- 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 3.321s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished OK in 4.210640215s (try 1/5)