"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/10/17 05:14:47 NOTICE: TestFTPProftpd: Stopping server 2025/10/17 05:14:48 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 2/10 2025/10/17 05:14:48 NOTICE: TestFTPProftpd: Stopping server 2025/10/17 05:14:49 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 3/10 2025/10/17 05:14:49 NOTICE: TestFTPProftpd: Stopping server 2025/10/17 05:14:50 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 4/10 2025/10/17 05:14:50 NOTICE: TestFTPProftpd: Stopping server 2025/10/17 05:14:51 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 5/10 2025/10/17 05:14:51 NOTICE: TestFTPProftpd: Stopping server 2025/10/17 05:14:52 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 6/10 2025/10/17 05:14:52 NOTICE: TestFTPProftpd: Stopping server 2025/10/17 05:14:53 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 7/10 2025/10/17 05:14:53 NOTICE: TestFTPProftpd: Stopping server 2025/10/17 05:14:54 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 8/10 2025/10/17 05:14:54 NOTICE: TestFTPProftpd: Stopping server 2025/10/17 05:14:55 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 9/10 2025/10/17 05:14:56 NOTICE: TestFTPProftpd: Stopping server 2025/10/17 05:14:57 NOTICE: TestFTPProftpd: Attempting to stop TestFTPProftpd try 10/10 2025/10/17 05:14:57 NOTICE: TestFTPProftpd: Stopping server 2025/10/17 05:14:57 NOTICE: TestFTPProftpd: Starting server 2025/10/17 05:14:58 NOTICE: TestFTPProftpd: Attempting to connect to "172.17.0.2:21" try 1/100 2025/10/17 05:14:58 DEBUG : TestFTPProftpd: Read 1, error: 2025/10/17 05:14:58 NOTICE: TestFTPProftpd: Started server and connected to "172.17.0.2:21" 2025/10/17 05:14:58 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-nakulaj9camo" 2025/10/17 05:14:58 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/17 05:14:58 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/17 05:14:58 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:14:58 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:14:58 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:14:58 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:14:58 DEBUG : TestFTPProftpd: detected overridden config - adding "{ND10h}" suffix to name 2025/10/17 05:14:58 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:14:58 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:14:58 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:14:58 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: Connecting to FTP server 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:21") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:35672->172.17.0.2:21, err= 2025/10/17 05:14:58 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/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:10958") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:53420->172.17.0.2:10958, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:54835") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:51718->172.17.0.2:54835, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/10/17 05:14:58 INFO : dir/subdir: Making directory 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:7298") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:56554->172.17.0.2:7298, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:7961") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:35874->172.17.0.2:7961, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:63510") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:42340->172.17.0.2:63510, err= 2025/10/17 05:14:58 INFO : dir/subdir: Removing directory 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:14178") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:41298->172.17.0.2:14178, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:29082") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:45262->172.17.0.2:29082, err= 2025/10/17 05:14:58 INFO : dir: Removing directory 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:23459") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:46672->172.17.0.2:23459, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:36371") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:33790->172.17.0.2:36371, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:15577") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:59686->172.17.0.2:15577, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:24740") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:60168->172.17.0.2:24740, err= 2025/10/17 05:14:58 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:54804") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:57270->172.17.0.2:54804, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:64256") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:40728->172.17.0.2:64256, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:57301") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:49562->172.17.0.2:57301, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:38127") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:59886->172.17.0.2:38127, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:46992") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:59712->172.17.0.2:46992, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:33050") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:57548->172.17.0.2:33050, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:40642") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:43312->172.17.0.2:40642, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:43325") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:55944->172.17.0.2:43325, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:48293") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:33528->172.17.0.2:48293, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:6735") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:44840->172.17.0.2:6735, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:13102") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:53686->172.17.0.2:13102, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:43719") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:36192->172.17.0.2:43719, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:8213") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:58520->172.17.0.2:8213, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:51706") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:40124->172.17.0.2:51706, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:12932") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:37944->172.17.0.2:12932, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:22335") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:34998->172.17.0.2:22335, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:2671") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:59238->172.17.0.2:2671, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:43124") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:43288->172.17.0.2:43124, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:27206") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:46656->172.17.0.2:27206, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:35546") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:34470->172.17.0.2:35546, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:53058") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:45730->172.17.0.2:53058, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:16507") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:57722->172.17.0.2:16507, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:41821") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:53322->172.17.0.2:41821, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:59996") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:41214->172.17.0.2:59996, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:14482") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:57974->172.17.0.2:14482, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:54975") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:47264->172.17.0.2:54975, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:23543") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:35782->172.17.0.2:23543, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:36917") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:48230->172.17.0.2:36917, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:25812") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:41830->172.17.0.2:25812, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:38097") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:53018->172.17.0.2:38097, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:60634") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:34234->172.17.0.2:60634, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:15081") 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:58888->172.17.0.2:15081, err= 2025/10/17 05:14:58 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:36819") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:35632->172.17.0.2:36819, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:52401") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:48024->172.17.0.2:52401, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:52185") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:39088->172.17.0.2:52185, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:18277") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:45960->172.17.0.2:18277, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:19917") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:48522->172.17.0.2:19917, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:27292") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:57684->172.17.0.2:27292, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:60578") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:41798->172.17.0.2:60578, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:2675") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:54902->172.17.0.2:2675, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:33003") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:36706->172.17.0.2:33003, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:8145") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:39158->172.17.0.2:8145, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:45371") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:50756->172.17.0.2:45371, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:40193") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:54200->172.17.0.2:40193, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:58828") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:45364->172.17.0.2:58828, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:57279") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:60792->172.17.0.2:57279, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:61504") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:54382->172.17.0.2:61504, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:60475") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:52586->172.17.0.2:60475, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:34869") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:48720->172.17.0.2:34869, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:23176") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:34566->172.17.0.2:23176, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:30487") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:38660->172.17.0.2:30487, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:22393") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:37056->172.17.0.2:22393, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:38659") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:34382->172.17.0.2:38659, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:6773") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:34502->172.17.0.2:6773, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:16854") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:60466->172.17.0.2:16854, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:52117") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:60714->172.17.0.2:52117, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:60725") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:43898->172.17.0.2:60725, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:39374") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:41988->172.17.0.2:39374, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:23500") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:36970->172.17.0.2:23500, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:21002") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:43536->172.17.0.2:21002, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:11936") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:40730->172.17.0.2:11936, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:18600") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:44426->172.17.0.2:18600, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:35060") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:58954->172.17.0.2:35060, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:47731") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:43860->172.17.0.2:47731, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:5466") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:57924->172.17.0.2:5466, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:21711") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:60762->172.17.0.2:21711, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:64984") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:60944->172.17.0.2:64984, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:24359") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:39772->172.17.0.2:24359, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:47980") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:59962->172.17.0.2:47980, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:60028") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:38588->172.17.0.2:60028, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:26010") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:46746->172.17.0.2:26010, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:15449") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:34180->172.17.0.2:15449, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:2639") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:36574->172.17.0.2:2639, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:5847") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:43934->172.17.0.2:5847, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:54619") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:60692->172.17.0.2:54619, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:60443") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:51674->172.17.0.2:60443, err= 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:62102") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:36290->172.17.0.2:62102, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:50589") 2025/10/17 05:14:59 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:53522->172.17.0.2:50589, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: Connecting to FTP server 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:21") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:35678->172.17.0.2:21, err= 2025/10/17 05:15:00 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:17345") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:37378->172.17.0.2:17345, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:23726") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:34472->172.17.0.2:23726, 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/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:37218") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:46200->172.17.0.2:37218, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:10675") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:48438->172.17.0.2:10675, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:17553") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:49916->172.17.0.2:17553, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:3533") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:37348->172.17.0.2:3533, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:60606") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:34452->172.17.0.2:60606, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:43238") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:39616->172.17.0.2:43238, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:17981") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:51258->172.17.0.2:17981, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:43377") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:36238->172.17.0.2:43377, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:55275") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:36634->172.17.0.2:55275, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:4762") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:32884->172.17.0.2:4762, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:43372") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:52168->172.17.0.2:43372, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:3567") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:46010->172.17.0.2:3567, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:49394") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:49204->172.17.0.2:49394, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:57411") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:53812->172.17.0.2:57411, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:36005") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:36666->172.17.0.2:36005, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:8240") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:48164->172.17.0.2:8240, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:6520") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:46534->172.17.0.2:6520, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/10/17 05:15:00 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/10/17 05:15:00 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/17 05:15:00 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:00 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:00 DEBUG : TestFTPProftpd: detected overridden config - adding "{ND10h}" suffix to name 2025/10/17 05:15:00 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:00 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:35686->172.17.0.2:21, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:58333") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:44186->172.17.0.2:58333, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:56071") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:50006->172.17.0.2:56071, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:22200") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:36542->172.17.0.2:22200, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:32643") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:57254->172.17.0.2:32643, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:44564") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:59128->172.17.0.2:44564, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:2339") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:58226->172.17.0.2:2339, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:14575") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:34672->172.17.0.2:14575, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:47196") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:54040->172.17.0.2:47196, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:57400") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:35432->172.17.0.2:57400, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:53021") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:48800->172.17.0.2:53021, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:15384") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:36730->172.17.0.2:15384, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:62723") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:34970->172.17.0.2:62723, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:7805") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:40572->172.17.0.2:7805, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:31705") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:41414->172.17.0.2:31705, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:20915") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:36642->172.17.0.2:20915, 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/17 05:15:00 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-nakulaj9camo/hello? sausage/êé" 2025/10/17 05:15:00 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/17 05:15:00 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:00 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:00 DEBUG : TestFTPProftpd: detected overridden config - adding "{ND10h}" suffix to name 2025/10/17 05:15:00 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:00 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: Connecting to FTP server 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:35702->172.17.0.2:21, err= 2025/10/17 05:15:00 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-nakulaj9camo/hello? sausage/êé" to be canonical "TestFTPProftpd{ND10h}:rclone-test-nakulaj9camo/hello? sausage/êé" 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:53361") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:40454->172.17.0.2:53361, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:9989") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:51950->172.17.0.2:9989, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: Connecting to FTP server 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:21") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:35710->172.17.0.2:21, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:35243") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:52652->172.17.0.2:35243, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:41187") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:46312->172.17.0.2:41187, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:46359") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:45568->172.17.0.2:46359, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:43227") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:58592->172.17.0.2:43227, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:29402") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:39168->172.17.0.2:29402, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:7008") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:45254->172.17.0.2:7008, err= 2025/10/17 05:15:00 DEBUG : Waiting for deletions to finish 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:21100") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:54402->172.17.0.2:21100, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:53691") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:56334->172.17.0.2:53691, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:60485") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:44832->172.17.0.2:60485, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:36728") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:53136->172.17.0.2:36728, err= 2025/10/17 05:15:00 INFO : a/b/c/d/e.txt: Deleted 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:7681") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:50094->172.17.0.2:7681, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:30244") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:41304->172.17.0.2:30244, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:60691") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:53692->172.17.0.2:60691, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: dial("tcp","172.17.0.2:45335") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé: > dial: conn=172.17.0.1:43930->172.17.0.2:45335, err= 2025/10/17 05:15:00 DEBUG : removing 1 level 4 directories 2025/10/17 05:15:00 INFO : a/b/c/d: Removing directory 2025/10/17 05:15:00 DEBUG : removing 1 level 3 directories 2025/10/17 05:15:00 INFO : a/b/c: Removing directory 2025/10/17 05:15:00 DEBUG : removing 1 level 2 directories 2025/10/17 05:15:00 INFO : a/b: Removing directory 2025/10/17 05:15:00 DEBUG : removing 1 level 1 directories 2025/10/17 05:15:00 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:44000") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:44022->172.17.0.2:44000, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:41357") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:46376->172.17.0.2:41357, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:37444") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:57680->172.17.0.2:37444, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:46510") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:36610->172.17.0.2:46510, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:36429") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:53666->172.17.0.2:36429, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:15148") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:38260->172.17.0.2:15148, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: Connecting to FTP server 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:21") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:63467") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:35724->172.17.0.2:21, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:45824->172.17.0.2:63467, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:60322") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:33158->172.17.0.2:60322, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:14271") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:39216->172.17.0.2:14271, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:65031") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:56168->172.17.0.2:65031, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:4889") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:34748->172.17.0.2:4889, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:6911") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:53280->172.17.0.2:6911, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:2695") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:45828->172.17.0.2:2695, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:42405") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:40238->172.17.0.2:42405, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:56620") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:36110->172.17.0.2:56620, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:17807") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:49800->172.17.0.2:17807, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:7432") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:45726->172.17.0.2:7432, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:17580") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:43046->172.17.0.2:17580, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:63568") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:45174->172.17.0.2:63568, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:51065") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:50026->172.17.0.2:51065, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:22488") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:48238->172.17.0.2:22488, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:48497") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:55418->172.17.0.2:48497, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:16689") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:47478->172.17.0.2:16689, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/10/17 05:15:00 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-humasoc0razo" 2025/10/17 05:15:00 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/17 05:15:00 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:00 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:00 DEBUG : TestFTPProftpd: detected overridden config - adding "{ND10h}" suffix to name 2025/10/17 05:15:00 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:00 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: Connecting to FTP server 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: dial("tcp","172.17.0.2:21") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: > dial: conn=172.17.0.1:35726->172.17.0.2:21, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:42414") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:56034->172.17.0.2:42414, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: dial("tcp","172.17.0.2:47438") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: > dial: conn=172.17.0.1:49654->172.17.0.2:47438, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: dial("tcp","172.17.0.2:50900") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: > dial: conn=172.17.0.1:51412->172.17.0.2:50900, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: dial("tcp","172.17.0.2:58299") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: > dial: conn=172.17.0.1:57372->172.17.0.2:58299, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: dial("tcp","172.17.0.2:35919") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: > dial: conn=172.17.0.1:50182->172.17.0.2:35919, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: dial("tcp","172.17.0.2:35293") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: > dial: conn=172.17.0.1:40914->172.17.0.2:35293, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: dial("tcp","172.17.0.2:45564") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: > dial: conn=172.17.0.1:44102->172.17.0.2:45564, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: dial("tcp","172.17.0.2:22691") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: > dial: conn=172.17.0.1:52384->172.17.0.2:22691, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:34738") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:42916->172.17.0.2:34738, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:58282") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:54210->172.17.0.2:58282, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:41367") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:45464->172.17.0.2:41367, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:53993") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:57288->172.17.0.2:53993, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:61341") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:56938->172.17.0.2:61341, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: dial("tcp","172.17.0.2:18757") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: > dial: conn=172.17.0.1:46042->172.17.0.2:18757, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: dial("tcp","172.17.0.2:30815") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: > dial: conn=172.17.0.1:48868->172.17.0.2:30815, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: dial("tcp","172.17.0.2:45734") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: > dial: conn=172.17.0.1:45698->172.17.0.2:45734, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: dial("tcp","172.17.0.2:12149") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: > dial: conn=172.17.0.1:47666->172.17.0.2:12149, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: Purge dir "new_name" 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-humasoc0razo: 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/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:32950") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:38168->172.17.0.2:32950, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:14947") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:55342->172.17.0.2:14947, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:21101") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:45602->172.17.0.2:21101, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:60273") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:37650->172.17.0.2:60273, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:11980") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:33632->172.17.0.2:11980, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:7736") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:39230->172.17.0.2:7736, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:27001") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:53844->172.17.0.2:27001, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:53008") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:59804->172.17.0.2:53008, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:18777") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:42962->172.17.0.2:18777, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/10/17 05:15:00 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-nakulaj9camo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/10/17 05:15:00 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/17 05:15:00 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:00 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:00 DEBUG : TestFTPProftpd: detected overridden config - adding "{ND10h}" suffix to name 2025/10/17 05:15:00 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:00 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:21") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:35732->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.2:41601") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:59144->172.17.0.2:41601, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/10/17 05:15:00 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-nakulaj9camo/not found.txt" 2025/10/17 05:15:00 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/17 05:15:00 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:00 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:00 DEBUG : TestFTPProftpd: detected overridden config - adding "{ND10h}" suffix to name 2025/10/17 05:15:00 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:00 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/not found.txt: Connecting to FTP server 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/not found.txt: dial("tcp","172.17.0.2:21") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/not found.txt: > dial: conn=172.17.0.1:35738->172.17.0.2:21, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/not found.txt: dial("tcp","172.17.0.2:36226") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/not found.txt: > dial: conn=172.17.0.1:41870->172.17.0.2:36226, err= 2025/10/17 05:15:00 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-nakulaj9camo" from "TestFTPProftpd:rclone-test-nakulaj9camo" 2025/10/17 05:15:00 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/10/17 05:15:00 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/17 05:15:00 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:00 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:00 DEBUG : TestFTPProftpd: detected overridden config - adding "{ND10h}" suffix to name 2025/10/17 05:15:00 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:00 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: Connecting to FTP server 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:35748->172.17.0.2:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:20535") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:36700->172.17.0.2:20535, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:2085") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:50630->172.17.0.2:2085, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:11002") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:59596->172.17.0.2:11002, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:57928") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:38630->172.17.0.2:57928, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:59671") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:58930->172.17.0.2:59671, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:51974") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:33700->172.17.0.2:51974, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:56433") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:56644->172.17.0.2:56433, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:65372") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:59398->172.17.0.2:65372, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:31505") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:58528->172.17.0.2:31505, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:46409") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:43512->172.17.0.2:46409, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:33150") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:57092->172.17.0.2:33150, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:32345") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:46786->172.17.0.2:32345, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:25318") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:53764->172.17.0.2:25318, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:60371") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:38666->172.17.0.2:60371, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:21315") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:49574->172.17.0.2:21315, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:26976") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:41524->172.17.0.2:26976, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: dial("tcp","172.17.0.2:61787") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21: > dial: conn=172.17.0.1:44258->172.17.0.2:61787, 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/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:16262") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:55682->172.17.0.2:16262, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:56315") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:39846->172.17.0.2:56315, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:34653") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:43376->172.17.0.2:34653, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:35438") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:48788->172.17.0.2:35438, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:58152") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:59200->172.17.0.2:58152, 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/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:8128") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:59184->172.17.0.2:8128, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:20447") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:47698->172.17.0.2:20447, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/10/17 05:15:00 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-nakulaj9camo" 2025/10/17 05:15:00 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/17 05:15:00 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:00 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:00 DEBUG : TestFTPProftpd: detected overridden config - adding "{plKLv}" suffix to name 2025/10/17 05:15:00 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:00 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:00 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:00 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: Connecting to FTP server 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:21") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:35756->172.17.0.2:21, err= 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:19410") 2025/10/17 05:15:00 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:47114->172.17.0.2:19410, 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/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:22139") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:58954->172.17.0.2:22139, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:8001") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:52094->172.17.0.2:8001, err= 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:8056") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:59120->172.17.0.2:8056, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/17 05:15:01 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-nakulaj9camo/deeper/nonexisting/directory" 2025/10/17 05:15:01 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/10/17 05:15:01 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:01 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:01 DEBUG : TestFTPProftpd: detected overridden config - adding "{ND10h}" suffix to name 2025/10/17 05:15:01 DEBUG : Setting host="172.17.0.2" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/10/17 05:15:01 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/10/17 05:15:01 DEBUG : Setting pass="Pn1LTuWMfpFedWiI85iLa4SfJszjNgxdQHDgZC6cIOn5Hw" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/10/17 05:15:01 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/deeper/nonexisting/directory: Connecting to FTP server 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/deeper/nonexisting/directory: dial("tcp","172.17.0.2:21") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo/deeper/nonexisting/directory: > dial: conn=172.17.0.1:35760->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/17 05:15:01 DEBUG : Waiting for deletions to finish 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:5316") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:59546->172.17.0.2:5316, err= 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:2742") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:47008->172.17.0.2:2742, err= 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:28921") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:46842->172.17.0.2:28921, err= 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:16884") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:47508->172.17.0.2:16884, err= 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:38683") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:37404->172.17.0.2:38683, err= 2025/10/17 05:15:01 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:44660") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:56360->172.17.0.2:44660, err= 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:25207") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:45176->172.17.0.2:25207, err= 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:43287") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:35818->172.17.0.2:43287, err= 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:7387") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:38548->172.17.0.2:7387, err= 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:30142") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:43098->172.17.0.2:30142, err= 2025/10/17 05:15:01 DEBUG : removing 1 level 4 directories 2025/10/17 05:15:01 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/10/17 05:15:01 DEBUG : removing 1 level 3 directories 2025/10/17 05:15:01 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/10/17 05:15:01 DEBUG : removing 1 level 2 directories 2025/10/17 05:15:01 INFO : hello? sausage/êé: Removing directory 2025/10/17 05:15:01 DEBUG : removing 1 level 1 directories 2025/10/17 05:15:01 INFO : hello? sausage: Removing directory 2025/10/17 05:15:01 DEBUG : removing 1 level 0 directories 2025/10/17 05:15:01 INFO : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: Removing directory 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:14604") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:53114->172.17.0.2:14604, err= 2025/10/17 05:15:01 ERROR : error listing: directory not found 2025/10/17 05:15:01 DEBUG : Waiting for deletions to finish 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:14506") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:56740->172.17.0.2:14506, err= 2025/10/17 05:15:01 ERROR : error listing: directory not found 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: dial("tcp","172.17.0.2:58317") 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: > dial: conn=172.17.0.1:43708->172.17.0.2:58317, err= 2025/10/17 05:15:01 ERROR : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: Failed to list "": directory not found 2025/10/17 05:15:01 DEBUG : removing 1 level 0 directories 2025/10/17 05:15:01 INFO : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: Removing directory 2025/10/17 05:15:01 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/10/17 05:15:01 DEBUG : ftp://172.17.0.2:21/rclone-test-nakulaj9camo: closing 2 unused connections 2025/10/17 05:15:01 NOTICE: TestFTPProftpd: Stopping server --- PASS: TestIntegration (14.79s) --- 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.51s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.02s) --- 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.18s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.05s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.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.01s) --- 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.800s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 15.653390945s (try 1/5)