"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPPureftpd:" 2025/10/14 02:03:29 NOTICE: TestFTPPureftpd: Stopping server 2025/10/14 02:03:30 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 2/10 2025/10/14 02:03:30 NOTICE: TestFTPPureftpd: Stopping server 2025/10/14 02:03:31 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 3/10 2025/10/14 02:03:31 NOTICE: TestFTPPureftpd: Stopping server 2025/10/14 02:03:32 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 4/10 2025/10/14 02:03:32 NOTICE: TestFTPPureftpd: Stopping server 2025/10/14 02:03:33 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 5/10 2025/10/14 02:03:33 NOTICE: TestFTPPureftpd: Stopping server 2025/10/14 02:03:34 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 6/10 2025/10/14 02:03:34 NOTICE: TestFTPPureftpd: Stopping server 2025/10/14 02:03:35 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 7/10 2025/10/14 02:03:35 NOTICE: TestFTPPureftpd: Stopping server 2025/10/14 02:03:36 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 8/10 2025/10/14 02:03:37 NOTICE: TestFTPPureftpd: Stopping server 2025/10/14 02:03:38 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 9/10 2025/10/14 02:03:38 NOTICE: TestFTPPureftpd: Stopping server 2025/10/14 02:03:39 NOTICE: TestFTPPureftpd: Attempting to stop TestFTPPureftpd try 10/10 2025/10/14 02:03:39 NOTICE: TestFTPPureftpd: Stopping server 2025/10/14 02:03:39 NOTICE: TestFTPPureftpd: Starting server 2025/10/14 02:03:40 NOTICE: TestFTPPureftpd: Attempting to connect to "172.17.0.6:21" try 1/100 2025/10/14 02:03:40 DEBUG : TestFTPPureftpd: Read 1, error: 2025/10/14 02:03:40 NOTICE: TestFTPPureftpd: Started server and connected to "172.17.0.6:21" 2025/10/14 02:03:40 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-zezecuz0guda" 2025/10/14 02:03:40 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/14 02:03:40 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/14 02:03:40 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:40 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:40 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:40 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:40 DEBUG : TestFTPPureftpd: detected overridden config - adding "{7mCpg}" suffix to name 2025/10/14 02:03:40 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:40 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:40 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:40 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: Connecting to FTP server 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:21") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:51262->172.17.0.6:21, err= 2025/10/14 02:03:40 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/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:39162") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:46680->172.17.0.6:39162, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:37929") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:55350->172.17.0.6:37929, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/10/14 02:03:40 INFO : dir/subdir: Making directory 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31835") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:37768->172.17.0.6:31835, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36667") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:44858->172.17.0.6:36667, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:39762") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:46666->172.17.0.6:39762, err= 2025/10/14 02:03:40 INFO : dir/subdir: Removing directory 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31054") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:58684->172.17.0.6:31054, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32003") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:50356->172.17.0.6:32003, err= 2025/10/14 02:03:40 INFO : dir: Removing directory 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38962") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:54676->172.17.0.6:38962, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38271") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:50696->172.17.0.6:38271, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38759") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:33330->172.17.0.6:38759, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36487") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:60266->172.17.0.6:36487, err= 2025/10/14 02:03:40 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/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32130") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:45720->172.17.0.6:32130, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35830") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:38244->172.17.0.6:35830, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30589") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:50126->172.17.0.6:30589, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31420") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:46506->172.17.0.6:31420, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:37007") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:56178->172.17.0.6:37007, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35122") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:40754->172.17.0.6:35122, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32035") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:57556->172.17.0.6:32035, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35378") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:52478->172.17.0.6:35378, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35299") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:53706->172.17.0.6:35299, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32445") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:33474->172.17.0.6:32445, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32215") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:40436->172.17.0.6:32215, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:37031") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:57068->172.17.0.6:37031, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34424") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:34440->172.17.0.6:34424, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34788") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:52760->172.17.0.6:34788, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30473") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:59048->172.17.0.6:30473, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:39600") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:42438->172.17.0.6:39600, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31816") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:42724->172.17.0.6:31816, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30945") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:37612->172.17.0.6:30945, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35659") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:41862->172.17.0.6:35659, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30175") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:49274->172.17.0.6:30175, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32125") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:44092->172.17.0.6:32125, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31480") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:43832->172.17.0.6:31480, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33730") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:42016->172.17.0.6:33730, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35772") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:37060->172.17.0.6:35772, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36312") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:35894->172.17.0.6:36312, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32157") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:60084->172.17.0.6:32157, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35300") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:56100->172.17.0.6:35300, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:39042") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:53592->172.17.0.6:39042, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34331") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:53318->172.17.0.6:34331, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38041") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:51214->172.17.0.6:38041, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30353") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:56632->172.17.0.6:30353, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34409") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:43658->172.17.0.6:34409, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31961") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:55774->172.17.0.6:31961, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34250") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:60060->172.17.0.6:34250, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33332") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:58548->172.17.0.6:33332, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30007") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:59890->172.17.0.6:30007, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30823") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:39188->172.17.0.6:30823, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36143") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:56576->172.17.0.6:36143, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31883") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:55096->172.17.0.6:31883, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38394") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:59998->172.17.0.6:38394, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38684") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:42280->172.17.0.6:38684, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38531") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:50372->172.17.0.6:38531, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33590") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:44602->172.17.0.6:33590, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:37257") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:36932->172.17.0.6:37257, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32335") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:58886->172.17.0.6:32335, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30247") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:40034->172.17.0.6:30247, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34367") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:53030->172.17.0.6:34367, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:39263") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:33978->172.17.0.6:39263, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33848") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:55928->172.17.0.6:33848, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38952") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:58692->172.17.0.6:38952, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32062") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:44830->172.17.0.6:32062, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38361") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:41296->172.17.0.6:38361, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38824") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:33714->172.17.0.6:38824, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30720") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:47430->172.17.0.6:30720, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32455") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:44520->172.17.0.6:32455, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35941") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:44770->172.17.0.6:35941, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33909") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:44598->172.17.0.6:33909, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33651") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:55548->172.17.0.6:33651, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34658") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:46382->172.17.0.6:34658, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32275") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:49762->172.17.0.6:32275, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32097") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:50306->172.17.0.6:32097, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:39714") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:46262->172.17.0.6:39714, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:37003") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:57126->172.17.0.6:37003, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35749") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:56176->172.17.0.6:35749, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30247") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:40036->172.17.0.6:30247, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38585") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:55350->172.17.0.6:38585, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35580") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:36126->172.17.0.6:35580, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33451") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:51620->172.17.0.6:33451, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34685") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:58774->172.17.0.6:34685, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30231") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:53228->172.17.0.6:30231, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31202") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:51962->172.17.0.6:31202, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30053") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:37152->172.17.0.6:30053, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:39864") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:37860->172.17.0.6:39864, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:37402") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:51660->172.17.0.6:37402, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30129") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:42682->172.17.0.6:30129, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34674") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:43698->172.17.0.6:34674, err= 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33908") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:51696->172.17.0.6:33908, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36324") 2025/10/14 02:03:40 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:33222->172.17.0.6:36324, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: Connecting to FTP server 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:21") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:51274->172.17.0.6:21, err= 2025/10/14 02:03:41 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30643") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:44662->172.17.0.6:30643, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34662") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:55148->172.17.0.6:34662, 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/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32416") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:35018->172.17.0.6:32416, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30616") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:39634->172.17.0.6:30616, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30049") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:55890->172.17.0.6:30049, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38764") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:38322->172.17.0.6:38764, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34740") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:55724->172.17.0.6:34740, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31273") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:56168->172.17.0.6:31273, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31588") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:42194->172.17.0.6:31588, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35340") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:60948->172.17.0.6:35340, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35679") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:43164->172.17.0.6:35679, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36273") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:56136->172.17.0.6:36273, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38674") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:57978->172.17.0.6:38674, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36851") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:54652->172.17.0.6:36851, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35775") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:50152->172.17.0.6:35775, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30512") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:38426->172.17.0.6:30512, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33297") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:39258->172.17.0.6:33297, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34574") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:34684->172.17.0.6:34574, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30810") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:52040->172.17.0.6:30810, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/10/14 02:03:41 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/10/14 02:03:41 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/14 02:03:41 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:41 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:41 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:41 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:41 DEBUG : TestFTPPureftpd: detected overridden config - adding "{7mCpg}" suffix to name 2025/10/14 02:03:41 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:41 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:41 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:41 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21: Connecting to FTP server 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:21") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:51290->172.17.0.6:21, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:34672") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:44680->172.17.0.6:34672, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33921") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:42076->172.17.0.6:33921, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:39734") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:52700->172.17.0.6:39734, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31840") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:60490->172.17.0.6:31840, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36208") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:32910->172.17.0.6:36208, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:39129") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:51700->172.17.0.6:39129, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31363") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:56882->172.17.0.6:31363, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:39163") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:40362->172.17.0.6:39163, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31769") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:38350->172.17.0.6:31769, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32326") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:46062->172.17.0.6:32326, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:37030") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:54716->172.17.0.6:37030, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31427") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:46528->172.17.0.6:31427, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33193") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:47604->172.17.0.6:33193, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31127") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:58728->172.17.0.6:31127, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38476") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:60306->172.17.0.6:38476, 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/14 02:03:41 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-zezecuz0guda/hello? sausage/êé" 2025/10/14 02:03:41 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/14 02:03:41 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:41 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:41 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:41 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:41 DEBUG : TestFTPPureftpd: detected overridden config - adding "{7mCpg}" suffix to name 2025/10/14 02:03:41 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:41 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:41 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:41 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: Connecting to FTP server 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:21") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:51298->172.17.0.6:21, err= 2025/10/14 02:03:41 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-zezecuz0guda/hello? sausage/êé" to be canonical "TestFTPPureftpd{7mCpg}:rclone-test-zezecuz0guda/hello? sausage/êé" 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:38967") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:58662->172.17.0.6:38967, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:31298") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:49094->172.17.0.6:31298, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: Connecting to FTP server 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:21") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:36292") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:51310->172.17.0.6:21, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:37960->172.17.0.6:36292, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:35311") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:57272->172.17.0.6:35311, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:35620") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:44228->172.17.0.6:35620, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:37653") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:39708->172.17.0.6:37653, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:35072") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:55650->172.17.0.6:35072, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:38825") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:36716->172.17.0.6:38825, err= 2025/10/14 02:03:41 DEBUG : Waiting for deletions to finish 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:37213") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:37926->172.17.0.6:37213, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:39072") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:50232->172.17.0.6:39072, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:39467") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:36820->172.17.0.6:39467, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:37278") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:44968->172.17.0.6:37278, err= 2025/10/14 02:03:41 INFO : a/b/c/d/e.txt: Deleted 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:30455") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:58084->172.17.0.6:30455, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:35966") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:55166->172.17.0.6:35966, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:36498") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:34170->172.17.0.6:36498, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: dial("tcp","172.17.0.6:34920") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé: > dial: conn=172.17.0.1:50280->172.17.0.6:34920, err= 2025/10/14 02:03:41 DEBUG : removing 1 level 4 directories 2025/10/14 02:03:41 INFO : a/b/c/d: Removing directory 2025/10/14 02:03:41 DEBUG : removing 1 level 3 directories 2025/10/14 02:03:41 INFO : a/b/c: Removing directory 2025/10/14 02:03:41 DEBUG : removing 1 level 2 directories 2025/10/14 02:03:41 INFO : a/b: Removing directory 2025/10/14 02:03:41 DEBUG : removing 1 level 1 directories 2025/10/14 02:03:41 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38534") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:55738->172.17.0.6:38534, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35586") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:45466->172.17.0.6:35586, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32335") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:58896->172.17.0.6:32335, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30354") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:40906->172.17.0.6:30354, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31034") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:58412->172.17.0.6:31034, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33179") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:41528->172.17.0.6:33179, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: Connecting to FTP server 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:21") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:51322->172.17.0.6:21, err= 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36760") 2025/10/14 02:03:41 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:51720->172.17.0.6:36760, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35846") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:55676->172.17.0.6:35846, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32505") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:59690->172.17.0.6:32505, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:37364") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:37718->172.17.0.6:37364, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34207") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:44216->172.17.0.6:34207, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:39207") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:57870->172.17.0.6:39207, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36520") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34497") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:49974->172.17.0.6:36520, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:48144->172.17.0.6:34497, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:39320") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:47892->172.17.0.6:39320, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30449") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:40774->172.17.0.6:30449, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38157") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:56826->172.17.0.6:38157, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:37291") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:58128->172.17.0.6:37291, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32670") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:50028->172.17.0.6:32670, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:37492") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:46672->172.17.0.6:37492, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30680") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:45514->172.17.0.6:30680, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35525") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:58188->172.17.0.6:35525, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32738") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:52246->172.17.0.6:32738, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/10/14 02:03:42 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-damoleg1xofu" 2025/10/14 02:03:42 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/14 02:03:42 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:42 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:42 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:42 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:42 DEBUG : TestFTPPureftpd: detected overridden config - adding "{7mCpg}" suffix to name 2025/10/14 02:03:42 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:42 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:42 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:42 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: Connecting to FTP server 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: dial("tcp","172.17.0.6:21") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: > dial: conn=172.17.0.1:51336->172.17.0.6:21, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32475") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:35068->172.17.0.6:32475, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: dial("tcp","172.17.0.6:30520") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: > dial: conn=172.17.0.1:52112->172.17.0.6:30520, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: dial("tcp","172.17.0.6:35026") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: > dial: conn=172.17.0.1:37404->172.17.0.6:35026, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: dial("tcp","172.17.0.6:32110") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: > dial: conn=172.17.0.1:45258->172.17.0.6:32110, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: dial("tcp","172.17.0.6:37088") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: > dial: conn=172.17.0.1:44272->172.17.0.6:37088, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: dial("tcp","172.17.0.6:39382") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: > dial: conn=172.17.0.1:35918->172.17.0.6:39382, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: dial("tcp","172.17.0.6:37468") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: > dial: conn=172.17.0.1:59666->172.17.0.6:37468, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: dial("tcp","172.17.0.6:38443") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: > dial: conn=172.17.0.1:56812->172.17.0.6:38443, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31504") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:40266->172.17.0.6:31504, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36561") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:53340->172.17.0.6:36561, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32172") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:48096->172.17.0.6:32172, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35094") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:35490->172.17.0.6:35094, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31315") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:33578->172.17.0.6:31315, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: dial("tcp","172.17.0.6:30066") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: > dial: conn=172.17.0.1:45192->172.17.0.6:30066, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: dial("tcp","172.17.0.6:39567") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: > dial: conn=172.17.0.1:34910->172.17.0.6:39567, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: dial("tcp","172.17.0.6:35111") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: > dial: conn=172.17.0.1:45140->172.17.0.6:35111, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: dial("tcp","172.17.0.6:35716") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: > dial: conn=172.17.0.1:47576->172.17.0.6:35716, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: Purge dir "new_name" 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-damoleg1xofu: 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/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34527") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:46594->172.17.0.6:34527, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31568") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:59060->172.17.0.6:31568, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35403") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:34824->172.17.0.6:35403, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:35090") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:58180->172.17.0.6:35090, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33062") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:59512->172.17.0.6:33062, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36788") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:42616->172.17.0.6:36788, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36163") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:56554->172.17.0.6:36163, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36944") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:49490->172.17.0.6:36944, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31507") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:44556->172.17.0.6:31507, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/10/14 02:03:42 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-zezecuz0guda/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/10/14 02:03:42 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/14 02:03:42 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:42 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:42 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:42 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:42 DEBUG : TestFTPPureftpd: detected overridden config - adding "{7mCpg}" suffix to name 2025/10/14 02:03:42 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:42 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:42 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:42 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.6:21") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:51338->172.17.0.6:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.6:39268") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:41442->172.17.0.6:39268, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/10/14 02:03:42 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-zezecuz0guda/not found.txt" 2025/10/14 02:03:42 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/14 02:03:42 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:42 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:42 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:42 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:42 DEBUG : TestFTPPureftpd: detected overridden config - adding "{7mCpg}" suffix to name 2025/10/14 02:03:42 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:42 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:42 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:42 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/not found.txt: Connecting to FTP server 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/not found.txt: dial("tcp","172.17.0.6:21") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/not found.txt: > dial: conn=172.17.0.1:51346->172.17.0.6:21, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/not found.txt: dial("tcp","172.17.0.6:31930") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/not found.txt: > dial: conn=172.17.0.1:47656->172.17.0.6:31930, err= 2025/10/14 02:03:42 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPPureftpd:" path "rclone-test-zezecuz0guda" from "TestFTPPureftpd:rclone-test-zezecuz0guda" 2025/10/14 02:03:42 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2025/10/14 02:03:42 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/14 02:03:42 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:42 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:42 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:42 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:42 DEBUG : TestFTPPureftpd: detected overridden config - adding "{7mCpg}" suffix to name 2025/10/14 02:03:42 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:42 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:42 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:42 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: Connecting to FTP server 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:21") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:51348->172.17.0.6:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:31896") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:35466->172.17.0.6:31896, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:37529") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:51700->172.17.0.6:37529, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:30012") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:40992->172.17.0.6:30012, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:36463") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:43216->172.17.0.6:36463, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:32646") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:35532->172.17.0.6:32646, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:33704") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:40072->172.17.0.6:33704, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:33027") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:39998->172.17.0.6:33027, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:36586") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:43206->172.17.0.6:36586, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:34239") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:58754->172.17.0.6:34239, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:35552") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:41636->172.17.0.6:35552, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:39429") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:52320->172.17.0.6:39429, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:34731") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:52362->172.17.0.6:34731, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:39627") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:48314->172.17.0.6:39627, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:37931") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:40344->172.17.0.6:37931, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:31129") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:50746->172.17.0.6:31129, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:39510") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:52972->172.17.0.6:39510, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: dial("tcp","172.17.0.6:39551") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21: > dial: conn=172.17.0.1:34662->172.17.0.6:39551, 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/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38694") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:47402->172.17.0.6:38694, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31464") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:46894->172.17.0.6:31464, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30972") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:55632->172.17.0.6:30972, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33991") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:42916->172.17.0.6:33991, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30854") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:37654->172.17.0.6:30854, 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/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36808") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:50424->172.17.0.6:36808, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33793") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:32780->172.17.0.6:33793, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/10/14 02:03:42 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-zezecuz0guda" 2025/10/14 02:03:42 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/14 02:03:42 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:42 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:42 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:42 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:42 DEBUG : TestFTPPureftpd: detected overridden config - adding "{DZLuD}" suffix to name 2025/10/14 02:03:42 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:42 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:42 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:42 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: Connecting to FTP server 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:21") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:51352->172.17.0.6:21, err= 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:39716") 2025/10/14 02:03:42 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:35106->172.17.0.6:39716, 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/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30871") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:58210->172.17.0.6:30871, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:37041") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:50262->172.17.0.6:37041, err= 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32650") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:33412->172.17.0.6:32650, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/14 02:03:43 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-zezecuz0guda/deeper/nonexisting/directory" 2025/10/14 02:03:43 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2025/10/14 02:03:43 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:43 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:43 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:43 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:43 DEBUG : TestFTPPureftpd: detected overridden config - adding "{7mCpg}" suffix to name 2025/10/14 02:03:43 DEBUG : Setting host="172.17.0.6" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2025/10/14 02:03:43 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2025/10/14 02:03:43 DEBUG : Setting pass="zXUgKrfkkXkqw1vIN9p_97X_njeUmc_VYV9_3ZoACNc" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2025/10/14 02:03:43 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/deeper/nonexisting/directory: Connecting to FTP server 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/deeper/nonexisting/directory: dial("tcp","172.17.0.6:21") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda/deeper/nonexisting/directory: > dial: conn=172.17.0.1:51358->172.17.0.6: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/14 02:03:43 DEBUG : Waiting for deletions to finish 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32413") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:42486->172.17.0.6:32413, err= 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30387") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:39788->172.17.0.6:30387, err= 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30030") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:40884->172.17.0.6:30030, err= 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32657") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:39940->172.17.0.6:32657, err= 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:33142") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:51782->172.17.0.6:33142, err= 2025/10/14 02:03:43 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:32889") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:37358->172.17.0.6:32889, err= 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38794") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:43352->172.17.0.6:38794, err= 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:34057") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:47630->172.17.0.6:34057, err= 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30637") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:54874->172.17.0.6:30637, err= 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:31306") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:37634->172.17.0.6:31306, err= 2025/10/14 02:03:43 DEBUG : removing 1 level 4 directories 2025/10/14 02:03:43 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/10/14 02:03:43 DEBUG : removing 1 level 3 directories 2025/10/14 02:03:43 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/10/14 02:03:43 DEBUG : removing 1 level 2 directories 2025/10/14 02:03:43 INFO : hello? sausage/êé: Removing directory 2025/10/14 02:03:43 DEBUG : removing 1 level 1 directories 2025/10/14 02:03:43 INFO : hello? sausage: Removing directory 2025/10/14 02:03:43 DEBUG : removing 1 level 0 directories 2025/10/14 02:03:43 INFO : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: Removing directory 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:30040") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:36950->172.17.0.6:30040, err= 2025/10/14 02:03:43 ERROR : error listing: directory not found 2025/10/14 02:03:43 DEBUG : Waiting for deletions to finish 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:36918") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:33132->172.17.0.6:36918, err= 2025/10/14 02:03:43 ERROR : error listing: directory not found 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: dial("tcp","172.17.0.6:38211") 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: > dial: conn=172.17.0.1:39450->172.17.0.6:38211, err= 2025/10/14 02:03:43 ERROR : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: Failed to list "": directory not found 2025/10/14 02:03:43 DEBUG : removing 1 level 0 directories 2025/10/14 02:03:43 INFO : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: Removing directory 2025/10/14 02:03:43 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/10/14 02:03:43 DEBUG : ftp://172.17.0.6:21/rclone-test-zezecuz0guda: closing 2 unused connections 2025/10/14 02:03:53 NOTICE: TestFTPPureftpd: Stopping server --- PASS: TestIntegration (34.08s) --- 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.44s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.05s) --- 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.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.81s) --- 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.098s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose" - Finished OK in 35.057983425s (try 1/5)