"go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPProftpd:" 2025/07/20 01:59:28 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-lubopac1peze" 2025/07/20 01:59:28 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/20 01:59:28 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/20 01:59:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:28 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:28 DEBUG : TestFTPProftpd: detected overridden config - adding "{6gE5C}" suffix to name 2025/07/20 01:59:28 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:28 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:28 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:28 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: Connecting to FTP server 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:21") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:48462->172.17.0.3:21, err= 2025/07/20 01:59:28 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/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:57151") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:54932->172.17.0.3:57151, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:39860") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:35552->172.17.0.3:39860, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/07/20 01:59:28 INFO : dir/subdir: Making directory 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:37069") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:39848->172.17.0.3:37069, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:3565") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:58352->172.17.0.3:3565, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:40286") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:42526->172.17.0.3:40286, err= 2025/07/20 01:59:28 INFO : dir/subdir: Removing directory 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:22964") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:48820->172.17.0.3:22964, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:7459") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:50472->172.17.0.3:7459, err= 2025/07/20 01:59:28 INFO : dir: Removing directory 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:51753") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:37380->172.17.0.3:51753, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:19691") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:54068->172.17.0.3:19691, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:37454") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:40436->172.17.0.3:37454, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:6855") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:42868->172.17.0.3:6855, err= 2025/07/20 01:59:28 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/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:44321") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:39852->172.17.0.3:44321, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:62452") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:38284->172.17.0.3:62452, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:12220") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:53954->172.17.0.3:12220, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:57484") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:42212->172.17.0.3:57484, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:5287") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:58016->172.17.0.3:5287, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:54231") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:35520->172.17.0.3:54231, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:49215") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:52236->172.17.0.3:49215, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:1457") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:54420->172.17.0.3:1457, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:56704") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:38192->172.17.0.3:56704, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:29067") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:39382->172.17.0.3:29067, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:48261") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:45856->172.17.0.3:48261, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:43943") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:41370->172.17.0.3:43943, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:21516") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:37436->172.17.0.3:21516, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:12904") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:51944->172.17.0.3:12904, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:52566") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:35332->172.17.0.3:52566, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:1377") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:38712->172.17.0.3:1377, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:50174") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:33434->172.17.0.3:50174, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:51541") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:43878->172.17.0.3:51541, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:21804") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:43926->172.17.0.3:21804, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:23620") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:42368->172.17.0.3:23620, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:43158") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:54736->172.17.0.3:43158, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:60641") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:39602->172.17.0.3:60641, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:59665") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:35650->172.17.0.3:59665, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:45699") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:50126->172.17.0.3:45699, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:35392") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:43510->172.17.0.3:35392, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:17095") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:47696->172.17.0.3:17095, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:52135") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:36786->172.17.0.3:52135, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:21610") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:49008->172.17.0.3:21610, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:35762") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:60902->172.17.0.3:35762, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:24054") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:43298->172.17.0.3:24054, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:27441") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:47022->172.17.0.3:27441, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:14548") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:35424->172.17.0.3:14548, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:20972") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:47126->172.17.0.3:20972, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:38638") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:55256->172.17.0.3:38638, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:6497") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:41476->172.17.0.3:6497, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:25235") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:49640->172.17.0.3:25235, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:27335") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:51808->172.17.0.3:27335, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:54689") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:49144->172.17.0.3:54689, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:25669") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:44450->172.17.0.3:25669, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:18505") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:40426->172.17.0.3:18505, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:18221") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:53958->172.17.0.3:18221, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:8396") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:46960->172.17.0.3:8396, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:61424") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:56578->172.17.0.3:61424, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:38714") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:49760->172.17.0.3:38714, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:20277") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:44852->172.17.0.3:20277, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:48456") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:33376->172.17.0.3:48456, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:39067") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:58198->172.17.0.3:39067, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:4916") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:46908->172.17.0.3:4916, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:34462") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:51506->172.17.0.3:34462, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:59847") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:51504->172.17.0.3:59847, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:27512") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:53130->172.17.0.3:27512, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:12085") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:43426->172.17.0.3:12085, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:54954") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:60180->172.17.0.3:54954, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:21643") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:54598->172.17.0.3:21643, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:56761") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:44020->172.17.0.3:56761, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:24811") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:35242->172.17.0.3:24811, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:37714") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:34442->172.17.0.3:37714, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:43361") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:55192->172.17.0.3:43361, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:45398") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:38982->172.17.0.3:45398, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:7942") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:47388->172.17.0.3:7942, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:1880") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:42082->172.17.0.3:1880, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:7305") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:33014->172.17.0.3:7305, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:21467") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:58936->172.17.0.3:21467, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:21829") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:44588->172.17.0.3:21829, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:44920") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:40074->172.17.0.3:44920, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:26940") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:60704->172.17.0.3:26940, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:46041") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:59452->172.17.0.3:46041, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:6720") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:57748->172.17.0.3:6720, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:16095") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:36678->172.17.0.3:16095, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:6176") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:36006->172.17.0.3:6176, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:24201") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:35808->172.17.0.3:24201, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:33293") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:60430->172.17.0.3:33293, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:13548") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:37854->172.17.0.3:13548, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:20091") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:53794->172.17.0.3:20091, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:6472") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:59248->172.17.0.3:6472, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:32801") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:52294->172.17.0.3:32801, err= 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:3012") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:56182->172.17.0.3:3012, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:44515") 2025/07/20 01:59:28 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:45550->172.17.0.3:44515, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: Connecting to FTP server 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:21") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:48474->172.17.0.3:21, err= 2025/07/20 01:59:29 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:62439") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:53776->172.17.0.3:62439, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:42647") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:60140->172.17.0.3:42647, 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/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:53416") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:47892->172.17.0.3:53416, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:45997") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:38228->172.17.0.3:45997, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:18837") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:58750->172.17.0.3:18837, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:54910") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:56386->172.17.0.3:54910, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:54922") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:48938->172.17.0.3:54922, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:17848") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:56594->172.17.0.3:17848, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:11932") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:48556->172.17.0.3:11932, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:3931") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:46588->172.17.0.3:3931, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:43996") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:32834->172.17.0.3:43996, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:55916") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:42146->172.17.0.3:55916, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:56864") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:37428->172.17.0.3:56864, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:48018") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:38204->172.17.0.3:48018, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:42808") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:33984->172.17.0.3:42808, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:27014") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:40510->172.17.0.3:27014, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:40703") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:36878->172.17.0.3:40703, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:27823") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:49924->172.17.0.3:27823, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:7995") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:46856->172.17.0.3:7995, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/07/20 01:59:29 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/07/20 01:59:29 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/20 01:59:29 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:29 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{6gE5C}" suffix to name 2025/07/20 01:59:29 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:29 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:48478->172.17.0.3:21, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:52769") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:54480->172.17.0.3:52769, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:44648") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:54420->172.17.0.3:44648, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:61216") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:52516->172.17.0.3:61216, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:22367") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:45384->172.17.0.3:22367, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:43971") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:37536->172.17.0.3:43971, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:10524") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:53018->172.17.0.3:10524, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:63945") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:52696->172.17.0.3:63945, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:51304") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:59792->172.17.0.3:51304, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:24683") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:57644->172.17.0.3:24683, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:1597") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:50944->172.17.0.3:1597, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:49582") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:52298->172.17.0.3:49582, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:29145") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:53602->172.17.0.3:29145, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:56947") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:43036->172.17.0.3:56947, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:46487") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:57922->172.17.0.3:46487, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:6257") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:50550->172.17.0.3:6257, 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/07/20 01:59:29 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-lubopac1peze/hello? sausage/êé" 2025/07/20 01:59:29 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/20 01:59:29 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:29 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{6gE5C}" suffix to name 2025/07/20 01:59:29 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:29 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: Connecting to FTP server 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:48480->172.17.0.3:21, err= 2025/07/20 01:59:29 DEBUG : fs cache: renaming cache item "TestFTPProftpd:rclone-test-lubopac1peze/hello? sausage/êé" to be canonical "TestFTPProftpd{6gE5C}:rclone-test-lubopac1peze/hello? sausage/êé" 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:46346") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:44030->172.17.0.3:46346, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:4111") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:38216->172.17.0.3:4111, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: Connecting to FTP server 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:21") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:48494->172.17.0.3:21, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:42724") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:57070->172.17.0.3:42724, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:57310") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:35070->172.17.0.3:57310, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:22972") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:58128->172.17.0.3:22972, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:4466") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:56406->172.17.0.3:4466, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:41775") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:57558->172.17.0.3:41775, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:13955") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:41452->172.17.0.3:13955, err= 2025/07/20 01:59:29 DEBUG : Waiting for deletions to finish 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:30341") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:58170->172.17.0.3:30341, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:5441") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:56106->172.17.0.3:5441, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:44724") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:44410->172.17.0.3:44724, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:10853") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:39804->172.17.0.3:10853, err= 2025/07/20 01:59:29 INFO : a/b/c/d/e.txt: Deleted 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:6815") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:60034->172.17.0.3:6815, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:2391") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:51598->172.17.0.3:2391, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:20177") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:37534->172.17.0.3:20177, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: dial("tcp","172.17.0.3:48588") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé: > dial: conn=172.17.0.1:51896->172.17.0.3:48588, err= 2025/07/20 01:59:29 DEBUG : removing 1 level 4 directories 2025/07/20 01:59:29 INFO : a/b/c/d: Removing directory 2025/07/20 01:59:29 DEBUG : removing 1 level 3 directories 2025/07/20 01:59:29 INFO : a/b/c: Removing directory 2025/07/20 01:59:29 DEBUG : removing 1 level 2 directories 2025/07/20 01:59:29 INFO : a/b: Removing directory 2025/07/20 01:59:29 DEBUG : removing 1 level 1 directories 2025/07/20 01:59:29 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:44828") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:48420->172.17.0.3:44828, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:26949") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:59842->172.17.0.3:26949, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:24071") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:52510->172.17.0.3:24071, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:34204") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:54446->172.17.0.3:34204, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:16337") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:56862->172.17.0.3:16337, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:40896") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:50534->172.17.0.3:40896, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: Connecting to FTP server 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:21") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:45112") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:48506->172.17.0.3:21, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:44256->172.17.0.3:45112, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:17481") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:44660->172.17.0.3:17481, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:19245") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:44996->172.17.0.3:19245, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:18762") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:58364->172.17.0.3:18762, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:19357") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:55256->172.17.0.3:19357, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:6828") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:35560->172.17.0.3:6828, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:30921") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:60844->172.17.0.3:30921, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:35493") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:41976->172.17.0.3:35493, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:54889") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:59056->172.17.0.3:54889, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:10574") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:35270->172.17.0.3:10574, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:50313") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:35686->172.17.0.3:50313, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:1841") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:38926->172.17.0.3:1841, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:41916") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:12767") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:42420->172.17.0.3:41916, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:50668->172.17.0.3:12767, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:30434") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:39060->172.17.0.3:30434, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:36565") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:51688->172.17.0.3:36565, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:17191") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:49628->172.17.0.3:17191, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/07/20 01:59:29 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-sibitop2cogi" 2025/07/20 01:59:29 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/20 01:59:29 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:29 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:29 DEBUG : TestFTPProftpd: detected overridden config - adding "{6gE5C}" suffix to name 2025/07/20 01:59:29 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:29 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:29 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:29 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: Connecting to FTP server 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: dial("tcp","172.17.0.3:21") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: > dial: conn=172.17.0.1:48518->172.17.0.3:21, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:41520") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:34948->172.17.0.3:41520, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: dial("tcp","172.17.0.3:45091") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: > dial: conn=172.17.0.1:41438->172.17.0.3:45091, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: dial("tcp","172.17.0.3:12602") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: > dial: conn=172.17.0.1:36042->172.17.0.3:12602, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: dial("tcp","172.17.0.3:41020") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: > dial: conn=172.17.0.1:48692->172.17.0.3:41020, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: dial("tcp","172.17.0.3:12600") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: > dial: conn=172.17.0.1:39390->172.17.0.3:12600, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: dial("tcp","172.17.0.3:51934") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: > dial: conn=172.17.0.1:35092->172.17.0.3:51934, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: dial("tcp","172.17.0.3:47231") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: > dial: conn=172.17.0.1:33410->172.17.0.3:47231, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: dial("tcp","172.17.0.3:57766") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: > dial: conn=172.17.0.1:37338->172.17.0.3:57766, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:24834") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:51970->172.17.0.3:24834, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:39566") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:42386->172.17.0.3:39566, err= 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:8103") 2025/07/20 01:59:29 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:32978->172.17.0.3:8103, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:43536") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:45934->172.17.0.3:43536, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:19077") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:41864->172.17.0.3:19077, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: dial("tcp","172.17.0.3:61555") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: > dial: conn=172.17.0.1:43890->172.17.0.3:61555, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: dial("tcp","172.17.0.3:56990") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: > dial: conn=172.17.0.1:51894->172.17.0.3:56990, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: dial("tcp","172.17.0.3:19311") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: > dial: conn=172.17.0.1:44564->172.17.0.3:19311, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: dial("tcp","172.17.0.3:45390") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: > dial: conn=172.17.0.1:52912->172.17.0.3:45390, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: Purge dir "new_name" 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-sibitop2cogi: 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/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:20634") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:52588->172.17.0.3:20634, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:35248") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:52826->172.17.0.3:35248, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:64880") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:47894->172.17.0.3:64880, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:64195") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:42630->172.17.0.3:64195, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:63581") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:50462->172.17.0.3:63581, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:56923") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:51882->172.17.0.3:56923, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:36771") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:45534->172.17.0.3:36771, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:32485") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:42662->172.17.0.3:32485, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:45368") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:42796->172.17.0.3:45368, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/07/20 01:59:30 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-lubopac1peze/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/07/20 01:59:30 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/20 01:59:30 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:30 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:30 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:30 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:30 DEBUG : TestFTPProftpd: detected overridden config - adding "{6gE5C}" suffix to name 2025/07/20 01:59:30 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:30 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:30 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:30 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:21") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:48534->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.3:41499") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:55648->172.17.0.3:41499, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/07/20 01:59:30 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-lubopac1peze/not found.txt" 2025/07/20 01:59:30 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/20 01:59:30 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:30 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:30 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:30 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:30 DEBUG : TestFTPProftpd: detected overridden config - adding "{6gE5C}" suffix to name 2025/07/20 01:59:30 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:30 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:30 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:30 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/not found.txt: Connecting to FTP server 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/not found.txt: dial("tcp","172.17.0.3:21") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/not found.txt: > dial: conn=172.17.0.1:48544->172.17.0.3:21, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/not found.txt: dial("tcp","172.17.0.3:10967") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/not found.txt: > dial: conn=172.17.0.1:49594->172.17.0.3:10967, err= 2025/07/20 01:59:30 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPProftpd:" path "rclone-test-lubopac1peze" from "TestFTPProftpd:rclone-test-lubopac1peze" 2025/07/20 01:59:30 DEBUG : Creating backend with remote "TestFTPProftpd:" 2025/07/20 01:59:30 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/20 01:59:30 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:30 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:30 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:30 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:30 DEBUG : TestFTPProftpd: detected overridden config - adding "{6gE5C}" suffix to name 2025/07/20 01:59:30 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:30 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:30 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:30 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: Connecting to FTP server 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:21") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:48554->172.17.0.3:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:1478") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:46668->172.17.0.3:1478, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:26605") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:47834->172.17.0.3:26605, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:8331") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:53522->172.17.0.3:8331, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:24021") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:43754->172.17.0.3:24021, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:19199") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:51006->172.17.0.3:19199, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:60710") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:42058->172.17.0.3:60710, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:30513") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:40242->172.17.0.3:30513, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:31541") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:39956->172.17.0.3:31541, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:15499") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:56462->172.17.0.3:15499, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:20980") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:43338->172.17.0.3:20980, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:15129") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:51974->172.17.0.3:15129, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:33798") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:46430->172.17.0.3:33798, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:40132") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:46438->172.17.0.3:40132, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:54803") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:35054->172.17.0.3:54803, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:39083") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:54022->172.17.0.3:39083, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:16392") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:50766->172.17.0.3:16392, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: dial("tcp","172.17.0.3:5221") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21: > dial: conn=172.17.0.1:57972->172.17.0.3:5221, 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/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:44748") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:59304->172.17.0.3:44748, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:29568") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:55482->172.17.0.3:29568, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:63290") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:54270->172.17.0.3:63290, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:65194") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:55170->172.17.0.3:65194, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:49351") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:50610->172.17.0.3:49351, 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/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:3897") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:47168->172.17.0.3:3897, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:6655") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:45246->172.17.0.3:6655, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/07/20 01:59:30 DEBUG : Creating backend with remote "TestFTPProftpd,concurrency='0',shut_timeout='1s':rclone-test-lubopac1peze" 2025/07/20 01:59:30 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/20 01:59:30 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:30 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:30 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:30 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:30 DEBUG : TestFTPProftpd: detected overridden config - adding "{4AVzl}" suffix to name 2025/07/20 01:59:30 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:30 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:30 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:30 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: Connecting to FTP server 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:21") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:48556->172.17.0.3:21, err= 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:5805") 2025/07/20 01:59:30 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:37704->172.17.0.3:5805, 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/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:63864") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:51612->172.17.0.3:63864, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:33399") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:37318->172.17.0.3:33399, err= 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:8556") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:55422->172.17.0.3:8556, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/07/20 01:59:31 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-lubopac1peze/deeper/nonexisting/directory" 2025/07/20 01:59:31 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/07/20 01:59:31 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:31 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:31 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:31 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:31 DEBUG : TestFTPProftpd: detected overridden config - adding "{6gE5C}" suffix to name 2025/07/20 01:59:31 DEBUG : Setting host="172.17.0.3" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/07/20 01:59:31 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/07/20 01:59:31 DEBUG : Setting pass="1f5fULs-_Rbm1MTPsW3dYaIDXDtedczWqycKJtjZbcFzoQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/07/20 01:59:31 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/deeper/nonexisting/directory: Connecting to FTP server 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/deeper/nonexisting/directory: dial("tcp","172.17.0.3:21") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze/deeper/nonexisting/directory: > dial: conn=172.17.0.1:48566->172.17.0.3: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/07/20 01:59:31 DEBUG : Waiting for deletions to finish 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:32019") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:54226->172.17.0.3:32019, err= 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:62930") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:37052->172.17.0.3:62930, err= 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:55276") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:55654->172.17.0.3:55276, err= 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:22067") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:53640->172.17.0.3:22067, err= 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:14351") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:59004->172.17.0.3:14351, err= 2025/07/20 01:59:31 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:41084") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:36796->172.17.0.3:41084, err= 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:37253") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:36374->172.17.0.3:37253, err= 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:14381") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:46766->172.17.0.3:14381, err= 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:34570") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:38228->172.17.0.3:34570, err= 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:11519") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:45996->172.17.0.3:11519, err= 2025/07/20 01:59:31 DEBUG : removing 1 level 4 directories 2025/07/20 01:59:31 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/07/20 01:59:31 DEBUG : removing 1 level 3 directories 2025/07/20 01:59:31 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/07/20 01:59:31 DEBUG : removing 1 level 2 directories 2025/07/20 01:59:31 INFO : hello? sausage/êé: Removing directory 2025/07/20 01:59:31 DEBUG : removing 1 level 1 directories 2025/07/20 01:59:31 INFO : hello? sausage: Removing directory 2025/07/20 01:59:31 DEBUG : removing 1 level 0 directories 2025/07/20 01:59:31 INFO : ftp://172.17.0.3:21/rclone-test-lubopac1peze: Removing directory 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:21292") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:44364->172.17.0.3:21292, err= 2025/07/20 01:59:31 ERROR : error listing: directory not found 2025/07/20 01:59:31 DEBUG : Waiting for deletions to finish 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:40277") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:50892->172.17.0.3:40277, err= 2025/07/20 01:59:31 ERROR : error listing: directory not found 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: dial("tcp","172.17.0.3:30483") 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: > dial: conn=172.17.0.1:33540->172.17.0.3:30483, err= 2025/07/20 01:59:31 ERROR : ftp://172.17.0.3:21/rclone-test-lubopac1peze: Failed to list "": directory not found 2025/07/20 01:59:31 DEBUG : removing 1 level 0 directories 2025/07/20 01:59:31 INFO : ftp://172.17.0.3:21/rclone-test-lubopac1peze: Removing directory 2025/07/20 01:59:31 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/07/20 01:59:31 DEBUG : ftp://172.17.0.3:21/rclone-test-lubopac1peze: closing 2 unused connections --- PASS: TestIntegration (2.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.70s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.24s) --- 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.02s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.02s) --- 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.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.02s) --- 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.10s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.06s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.06s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.02s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 2.824s "go test -v -timeout 1h0m0s -remote TestFTPProftpd: -verbose" - Finished OK in 3.679935106s (try 1/5)