"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/10/18 04:30:49 NOTICE: TestFTPProftpd: Stopping server 2025/10/18 04:30:50 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 2/10 2025/10/18 04:30:50 NOTICE: TestFTPProftpd: Stopping server 2025/10/18 04:30:51 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 3/10 2025/10/18 04:30:52 NOTICE: TestFTPProftpd: Stopping server 2025/10/18 04:30:53 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 4/10 2025/10/18 04:30:53 NOTICE: TestFTPProftpd: Stopping server 2025/10/18 04:30:54 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 5/10 2025/10/18 04:30:54 NOTICE: TestFTPProftpd: Stopping server 2025/10/18 04:30:55 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 6/10 2025/10/18 04:30:55 NOTICE: TestFTPProftpd: Stopping server 2025/10/18 04:30:56 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 7/10 2025/10/18 04:30:56 NOTICE: TestFTPProftpd: Stopping server 2025/10/18 04:30:57 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 8/10 2025/10/18 04:30:57 NOTICE: TestFTPProftpd: Stopping server 2025/10/18 04:30:58 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 9/10 2025/10/18 04:30:58 NOTICE: TestFTPProftpd: Stopping server 2025/10/18 04:30:59 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 10/10 2025/10/18 04:30:59 NOTICE: TestFTPProftpd: Stopping server 2025/10/18 04:30:59 NOTICE: TestFTPProftpd: Starting server 2025/10/18 04:31:01 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.2:21" try 1/100 2025/10/18 04:31:01 DEBUG : TestFTPProftpd: Read 1, error: 2025/10/18 04:31:01 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.2:21" 2025/10/18 04:31:01 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-jaganot9bodu" 2025/10/18 04:31:01 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/18 04:31:01 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/18 04:31:01 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:01 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:01 DEBUG : TestFTPProftpd: detected overridden config - adding "{uKNHM}" suffix to name 2025/10/18 04:31:01 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:01 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: Connecting to FTP server 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:21") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:51282->172.17.0.2:21, err= 2025/10/18 04:31:01 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/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:1625") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:41084->172.17.0.2:1625, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:47481") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:42098->172.17.0.2:47481, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/10/18 04:31:01 INFO : dir/subdir: Making directory 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:18526") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:41128->172.17.0.2:18526, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:7469") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:37272->172.17.0.2:7469, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:25244") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:57860->172.17.0.2:25244, err= 2025/10/18 04:31:01 INFO : dir/subdir: Removing directory 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:12705") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:34122->172.17.0.2:12705, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:35649") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:57210->172.17.0.2:35649, err= 2025/10/18 04:31:01 INFO : dir: Removing directory 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:27847") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:44132->172.17.0.2:27847, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:13220") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:41044->172.17.0.2:13220, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:3275") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:51374->172.17.0.2:3275, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:36497") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:50432->172.17.0.2:36497, err= 2025/10/18 04:31:01 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:21281") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:36306->172.17.0.2:21281, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:51532") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:34486->172.17.0.2:51532, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:53701") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:37268->172.17.0.2:53701, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:28646") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:43250->172.17.0.2:28646, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:37610") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:56874->172.17.0.2:37610, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "." 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:40830") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:33718->172.17.0.2:40830, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:18290") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:37634->172.17.0.2:18290, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:22872") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:53782->172.17.0.2:22872, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:7555") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:57698->172.17.0.2:7555, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing ".." 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:11244") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:47666->172.17.0.2:11244, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:63005") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:39750->172.17.0.2:63005, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:56343") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:59128->172.17.0.2:56343, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:27335") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:42066->172.17.0.2:27335, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:35555") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:48940->172.17.0.2:35555, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:21321") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:60900->172.17.0.2:21321, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:64960") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:57998->172.17.0.2:64960, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:17385") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:46526->172.17.0.2:17385, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:54911") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:33198->172.17.0.2:54911, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:57716") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:39828->172.17.0.2:57716, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:33719") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:46884->172.17.0.2:33719, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:55512") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:38162->172.17.0.2:55512, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:39663") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:57572->172.17.0.2:39663, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:51221") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:56886->172.17.0.2:51221, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:61958") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:59694->172.17.0.2:61958, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:63884") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:58442->172.17.0.2:63884, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:62902") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:41964->172.17.0.2:62902, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:32072") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:58624->172.17.0.2:32072, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:26197") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:46260->172.17.0.2:26197, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:10588") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:42362->172.17.0.2:10588, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:34324") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:48624->172.17.0.2:34324, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:61670") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:34604->172.17.0.2:61670, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:30845") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:53434->172.17.0.2:30845, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:20322") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:58166->172.17.0.2:20322, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:49837") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:46052->172.17.0.2:49837, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:58468") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:41382->172.17.0.2:58468, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:56908") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:55072->172.17.0.2:56908, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:25132") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:40092->172.17.0.2:25132, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:11223") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:57848->172.17.0.2:11223, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:14246") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:42136->172.17.0.2:14246, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:31663") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:42974->172.17.0.2:31663, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:21444") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:56460->172.17.0.2:21444, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:11717") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:60512->172.17.0.2:11717, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:22472") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:39734->172.17.0.2:22472, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:47755") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:58662->172.17.0.2:47755, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:46248") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:33042->172.17.0.2:46248, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:42769") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:43930->172.17.0.2:42769, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:47181") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:34326->172.17.0.2:47181, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:62610") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:36806->172.17.0.2:62610, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:32146") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:53460->172.17.0.2:32146, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:39362") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:40344->172.17.0.2:39362, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:30794") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:56820->172.17.0.2:30794, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:22123") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:34346->172.17.0.2:22123, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:13491") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:59994->172.17.0.2:13491, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:16481") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:57076->172.17.0.2:16481, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:18547") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:52272->172.17.0.2:18547, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:11840") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:52292->172.17.0.2:11840, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:13849") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:58398->172.17.0.2:13849, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:49595") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:52366->172.17.0.2:49595, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:37013") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:46574->172.17.0.2:37013, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:23413") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:55296->172.17.0.2:23413, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:18385") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:57956->172.17.0.2:18385, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:33149") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:57940->172.17.0.2:33149, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:53235") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:43432->172.17.0.2:53235, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:37683") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:46690->172.17.0.2:37683, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:17451") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:41606->172.17.0.2:17451, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:46168") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:34168->172.17.0.2:46168, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:29057") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:34372->172.17.0.2:29057, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:41560") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:56176->172.17.0.2:41560, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:56368") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:47724->172.17.0.2:56368, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:42279") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:45736->172.17.0.2:42279, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:7689") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:55206->172.17.0.2:7689, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:12277") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:55626->172.17.0.2:12277, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:52973") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:52454->172.17.0.2:52973, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:29137") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:37898->172.17.0.2:29137, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:59009") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:47588->172.17.0.2:59009, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:33687") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:51530->172.17.0.2:33687, err= 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:6372") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:47878->172.17.0.2:6372, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:40655") 2025/10/18 04:31:01 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:54544->172.17.0.2:40655, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: Connecting to FTP server 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:21") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:51290->172.17.0.2:21, err= 2025/10/18 04:31:02 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:32020") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:34574->172.17.0.2:32020, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:45107") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:47210->172.17.0.2:45107, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:19930") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:40624->172.17.0.2:19930, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:60637") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:42108->172.17.0.2:60637, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:55765") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:43218->172.17.0.2:55765, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:46424") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:35694->172.17.0.2:46424, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:6732") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:42426->172.17.0.2:6732, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:55535") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:55188->172.17.0.2:55535, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:1508") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:58794->172.17.0.2:1508, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:40753") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:37694->172.17.0.2:40753, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:37895") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:41238->172.17.0.2:37895, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:15898") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:49036->172.17.0.2:15898, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:43901") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:46896->172.17.0.2:43901, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:64713") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:43576->172.17.0.2:64713, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:39095") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:53520->172.17.0.2:39095, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:11726") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:47936->172.17.0.2:11726, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:19405") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:57654->172.17.0.2:19405, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:52288") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:56582->172.17.0.2:52288, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:1409") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:43036->172.17.0.2:1409, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/10/18 04:31:02 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/10/18 04:31:02 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/18 04:31:02 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:02 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:02 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:02 DEBUG : TestFTPProftpd: detected overridden config - adding "{uKNHM}" suffix to name 2025/10/18 04:31:02 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:02 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:02 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:51296->172.17.0.2:21, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:14789") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:35454->172.17.0.2:14789, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:15797") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:55348->172.17.0.2:15797, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:15125") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:60394->172.17.0.2:15125, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:43121") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:35982->172.17.0.2:43121, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:28321") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:47796->172.17.0.2:28321, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:42200") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:57110->172.17.0.2:42200, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:42888") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:52438->172.17.0.2:42888, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:50019") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:56218->172.17.0.2:50019, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:7138") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:32888->172.17.0.2:7138, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:30723") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:60152->172.17.0.2:30723, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:53122") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:59154->172.17.0.2:53122, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:6733") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:44818->172.17.0.2:6733, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:2891") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:50630->172.17.0.2:2891, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:19607") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:33180->172.17.0.2:19607, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:50816") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:42608->172.17.0.2:50816, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1153: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1190: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/10/18 04:31:02 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-jaganot9bodu/hello? sausage/êé" 2025/10/18 04:31:02 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/18 04:31:02 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:02 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:02 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:02 DEBUG : TestFTPProftpd: detected overridden config - adding "{uKNHM}" suffix to name 2025/10/18 04:31:02 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:02 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:02 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: Connecting to FTP server 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:51310->172.17.0.2:21, err= 2025/10/18 04:31:02 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-jaganot9bodu/hello? sausage/êé" to be canonical "TestFTPProftpd{uKNHM}:rclone-test-jaganot9bodu/hello? sausage/êé" 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:37268") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:34364->172.17.0.2:37268, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:36141") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:51076->172.17.0.2:36141, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: Connecting to FTP server 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:51314->172.17.0.2:21, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:45317") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:59688->172.17.0.2:45317, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:3209") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:50600->172.17.0.2:3209, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:48651") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:38244->172.17.0.2:48651, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:60042") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:41168->172.17.0.2:60042, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:63367") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:50166->172.17.0.2:63367, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:11859") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:59446->172.17.0.2:11859, err= 2025/10/18 04:31:02 DEBUG : Waiting for deletions to finish 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:59688") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:49000->172.17.0.2:59688, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:49666") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:50280->172.17.0.2:49666, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:15204") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:47092->172.17.0.2:15204, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:58826") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:39818->172.17.0.2:58826, err= 2025/10/18 04:31:02 INFO : a/b/c/d/e.txt: Deleted 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:57881") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:36086->172.17.0.2:57881, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:51831") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:45896->172.17.0.2:51831, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:4542") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:41554->172.17.0.2:4542, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: dial("tcp","172.17.0.2:36786") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé: > dial: conn=172.17.0.1:43640->172.17.0.2:36786, err= 2025/10/18 04:31:02 DEBUG : removing 1 level 4 directories 2025/10/18 04:31:02 INFO : a/b/c/d: Removing directory 2025/10/18 04:31:02 DEBUG : removing 1 level 3 directories 2025/10/18 04:31:02 INFO : a/b/c: Removing directory 2025/10/18 04:31:02 DEBUG : removing 1 level 2 directories 2025/10/18 04:31:02 INFO : a/b: Removing directory 2025/10/18 04:31:02 DEBUG : removing 1 level 1 directories 2025/10/18 04:31:02 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:21798") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:51022->172.17.0.2:21798, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:14710") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:36854->172.17.0.2:14710, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:41047") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:49210->172.17.0.2:41047, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:2687") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:39628->172.17.0.2:2687, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:20419") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:57558->172.17.0.2:20419, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:31048") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:41618->172.17.0.2:31048, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: Connecting to FTP server 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:21") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:51318->172.17.0.2:21, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:3172") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:40674->172.17.0.2:3172, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:61521") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:56122->172.17.0.2:61521, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:60148") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:47928->172.17.0.2:60148, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:20300") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:53736->172.17.0.2:20300, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:3409") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:48478->172.17.0.2:3409, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:30056") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:44446->172.17.0.2:30056, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:18047") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:43302->172.17.0.2:18047, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:47215") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:40256->172.17.0.2:47215, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:38515") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:41790->172.17.0.2:38515, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:18838") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:42328->172.17.0.2:18838, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:2587") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:38692->172.17.0.2:2587, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:48947") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:34634->172.17.0.2:48947, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:56118") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:64701") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:44984->172.17.0.2:56118, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:33974->172.17.0.2:64701, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:49217") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:38424->172.17.0.2:49217, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:33534") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:35266->172.17.0.2:33534, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:20968") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:52270->172.17.0.2:20968, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/10/18 04:31:02 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-wuqugaw9dini" 2025/10/18 04:31:02 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/18 04:31:02 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:02 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:02 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:02 DEBUG : TestFTPProftpd: detected overridden config - adding "{uKNHM}" suffix to name 2025/10/18 04:31:02 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:02 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:02 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: Connecting to FTP server 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: dial("tcp","172.17.0.2:21") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: > dial: conn=172.17.0.1:51334->172.17.0.2:21, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:44810") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:53526->172.17.0.2:44810, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: dial("tcp","172.17.0.2:52152") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: > dial: conn=172.17.0.1:58636->172.17.0.2:52152, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: dial("tcp","172.17.0.2:64180") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: > dial: conn=172.17.0.1:54830->172.17.0.2:64180, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: dial("tcp","172.17.0.2:43002") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: > dial: conn=172.17.0.1:43328->172.17.0.2:43002, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: dial("tcp","172.17.0.2:49107") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: > dial: conn=172.17.0.1:42952->172.17.0.2:49107, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: dial("tcp","172.17.0.2:50488") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: > dial: conn=172.17.0.1:54126->172.17.0.2:50488, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: dial("tcp","172.17.0.2:34328") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: > dial: conn=172.17.0.1:57246->172.17.0.2:34328, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: dial("tcp","172.17.0.2:45951") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: > dial: conn=172.17.0.1:59914->172.17.0.2:45951, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:42872") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:34760->172.17.0.2:42872, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:33216") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:60086->172.17.0.2:33216, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:49603") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:60422->172.17.0.2:49603, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:57893") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:41086->172.17.0.2:57893, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:35741") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:46202->172.17.0.2:35741, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: dial("tcp","172.17.0.2:61407") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: > dial: conn=172.17.0.1:34192->172.17.0.2:61407, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: dial("tcp","172.17.0.2:59251") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: > dial: conn=172.17.0.1:53148->172.17.0.2:59251, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: dial("tcp","172.17.0.2:57114") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: > dial: conn=172.17.0.1:35304->172.17.0.2:57114, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: dial("tcp","172.17.0.2:14545") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: > dial: conn=172.17.0.1:50698->172.17.0.2:14545, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: Purge dir "new_name" 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-wuqugaw9dini: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:26773") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:45962->172.17.0.2:26773, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:9478") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:48622->172.17.0.2:9478, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:20358") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:53154->172.17.0.2:20358, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:56973") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:39848->172.17.0.2:56973, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:20517") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:34116->172.17.0.2:20517, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:27189") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:56128->172.17.0.2:27189, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:63039") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:47074->172.17.0.2:63039, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:33638") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:57602->172.17.0.2:33638, err= 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:4543") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:53570->172.17.0.2:4543, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/10/18 04:31:02 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-jaganot9bodu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/10/18 04:31:02 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/18 04:31:02 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:02 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:02 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:02 DEBUG : TestFTPProftpd: detected overridden config - adding "{uKNHM}" suffix to name 2025/10/18 04:31:02 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:02 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:02 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:21") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:51344->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:9950") 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:54040->172.17.0.2:9950, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/10/18 04:31:02 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-jaganot9bodu/not found.txt" 2025/10/18 04:31:02 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/18 04:31:02 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:02 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:02 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:02 DEBUG : TestFTPProftpd: detected overridden config - adding "{uKNHM}" suffix to name 2025/10/18 04:31:02 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:02 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:02 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:02 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/not found.txt: Connecting to FTP server 2025/10/18 04:31:02 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/not found.txt: dial("tcp","172.17.0.2:21") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/not found.txt: > dial: conn=172.17.0.1:51356->172.17.0.2:21, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/not found.txt: dial("tcp","172.17.0.2:38816") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/not found.txt: > dial: conn=172.17.0.1:47556->172.17.0.2:38816, err= 2025/10/18 04:31:03 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-jaganot9bodu" from "TestFTPProftpd:rclone-test-jaganot9bodu" 2025/10/18 04:31:03 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/10/18 04:31:03 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/18 04:31:03 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:03 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:03 DEBUG : TestFTPProftpd: detected overridden config - adding "{uKNHM}" suffix to name 2025/10/18 04:31:03 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:03 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:51372->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:12402") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:51892->172.17.0.2:12402, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:23452") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:58020->172.17.0.2:23452, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:63957") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:54830->172.17.0.2:63957, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:40698") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:43258->172.17.0.2:40698, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:20684") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:53582->172.17.0.2:20684, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21072") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:48032->172.17.0.2:21072, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:42309") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:46760->172.17.0.2:42309, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:7302") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:34384->172.17.0.2:7302, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:17114") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:49136->172.17.0.2:17114, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:2442") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:35762->172.17.0.2:2442, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:45180") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:42420->172.17.0.2:45180, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:59438") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:52302->172.17.0.2:59438, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:63100") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:38568->172.17.0.2:63100, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:12308") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:49132->172.17.0.2:12308, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:19446") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50190->172.17.0.2:19446, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:23015") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:41604->172.17.0.2:23015, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:19785") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:52584->172.17.0.2:19785, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2004: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2109: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:6522") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:47006->172.17.0.2:6522, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:47523") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:33366->172.17.0.2:47523, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:60355") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:54814->172.17.0.2:60355, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:39753") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:51728->172.17.0.2:39753, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:2935") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:37958->172.17.0.2:2935, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2281: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:14476") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:53312->172.17.0.2:14476, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:34243") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:39190->172.17.0.2:34243, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/10/18 04:31:03 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-jaganot9bodu" 2025/10/18 04:31:03 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/18 04:31:03 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:03 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:03 DEBUG : TestFTPProftpd: detected overridden config - adding "{Anejm}" suffix to name 2025/10/18 04:31:03 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:03 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: Connecting to FTP server 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:21") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:51380->172.17.0.2:21, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:4706") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:34258->172.17.0.2:4706, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2476: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:34649") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:39628->172.17.0.2:34649, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:15378") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:60722->172.17.0.2:15378, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:35111") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:52034->172.17.0.2:35111, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/18 04:31:03 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-jaganot9bodu/deeper/nonexisting/directory" 2025/10/18 04:31:03 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/18 04:31:03 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:03 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:03 DEBUG : TestFTPProftpd: detected overridden config - adding "{uKNHM}" suffix to name 2025/10/18 04:31:03 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/18 04:31:03 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/18 04:31:03 DEBUG : Setting pass="bSJc23aOzYQJ_6_n7H_rdlOt2zb8Nk-N2WZtbqrnBWz3Cw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/18 04:31:03 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/deeper/nonexisting/directory: Connecting to FTP server 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/deeper/nonexisting/directory: dial("tcp","172.17.0.2:21") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu/deeper/nonexisting/directory: > dial: conn=172.17.0.1:51392->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/10/18 04:31:03 DEBUG : Waiting for deletions to finish 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:56698") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:56944->172.17.0.2:56698, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:45462") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:34064->172.17.0.2:45462, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:20434") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:37756->172.17.0.2:20434, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:36110") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:35262->172.17.0.2:36110, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:31913") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:51260->172.17.0.2:31913, err= 2025/10/18 04:31:03 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:53695") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:54634->172.17.0.2:53695, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:27460") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:48024->172.17.0.2:27460, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:30744") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:45554->172.17.0.2:30744, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:47204") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:57912->172.17.0.2:47204, err= 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:56885") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:45028->172.17.0.2:56885, err= 2025/10/18 04:31:03 DEBUG : removing 1 level 4 directories 2025/10/18 04:31:03 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/10/18 04:31:03 DEBUG : removing 1 level 3 directories 2025/10/18 04:31:03 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/10/18 04:31:03 DEBUG : removing 1 level 2 directories 2025/10/18 04:31:03 INFO : hello? sausage/êé: Removing directory 2025/10/18 04:31:03 DEBUG : removing 1 level 1 directories 2025/10/18 04:31:03 INFO : hello? sausage: Removing directory 2025/10/18 04:31:03 DEBUG : removing 1 level 0 directories 2025/10/18 04:31:03 INFO : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: Removing directory 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:2870") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:38446->172.17.0.2:2870, err= 2025/10/18 04:31:03 ERROR : error listing: directory not found 2025/10/18 04:31:03 DEBUG : Waiting for deletions to finish 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:64138") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:40950->172.17.0.2:64138, err= 2025/10/18 04:31:03 ERROR : error listing: directory not found 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: dial("tcp","172.17.0.2:6256") 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: > dial: conn=172.17.0.1:59312->172.17.0.2:6256, err= 2025/10/18 04:31:03 ERROR : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: Failed to list "": directory not found 2025/10/18 04:31:03 DEBUG : removing 1 level 0 directories 2025/10/18 04:31:03 INFO : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: Removing directory 2025/10/18 04:31:03 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/10/18 04:31:03 DEBUG : ftp://172.17.0.2:21/rclone-test-jaganot9bodu: closing 2 unused connections 2025/10/18 04:31:04 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (14.96s) --- 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.60s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.03s) --- 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.25s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.03s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.24s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 14.974s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 15.834630307s (try 1/5)