"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/10/07 04:19:01 NOTICE: TestFTPProftpd: Stopping server 2025/10/07 04:19:02 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 2/10 2025/10/07 04:19:02 NOTICE: TestFTPProftpd: Stopping server 2025/10/07 04:19:03 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 3/10 2025/10/07 04:19:03 NOTICE: TestFTPProftpd: Stopping server 2025/10/07 04:19:04 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 4/10 2025/10/07 04:19:04 NOTICE: TestFTPProftpd: Stopping server 2025/10/07 04:19:05 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 5/10 2025/10/07 04:19:05 NOTICE: TestFTPProftpd: Stopping server 2025/10/07 04:19:06 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 6/10 2025/10/07 04:19:06 NOTICE: TestFTPProftpd: Stopping server 2025/10/07 04:19:07 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 7/10 2025/10/07 04:19:07 NOTICE: TestFTPProftpd: Stopping server 2025/10/07 04:19:08 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 8/10 2025/10/07 04:19:08 NOTICE: TestFTPProftpd: Stopping server 2025/10/07 04:19:09 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 9/10 2025/10/07 04:19:09 NOTICE: TestFTPProftpd: Stopping server 2025/10/07 04:19:10 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 10/10 2025/10/07 04:19:10 NOTICE: TestFTPProftpd: Stopping server 2025/10/07 04:19:10 NOTICE: TestFTPProftpd: Starting server 2025/10/07 04:19:12 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.2:21" try 1/100 2025/10/07 04:19:12 DEBUG : TestFTPProftpd: Read 1, error: 2025/10/07 04:19:12 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.2:21" 2025/10/07 04:19:12 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hayemev4huxi" 2025/10/07 04:19:12 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/07 04:19:12 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/07 04:19:12 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:12 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:12 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:12 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:12 DEBUG : TestFTPProftpd: detected overridden config - adding "{PKytQ}" suffix to name 2025/10/07 04:19:12 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:12 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:12 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:12 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: Connecting to FTP server 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:21") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:52550->172.17.0.2:21, err= 2025/10/07 04:19:12 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_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/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:20622") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:38712->172.17.0.2:20622, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:41373") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:51308->172.17.0.2:41373, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/10/07 04:19:12 INFO : dir/subdir: Making directory 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:38686") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:37994->172.17.0.2:38686, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:22524") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:46524->172.17.0.2:22524, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:50498") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:36106->172.17.0.2:50498, err= 2025/10/07 04:19:12 INFO : dir/subdir: Removing directory 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:34655") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:52018->172.17.0.2:34655, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:55736") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:43098->172.17.0.2:55736, err= 2025/10/07 04:19:12 INFO : dir: Removing directory 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:2014") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:53254->172.17.0.2:2014, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:5253") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:35066->172.17.0.2:5253, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:11705") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:51414->172.17.0.2:11705, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:10735") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:60422->172.17.0.2:10735, err= 2025/10/07 04:19:12 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/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:45424") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:42198->172.17.0.2:45424, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:23246") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:52584->172.17.0.2:23246, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:5956") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:57600->172.17.0.2:5956, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:54804") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:44068->172.17.0.2:54804, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:56424") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:60478->172.17.0.2:56424, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:12715") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:57944->172.17.0.2:12715, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:12263") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:54494->172.17.0.2:12263, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:31955") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:48124->172.17.0.2:31955, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:7972") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:55406->172.17.0.2:7972, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:11175") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:41010->172.17.0.2:11175, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:65179") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:35904->172.17.0.2:65179, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:53115") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:48960->172.17.0.2:53115, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:39151") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:57774->172.17.0.2:39151, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:39457") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:43958->172.17.0.2:39457, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:57319") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:57500->172.17.0.2:57319, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:41034") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:44136->172.17.0.2:41034, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:58241") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:34884->172.17.0.2:58241, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:22309") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:40526->172.17.0.2:22309, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:12358") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:33960->172.17.0.2:12358, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:42009") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:35784->172.17.0.2:42009, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:41907") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:56692->172.17.0.2:41907, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:52708") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:47024->172.17.0.2:52708, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:15161") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:48028->172.17.0.2:15161, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:63407") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:33924->172.17.0.2:63407, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:37671") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:50880->172.17.0.2:37671, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:48792") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:45868->172.17.0.2:48792, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:53609") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:47396->172.17.0.2:53609, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:38661") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:47200->172.17.0.2:38661, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:53022") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:43512->172.17.0.2:53022, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:64291") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:48982->172.17.0.2:64291, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:48373") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:51408->172.17.0.2:48373, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:32911") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:58832->172.17.0.2:32911, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:22003") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:49624->172.17.0.2:22003, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:53305") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:47524->172.17.0.2:53305, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:22181") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:59912->172.17.0.2:22181, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:12892") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:58300->172.17.0.2:12892, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:64997") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:54460->172.17.0.2:64997, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:33420") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:56870->172.17.0.2:33420, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:43823") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:57914->172.17.0.2:43823, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:7435") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:48808->172.17.0.2:7435, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:43571") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:33208->172.17.0.2:43571, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:43468") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:43190->172.17.0.2:43468, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:59526") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:57934->172.17.0.2:59526, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:17188") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:51196->172.17.0.2:17188, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:17390") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:44828->172.17.0.2:17390, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:51311") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:56110->172.17.0.2:51311, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:57199") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:49792->172.17.0.2:57199, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:10097") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:56468->172.17.0.2:10097, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:8085") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:58332->172.17.0.2:8085, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:4022") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:34750->172.17.0.2:4022, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:51083") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:38128->172.17.0.2:51083, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:48969") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:59298->172.17.0.2:48969, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:55706") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:40332->172.17.0.2:55706, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:65220") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:42118->172.17.0.2:65220, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:46842") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:37968->172.17.0.2:46842, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:27843") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:44968->172.17.0.2:27843, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:48478") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:51154->172.17.0.2:48478, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:34916") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:38068->172.17.0.2:34916, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:65480") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:58182->172.17.0.2:65480, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:35965") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:39214->172.17.0.2:35965, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:33673") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:38148->172.17.0.2:33673, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:48318") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:54140->172.17.0.2:48318, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:3342") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:50082->172.17.0.2:3342, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:54652") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:60750->172.17.0.2:54652, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:36089") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:48666->172.17.0.2:36089, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:24499") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:47680->172.17.0.2:24499, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:2010") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:40930->172.17.0.2:2010, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:35551") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:50826->172.17.0.2:35551, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:56895") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:56168->172.17.0.2:56895, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:44809") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:34152->172.17.0.2:44809, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:41962") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:41910->172.17.0.2:41962, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:34932") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:49576->172.17.0.2:34932, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:22742") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:35994->172.17.0.2:22742, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:35954") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:53348->172.17.0.2:35954, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:51097") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:54474->172.17.0.2:51097, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:39109") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:42088->172.17.0.2:39109, err= 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:21730") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:59828->172.17.0.2:21730, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:42762") 2025/10/07 04:19:12 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:47752->172.17.0.2:42762, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: Connecting to FTP server 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:21") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:52564->172.17.0.2:21, err= 2025/10/07 04:19:13 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:39874") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:49826->172.17.0.2:39874, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:36435") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:43368->172.17.0.2:36435, 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/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:61460") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:46134->172.17.0.2:61460, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:27983") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:59786->172.17.0.2:27983, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:33998") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:37730->172.17.0.2:33998, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:15258") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:47174->172.17.0.2:15258, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:11647") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:58134->172.17.0.2:11647, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:5636") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:54250->172.17.0.2:5636, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:5072") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:38592->172.17.0.2:5072, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:43325") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:32954->172.17.0.2:43325, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:6141") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:53408->172.17.0.2:6141, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:3162") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:41544->172.17.0.2:3162, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:63872") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:46366->172.17.0.2:63872, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:59910") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:57100->172.17.0.2:59910, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:48634") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:54086->172.17.0.2:48634, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:21221") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:58986->172.17.0.2:21221, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:61560") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:47030->172.17.0.2:61560, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:55819") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:43882->172.17.0.2:55819, err= 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:26732") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:55560->172.17.0.2:26732, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/10/07 04:19:13 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/10/07 04:19:13 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/07 04:19:13 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:13 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:13 DEBUG : TestFTPProftpd: detected overridden config - adding "{PKytQ}" suffix to name 2025/10/07 04:19:13 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:13 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:13 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:13 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/10/07 04:19:13 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:52580->172.17.0.2:21, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:11900") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:36224->172.17.0.2:11900, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:37740") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:46190->172.17.0.2:37740, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:2759") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:60714->172.17.0.2:2759, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:55015") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:43470->172.17.0.2:55015, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:16001") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:55054->172.17.0.2:16001, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:10138") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:48656->172.17.0.2:10138, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:38433") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:49934->172.17.0.2:38433, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:32834") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:55090->172.17.0.2:32834, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:49899") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:39012->172.17.0.2:49899, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:23153") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:33802->172.17.0.2:23153, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:47517") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:37068->172.17.0.2:47517, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:10468") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:35288->172.17.0.2:10468, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:59456") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:53090->172.17.0.2:59456, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:21857") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:40854->172.17.0.2:21857, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:45880") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:44102->172.17.0.2:45880, 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/07 04:19:14 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hayemev4huxi/hello? sausage/êé" 2025/10/07 04:19:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/07 04:19:14 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:14 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{PKytQ}" suffix to name 2025/10/07 04:19:14 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:14 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: Connecting to FTP server 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:52584->172.17.0.2:21, err= 2025/10/07 04:19:14 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-hayemev4huxi/hello? sausage/êé" to be canonical "TestFTPProftpd{PKytQ}:rclone-test-hayemev4huxi/hello? sausage/êé" 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:22359") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:45868->172.17.0.2:22359, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:14135") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:38840->172.17.0.2:14135, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: Connecting to FTP server 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:52600->172.17.0.2:21, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:7876") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:43492->172.17.0.2:7876, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:19999") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:57286->172.17.0.2:19999, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:65140") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:38334->172.17.0.2:65140, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:53290") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:55920->172.17.0.2:53290, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:29009") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:33072->172.17.0.2:29009, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:26346") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:60624->172.17.0.2:26346, err= 2025/10/07 04:19:14 DEBUG : Waiting for deletions to finish 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:28326") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:39592->172.17.0.2:28326, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:50348") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:45522->172.17.0.2:50348, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:6369") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:47540->172.17.0.2:6369, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:64134") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:45422->172.17.0.2:64134, err= 2025/10/07 04:19:14 INFO : a/b/c/d/e.txt: Deleted 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:15973") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:38346->172.17.0.2:15973, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:57634") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:48214->172.17.0.2:57634, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:46272") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:59660->172.17.0.2:46272, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: dial("tcp","172.17.0.2:20565") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé: > dial: conn=172.17.0.1:38894->172.17.0.2:20565, err= 2025/10/07 04:19:14 DEBUG : removing 1 level 4 directories 2025/10/07 04:19:14 INFO : a/b/c/d: Removing directory 2025/10/07 04:19:14 DEBUG : removing 1 level 3 directories 2025/10/07 04:19:14 INFO : a/b/c: Removing directory 2025/10/07 04:19:14 DEBUG : removing 1 level 2 directories 2025/10/07 04:19:14 INFO : a/b: Removing directory 2025/10/07 04:19:14 DEBUG : removing 1 level 1 directories 2025/10/07 04:19:14 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:55382") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:42838->172.17.0.2:55382, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:48816") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:47134->172.17.0.2:48816, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:14344") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:58874->172.17.0.2:14344, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:5105") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:50818->172.17.0.2:5105, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:59440") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:52730->172.17.0.2:59440, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:18956") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:54126->172.17.0.2:18956, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: Connecting to FTP server 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:21") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:9153") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:48798->172.17.0.2:9153, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:52610->172.17.0.2:21, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:22679") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:51658->172.17.0.2:22679, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:37230") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:56346->172.17.0.2:37230, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:9534") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:58450->172.17.0.2:9534, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:24073") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:39968->172.17.0.2:24073, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:48069") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:41390->172.17.0.2:48069, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:11292") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:60248->172.17.0.2:11292, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:39639") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:56734->172.17.0.2:39639, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:35568") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:33636->172.17.0.2:35568, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:10527") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:55196->172.17.0.2:10527, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:18449") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:33138->172.17.0.2:18449, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:32245") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:54082->172.17.0.2:32245, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:29587") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:60628->172.17.0.2:29587, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:58902") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:56970->172.17.0.2:58902, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:55765") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:36046->172.17.0.2:55765, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:14068") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:51142->172.17.0.2:14068, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:14475") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:43058->172.17.0.2:14475, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/10/07 04:19:14 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-wefuyey4xuwu" 2025/10/07 04:19:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/07 04:19:14 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:14 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{PKytQ}" suffix to name 2025/10/07 04:19:14 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:14 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: Connecting to FTP server 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: dial("tcp","172.17.0.2:21") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: > dial: conn=172.17.0.1:52626->172.17.0.2:21, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:43673") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:37928->172.17.0.2:43673, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: dial("tcp","172.17.0.2:5022") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: > dial: conn=172.17.0.1:42140->172.17.0.2:5022, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: dial("tcp","172.17.0.2:29619") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: > dial: conn=172.17.0.1:58036->172.17.0.2:29619, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: dial("tcp","172.17.0.2:1862") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: > dial: conn=172.17.0.1:56284->172.17.0.2:1862, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: dial("tcp","172.17.0.2:22403") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: > dial: conn=172.17.0.1:58300->172.17.0.2:22403, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: dial("tcp","172.17.0.2:3075") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: > dial: conn=172.17.0.1:38188->172.17.0.2:3075, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: dial("tcp","172.17.0.2:58177") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: > dial: conn=172.17.0.1:47976->172.17.0.2:58177, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: dial("tcp","172.17.0.2:5710") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: > dial: conn=172.17.0.1:43260->172.17.0.2:5710, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:49187") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:33776->172.17.0.2:49187, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:56894") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:40066->172.17.0.2:56894, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:16963") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:47376->172.17.0.2:16963, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:21224") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:36004->172.17.0.2:21224, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:51191") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:59156->172.17.0.2:51191, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: dial("tcp","172.17.0.2:40628") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: > dial: conn=172.17.0.1:41234->172.17.0.2:40628, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: dial("tcp","172.17.0.2:57908") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: > dial: conn=172.17.0.1:33360->172.17.0.2:57908, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: dial("tcp","172.17.0.2:10834") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: > dial: conn=172.17.0.1:33832->172.17.0.2:10834, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: dial("tcp","172.17.0.2:47839") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: > dial: conn=172.17.0.1:45422->172.17.0.2:47839, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: Purge dir "new_name" 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-wefuyey4xuwu: 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/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:11328") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:41564->172.17.0.2:11328, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:23341") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:43920->172.17.0.2:23341, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:17840") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:48654->172.17.0.2:17840, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:50923") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:53916->172.17.0.2:50923, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:4860") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:51378->172.17.0.2:4860, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:6444") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:50296->172.17.0.2:6444, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:1658") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:36602->172.17.0.2:1658, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:60037") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:50630->172.17.0.2:60037, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:43853") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:56042->172.17.0.2:43853, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/10/07 04:19:14 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hayemev4huxi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/10/07 04:19:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/07 04:19:14 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:14 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{PKytQ}" suffix to name 2025/10/07 04:19:14 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:14 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:21") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:52638->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:19541") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:49262->172.17.0.2:19541, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/10/07 04:19:14 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hayemev4huxi/not found.txt" 2025/10/07 04:19:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/07 04:19:14 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:14 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{PKytQ}" suffix to name 2025/10/07 04:19:14 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:14 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/not found.txt: Connecting to FTP server 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/not found.txt: dial("tcp","172.17.0.2:21") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/not found.txt: > dial: conn=172.17.0.1:52646->172.17.0.2:21, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/not found.txt: dial("tcp","172.17.0.2:13177") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/not found.txt: > dial: conn=172.17.0.1:59150->172.17.0.2:13177, err= 2025/10/07 04:19:14 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-hayemev4huxi" from "TestFTPProftpd:rclone-test-hayemev4huxi" 2025/10/07 04:19:14 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/10/07 04:19:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/07 04:19:14 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:14 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{PKytQ}" suffix to name 2025/10/07 04:19:14 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:14 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:52662->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:27938") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:38158->172.17.0.2:27938, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:51178") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:32830->172.17.0.2:51178, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:48043") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:48594->172.17.0.2:48043, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:11652") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50552->172.17.0.2:11652, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:17144") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:45224->172.17.0.2:17144, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:57525") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:48044->172.17.0.2:57525, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:57520") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:49266->172.17.0.2:57520, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:16844") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:57570->172.17.0.2:16844, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:57917") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:52048->172.17.0.2:57917, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:32981") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:34002->172.17.0.2:32981, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:10559") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:45574->172.17.0.2:10559, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:20903") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:53498->172.17.0.2:20903, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:64505") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:60912->172.17.0.2:64505, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:58383") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:52796->172.17.0.2:58383, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:26209") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:44124->172.17.0.2:26209, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:15925") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:41224->172.17.0.2:15925, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:29782") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:38576->172.17.0.2:29782, 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/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:30558") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:59988->172.17.0.2:30558, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:33468") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:40776->172.17.0.2:33468, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:10160") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:53294->172.17.0.2:10160, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:44402") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:58972->172.17.0.2:44402, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:35073") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:52382->172.17.0.2:35073, 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/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:55277") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:52732->172.17.0.2:55277, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:1472") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:56512->172.17.0.2:1472, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/10/07 04:19:14 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-hayemev4huxi" 2025/10/07 04:19:14 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/07 04:19:14 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:14 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:14 DEBUG : TestFTPProftpd: detected overridden config - adding "{GeWsp}" suffix to name 2025/10/07 04:19:14 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:14 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:14 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:14 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: Connecting to FTP server 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:21") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:52670->172.17.0.2:21, err= 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:54053") 2025/10/07 04:19:14 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:60462->172.17.0.2:54053, 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/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:40906") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:49544->172.17.0.2:40906, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:29755") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:60776->172.17.0.2:29755, err= 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:15450") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:55668->172.17.0.2:15450, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/07 04:19:15 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-hayemev4huxi/deeper/nonexisting/directory" 2025/10/07 04:19:15 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/07 04:19:15 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:15 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:15 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:15 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:15 DEBUG : TestFTPProftpd: detected overridden config - adding "{PKytQ}" suffix to name 2025/10/07 04:19:15 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/07 04:19:15 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/07 04:19:15 DEBUG : Setting pass="EyN6-XVyWepJqlArMiRm2awH40aSKWm_pQCVO8AFDn71Ng" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/07 04:19:15 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/deeper/nonexisting/directory: Connecting to FTP server 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/deeper/nonexisting/directory: dial("tcp","172.17.0.2:21") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi/deeper/nonexisting/directory: > dial: conn=172.17.0.1:52672->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/10/07 04:19:15 DEBUG : Waiting for deletions to finish 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:29331") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:60268->172.17.0.2:29331, err= 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:53847") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:56354->172.17.0.2:53847, err= 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:60155") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:57966->172.17.0.2:60155, err= 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:59904") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:46350->172.17.0.2:59904, err= 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:18216") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:52914->172.17.0.2:18216, err= 2025/10/07 04:19:15 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:36283") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:40568->172.17.0.2:36283, err= 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:33090") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:37966->172.17.0.2:33090, err= 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:34192") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:52692->172.17.0.2:34192, err= 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:63547") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:47346->172.17.0.2:63547, err= 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:49751") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:42914->172.17.0.2:49751, err= 2025/10/07 04:19:15 DEBUG : removing 1 level 4 directories 2025/10/07 04:19:15 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/10/07 04:19:15 DEBUG : removing 1 level 3 directories 2025/10/07 04:19:15 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/10/07 04:19:15 DEBUG : removing 1 level 2 directories 2025/10/07 04:19:15 INFO : hello? sausage/êé: Removing directory 2025/10/07 04:19:15 DEBUG : removing 1 level 1 directories 2025/10/07 04:19:15 INFO : hello? sausage: Removing directory 2025/10/07 04:19:15 DEBUG : removing 1 level 0 directories 2025/10/07 04:19:15 INFO : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: Removing directory 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:19565") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:55652->172.17.0.2:19565, err= 2025/10/07 04:19:15 ERROR : error listing: directory not found 2025/10/07 04:19:15 DEBUG : Waiting for deletions to finish 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:34854") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:57214->172.17.0.2:34854, err= 2025/10/07 04:19:15 ERROR : error listing: directory not found 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: dial("tcp","172.17.0.2:47512") 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: > dial: conn=172.17.0.1:42380->172.17.0.2:47512, err= 2025/10/07 04:19:15 ERROR : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: Failed to list "": directory not found 2025/10/07 04:19:15 DEBUG : removing 1 level 0 directories 2025/10/07 04:19:15 INFO : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: Removing directory 2025/10/07 04:19:15 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/10/07 04:19:15 DEBUG : ftp://172.17.0.2:21/rclone-test-hayemev4huxi: closing 2 unused connections 2025/10/07 04:19:15 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (14.80s) --- 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.69s) --- 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.28s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.02s) --- 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.28s) --- 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.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.06s) --- 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.03s) --- 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.02s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.76s) --- 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.01s) --- 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 14.818s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 15.71604745s (try 1/5)