"go test -v -timeout 1h0m0s -remote TestFTPRclone: -verbose" - Starting (try 1/5) === RUN TestCommandEncodingNeutralisesCRLF --- PASS: TestCommandEncodingNeutralisesCRLF (0.00s) === RUN TestIntegration fstests.go:457: Using remote "TestFTPRclone:" 2026/08/17 01:00:35 NOTICE: TestFTPRclone: Starting server 2026/08/17 01:00:36 NOTICE: TestFTPRclone: Attempting to connect to "127.0.0.1:28622" try 1/100 2026/08/17 01:00:36 DEBUG : TestFTPRclone: Read 1, error: 2026/08/17 01:00:36 NOTICE: TestFTPRclone: Started server and connected to "127.0.0.1:28622" 2026/08/17 01:00:36 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-wisehuq9nufa" 2026/08/17 01:00:36 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/17 01:00:36 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/17 01:00:36 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:36 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:36 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:36 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:36 DEBUG : TestFTPRclone: detected overridden config - adding "{ytP-K}" suffix to name 2026/08/17 01:00:36 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:36 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:36 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:36 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: Connecting to FTP server 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:28622") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39594->127.0.0.1:28622, err= 2026/08/17 01:00:36 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:498: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:526: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31843") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:35882->127.0.0.1:31843, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30235") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:57020->127.0.0.1:30235, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/08/17 01:00:36 INFO : dir/subdir: Making directory 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31911") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:44676->127.0.0.1:31911, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31599") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:33242->127.0.0.1:31599, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31518") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:33644->127.0.0.1:31518, err= 2026/08/17 01:00:36 INFO : dir/subdir: Removing directory 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31083") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:45274->127.0.0.1:31083, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31264") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:44150->127.0.0.1:31264, err= 2026/08/17 01:00:36 INFO : dir: Removing directory 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30310") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:55326->127.0.0.1:30310, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30065") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39838->127.0.0.1:30065, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31668") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:50176->127.0.0.1:31668, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31608") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:37346->127.0.0.1:31608, err= 2026/08/17 01:00:36 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30201") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:42536->127.0.0.1:30201, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:727: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30804") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:35408->127.0.0.1:30804, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31587") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:54322->127.0.0.1:31587, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30762") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39348->127.0.0.1:30762, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30574") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39108->127.0.0.1:30574, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:727: testing "．" 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31309") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:57802->127.0.0.1:31309, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31298") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:45004->127.0.0.1:31298, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31777") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:51566->127.0.0.1:31777, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30585") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:57206->127.0.0.1:30585, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:727: testing "．．" 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31649") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:55010->127.0.0.1:31649, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31673") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:57470->127.0.0.1:31673, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30761") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:34294->127.0.0.1:30761, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30269") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:53592->127.0.0.1:30269, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:727: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30542") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:54414->127.0.0.1:30542, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30620") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:36622->127.0.0.1:30620, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30759") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:38460->127.0.0.1:30759, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31915") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:55890->127.0.0.1:31915, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:727: testing " leading space" 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30148") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:56804->127.0.0.1:30148, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31181") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:51606->127.0.0.1:31181, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30555") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:56914->127.0.0.1:30555, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31683") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:59886->127.0.0.1:31683, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:727: testing "~leading tilde" 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30411") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:57936->127.0.0.1:30411, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30273") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:60272->127.0.0.1:30273, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31679") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:46646->127.0.0.1:31679, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30772") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39966->127.0.0.1:30772, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:727: testing "␍leading CR" 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30087") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:33036->127.0.0.1:30087, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31471") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:46238->127.0.0.1:31471, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30204") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:50624->127.0.0.1:30204, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31946") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:51402->127.0.0.1:31946, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:727: testing "␊leading LF" 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30385") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:53746->127.0.0.1:30385, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31531") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:44032->127.0.0.1:31531, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30294") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39750->127.0.0.1:30294, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30583") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:40570->127.0.0.1:30583, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:727: testing "␉leading HT" 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30234") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:55086->127.0.0.1:30234, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30263") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:58166->127.0.0.1:30263, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30368") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:56498->127.0.0.1:30368, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30156") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:59226->127.0.0.1:30156, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:727: testing "␋leading VT" 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30581") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:46948->127.0.0.1:30581, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31142") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:40436->127.0.0.1:31142, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31639") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:37928->127.0.0.1:31639, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30142") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:57244->127.0.0.1:30142, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:727: testing ".leading dot" 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30140") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:49330->127.0.0.1:30140, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30742") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:53864->127.0.0.1:30742, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31722") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:40350->127.0.0.1:31722, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30462") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:38174->127.0.0.1:30462, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:727: testing "trailing space " 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30507") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:56204->127.0.0.1:30507, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31013") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:49856->127.0.0.1:31013, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30921") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:37692->127.0.0.1:30921, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31949") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:54646->127.0.0.1:31949, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:727: testing "trailing CR␍" 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30883") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:40960->127.0.0.1:30883, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31960") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:51144->127.0.0.1:31960, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30488") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:53680->127.0.0.1:30488, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30891") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:43610->127.0.0.1:30891, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:727: testing "trailing LF␊" 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31632") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:37196->127.0.0.1:31632, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30541") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:45358->127.0.0.1:30541, err= 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30022") 2026/08/17 01:00:36 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:42334->127.0.0.1:30022, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30769") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:34366->127.0.0.1:30769, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:727: testing "trailing HT␉" 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30641") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:33772->127.0.0.1:30641, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30715") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:35228->127.0.0.1:30715, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30574") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39114->127.0.0.1:30574, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31822") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:50248->127.0.0.1:31822, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:727: testing "trailing VT␋" 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31150") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:60358->127.0.0.1:31150, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30265") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:54538->127.0.0.1:30265, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31303") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:60776->127.0.0.1:31303, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30766") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:53380->127.0.0.1:30766, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:727: testing "trailing dot." 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30955") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:42120->127.0.0.1:30955, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31783") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:48486->127.0.0.1:31783, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30734") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:52804->127.0.0.1:30734, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30521") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:36038->127.0.0.1:30521, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:727: testing "invalid utf-8\xfe" 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30329") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:43022->127.0.0.1:30329, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30083") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:38408->127.0.0.1:30083, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31489") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:59370->127.0.0.1:31489, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30837") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:59820->127.0.0.1:30837, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:727: testing "test%46.txt" 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30032") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:57518->127.0.0.1:30032, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31306") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:48030->127.0.0.1:31306, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30067") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:51746->127.0.0.1:30067, err= 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31964") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:55812->127.0.0.1:31964, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30439") 2026/08/17 01:00:37 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:44344->127.0.0.1:30439, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: Connecting to FTP server 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:28622") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39596->127.0.0.1:28622, err= 2026/08/17 01:00:38 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31002") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:41702->127.0.0.1:31002, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31768") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:38686->127.0.0.1:31768, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:806: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:839: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:892: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31629") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:59212->127.0.0.1:31629, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31139") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:36010->127.0.0.1:31139, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31162") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:54448->127.0.0.1:31162, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31259") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:47524->127.0.0.1:31259, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31073") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:37130->127.0.0.1:31073, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30746") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:55670->127.0.0.1:30746, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30756") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:46910->127.0.0.1:30756, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30436") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:54150->127.0.0.1:30436, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31251") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:53706->127.0.0.1:31251, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30527") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:51720->127.0.0.1:30527, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31133") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:57598->127.0.0.1:31133, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31646") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:50978->127.0.0.1:31646, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30047") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:35170->127.0.0.1:30047, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30590") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:51170->127.0.0.1:30590, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31279") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39786->127.0.0.1:31279, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31670") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:37108->127.0.0.1:31670, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30938") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:35374->127.0.0.1:30938, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/08/17 01:00:38 DEBUG : Creating backend with remote "TestFTPRclone:" 2026/08/17 01:00:38 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/17 01:00:38 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:38 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:38 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:38 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:38 DEBUG : TestFTPRclone: detected overridden config - adding "{ytP-K}" suffix to name 2026/08/17 01:00:38 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:38 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:38 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:38 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: Connecting to FTP server 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:28622") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:39606->127.0.0.1:28622, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31576") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:38106->127.0.0.1:31576, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30094") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:50454->127.0.0.1:30094, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31118") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:55448->127.0.0.1:31118, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31732") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:50542->127.0.0.1:31732, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30264") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:59178->127.0.0.1:30264, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30536") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:53786->127.0.0.1:30536, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30400") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:56546->127.0.0.1:30400, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31010") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:42926->127.0.0.1:31010, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30038") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:37380->127.0.0.1:30038, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31229") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:60948->127.0.0.1:31229, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1145: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30170") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:34982->127.0.0.1:30170, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30393") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:44522->127.0.0.1:30393, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31774") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:59594->127.0.0.1:31774, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31879") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:42832->127.0.0.1:31879, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31224") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:36370->127.0.0.1:31224, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1177: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1214: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/08/17 01:00:38 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-wisehuq9nufa/hello? sausage/êé" 2026/08/17 01:00:38 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/17 01:00:38 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:38 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:38 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:38 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:38 DEBUG : TestFTPRclone: detected overridden config - adding "{ytP-K}" suffix to name 2026/08/17 01:00:38 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:38 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:38 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:38 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: Connecting to FTP server 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:28622") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:39618->127.0.0.1:28622, err= 2026/08/17 01:00:38 DEBUG : fs cache: renaming cache item "TestFTPRclone:rclone-test-wisehuq9nufa/hello? sausage/êé" to be canonical "TestFTPRclone{ytP-K}:rclone-test-wisehuq9nufa/hello? sausage/êé" 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:31537") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:37166->127.0.0.1:31537, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: SetModTime is not supported 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:30450") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:59314->127.0.0.1:30450, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: Connecting to FTP server 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:30333") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:42102->127.0.0.1:30333, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:30464") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:59358->127.0.0.1:30464, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:28622") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:30464") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:39630->127.0.0.1:28622, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:59372->127.0.0.1:30464, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:30180") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:57166->127.0.0.1:30180, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:30922") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:34494->127.0.0.1:30922, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:31174") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:50670->127.0.0.1:31174, err= 2026/08/17 01:00:38 DEBUG : Waiting for deletions to finish 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:30712") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:35144->127.0.0.1:30712, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:30082") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:56922->127.0.0.1:30082, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:31516") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:60264->127.0.0.1:31516, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:30982") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:38494->127.0.0.1:30982, err= 2026/08/17 01:00:38 INFO : a/b/c/d/e.txt: Deleted 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:30719") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:56438->127.0.0.1:30719, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:30189") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:32802->127.0.0.1:30189, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:30459") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:48088->127.0.0.1:30459, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: dial("tcp","127.0.0.1:30564") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé: > dial: conn=127.0.0.1:36292->127.0.0.1:30564, err= 2026/08/17 01:00:38 DEBUG : removing 1 level 4 directories 2026/08/17 01:00:38 INFO : a/b/c/d: Removing directory 2026/08/17 01:00:38 DEBUG : removing 1 level 3 directories 2026/08/17 01:00:38 INFO : a/b/c: Removing directory 2026/08/17 01:00:38 DEBUG : removing 1 level 2 directories 2026/08/17 01:00:38 INFO : a/b: Removing directory 2026/08/17 01:00:38 DEBUG : removing 1 level 1 directories 2026/08/17 01:00:38 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1278: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31214") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:41190->127.0.0.1:31214, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31605") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:55980->127.0.0.1:31605, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31307") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:40420->127.0.0.1:31307, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31623") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:41274->127.0.0.1:31623, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30883") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:40968->127.0.0.1:30883, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31848") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:37866->127.0.0.1:31848, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: Connecting to FTP server 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:28622") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39638->127.0.0.1:28622, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30479") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31523") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:57754->127.0.0.1:31523, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:55794->127.0.0.1:30479, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31311") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:35620->127.0.0.1:31311, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30076") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:50136->127.0.0.1:30076, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30964") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:37528->127.0.0.1:30964, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31868") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39146->127.0.0.1:31868, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31254") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30883") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:40980->127.0.0.1:30883, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:49110->127.0.0.1:31254, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31578") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:50034->127.0.0.1:31578, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31993") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:41118->127.0.0.1:31993, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31878") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:33260->127.0.0.1:31878, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30067") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:51748->127.0.0.1:30067, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31224") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:36384->127.0.0.1:31224, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31252") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:53226->127.0.0.1:31252, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30134") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:49128->127.0.0.1:30134, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31917") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:44082->127.0.0.1:31917, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31887") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:50032->127.0.0.1:31887, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1430: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/08/17 01:00:38 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-xalabap3ruje" 2026/08/17 01:00:38 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/17 01:00:38 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:38 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:38 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:38 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:38 DEBUG : TestFTPRclone: detected overridden config - adding "{ytP-K}" suffix to name 2026/08/17 01:00:38 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:38 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:38 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:38 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: Connecting to FTP server 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: dial("tcp","127.0.0.1:28622") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: > dial: conn=127.0.0.1:39654->127.0.0.1:28622, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30752") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:57488->127.0.0.1:30752, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: dial("tcp","127.0.0.1:31195") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: > dial: conn=127.0.0.1:37572->127.0.0.1:31195, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: dial("tcp","127.0.0.1:30252") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: > dial: conn=127.0.0.1:33258->127.0.0.1:30252, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: dial("tcp","127.0.0.1:30454") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: > dial: conn=127.0.0.1:32790->127.0.0.1:30454, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: dial("tcp","127.0.0.1:31677") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: > dial: conn=127.0.0.1:59600->127.0.0.1:31677, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: dial("tcp","127.0.0.1:30911") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: > dial: conn=127.0.0.1:39476->127.0.0.1:30911, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: dial("tcp","127.0.0.1:30406") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: > dial: conn=127.0.0.1:45034->127.0.0.1:30406, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: dial("tcp","127.0.0.1:31202") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: > dial: conn=127.0.0.1:56456->127.0.0.1:31202, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31341") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:49630->127.0.0.1:31341, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31738") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:37534->127.0.0.1:31738, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30305") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:49910->127.0.0.1:30305, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31977") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:41270->127.0.0.1:31977, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31259") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:47536->127.0.0.1:31259, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: dial("tcp","127.0.0.1:31448") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: > dial: conn=127.0.0.1:43164->127.0.0.1:31448, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: dial("tcp","127.0.0.1:30392") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: > dial: conn=127.0.0.1:56684->127.0.0.1:30392, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: dial("tcp","127.0.0.1:30041") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: > dial: conn=127.0.0.1:50116->127.0.0.1:30041, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: dial("tcp","127.0.0.1:30679") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: > dial: conn=127.0.0.1:50478->127.0.0.1:30679, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: Purge dir "new_name" 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-xalabap3ruje: 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:1626: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1657: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1728: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31148") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:57224->127.0.0.1:31148, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30767") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:59786->127.0.0.1:30767, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30481") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:49786->127.0.0.1:30481, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31392") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:35280->127.0.0.1:31392, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30664") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:47892->127.0.0.1:30664, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31412") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:49952->127.0.0.1:31412, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30451") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:56952->127.0.0.1:30451, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31287") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:50824->127.0.0.1:31287, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30952") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:53528->127.0.0.1:30952, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31104") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:44522->127.0.0.1:31104, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30604") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:37228->127.0.0.1:30604, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30235") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:57026->127.0.0.1:30235, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31812") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:52962->127.0.0.1:31812, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31447") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:51918->127.0.0.1:31447, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30202") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:42108->127.0.0.1:30202, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30065") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39840->127.0.0.1:30065, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/08/17 01:00:38 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-wisehuq9nufa/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/08/17 01:00:38 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/17 01:00:38 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:38 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:38 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:38 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:38 DEBUG : TestFTPRclone: detected overridden config - adding "{ytP-K}" suffix to name 2026/08/17 01:00:38 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:38 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:38 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:38 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:28622") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:39658->127.0.0.1:28622, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:31540") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:39734->127.0.0.1:31540, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/08/17 01:00:38 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-wisehuq9nufa/not found.txt" 2026/08/17 01:00:38 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/17 01:00:38 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:38 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:38 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:38 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:38 DEBUG : TestFTPRclone: detected overridden config - adding "{ytP-K}" suffix to name 2026/08/17 01:00:38 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:38 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:38 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:38 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/not found.txt: Connecting to FTP server 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/not found.txt: dial("tcp","127.0.0.1:28622") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/not found.txt: > dial: conn=127.0.0.1:39674->127.0.0.1:28622, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/not found.txt: dial("tcp","127.0.0.1:31612") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/not found.txt: > dial: conn=127.0.0.1:60284->127.0.0.1:31612, err= 2026/08/17 01:00:38 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1987: Opening root remote "TestFTPRclone:" path "rclone-test-wisehuq9nufa" from "TestFTPRclone:rclone-test-wisehuq9nufa" 2026/08/17 01:00:38 DEBUG : Creating backend with remote "TestFTPRclone:" 2026/08/17 01:00:38 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/17 01:00:38 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:38 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:38 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:38 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:38 DEBUG : TestFTPRclone: detected overridden config - adding "{ytP-K}" suffix to name 2026/08/17 01:00:38 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:38 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:38 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:38 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: Connecting to FTP server 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:28622") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:39680->127.0.0.1:28622, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30599") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:57800->127.0.0.1:30599, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30211") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:56846->127.0.0.1:30211, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30116") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:45716->127.0.0.1:30116, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30629") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:49376->127.0.0.1:30629, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30885") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:39734->127.0.0.1:30885, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30325") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:34276->127.0.0.1:30325, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2024: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30236") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:51022->127.0.0.1:30236, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: SetModTime is not supported 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30042") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:56982->127.0.0.1:30042, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30057") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:33112->127.0.0.1:30057, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30240") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:38652->127.0.0.1:30240, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31725") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:45986->127.0.0.1:31725, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31678") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:56022->127.0.0.1:31678, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31940") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:37844->127.0.0.1:31940, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31703") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:45230->127.0.0.1:31703, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30500") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:59564->127.0.0.1:30500, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31910") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:53918->127.0.0.1:31910, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31560") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:50946->127.0.0.1:31560, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2083: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:431: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2188: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2204: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30025") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:60580->127.0.0.1:30025, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30247") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:33350->127.0.0.1:30247, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31719") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:35730->127.0.0.1:31719, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31189") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:46504->127.0.0.1:31189, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31067") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39938->127.0.0.1:31067, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2360: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31937") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:55766->127.0.0.1:31937, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30947") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:49144->127.0.0.1:30947, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/08/17 01:00:38 DEBUG : Creating backend with remote "TestFTPRclone,concurrency='0',shut_timeout='1s':rclone-test-wisehuq9nufa" 2026/08/17 01:00:38 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/17 01:00:38 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:38 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:38 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:38 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:38 DEBUG : TestFTPRclone: detected overridden config - adding "{zlmIU}" suffix to name 2026/08/17 01:00:38 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:38 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:38 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:38 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: Connecting to FTP server 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:28622") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39688->127.0.0.1:28622, err= 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31262") 2026/08/17 01:00:38 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:52156->127.0.0.1:31262, err= 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2445: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30953") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:51946->127.0.0.1:30953, err= 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported === RUN TestIntegration/FsMkdir/FsPutShortEOF/Chunked fstests.go:2640: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2682: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31406") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:57036->127.0.0.1:31406, err= 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30727") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:60190->127.0.0.1:30727, err= 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31395") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39570->127.0.0.1:31395, err= 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: SetModTime is not supported === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/08/17 01:00:40 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-wisehuq9nufa/deeper/nonexisting/directory" 2026/08/17 01:00:40 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/17 01:00:40 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:40 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:40 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:40 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:40 DEBUG : TestFTPRclone: detected overridden config - adding "{ytP-K}" suffix to name 2026/08/17 01:00:40 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/17 01:00:40 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/17 01:00:40 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/17 01:00:40 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/deeper/nonexisting/directory: Connecting to FTP server 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/deeper/nonexisting/directory: dial("tcp","127.0.0.1:28622") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa/deeper/nonexisting/directory: > dial: conn=127.0.0.1:39696->127.0.0.1:28622, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2831: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2874: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2931: FS has no Directory methods and doesn't Wrap 2026/08/17 01:00:40 DEBUG : Waiting for deletions to finish 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30065") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:39850->127.0.0.1:30065, err= 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30578") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:57030->127.0.0.1:30578, err= 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31674") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:32922->127.0.0.1:31674, err= 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30604") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:37244->127.0.0.1:30604, err= 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30021") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:55362->127.0.0.1:30021, err= 2026/08/17 01:00:40 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30164") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:33244->127.0.0.1:30164, err= 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30654") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:56666->127.0.0.1:30654, err= 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30980") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:51952->127.0.0.1:30980, err= 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31496") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:37078->127.0.0.1:31496, err= 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31990") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:50906->127.0.0.1:31990, err= 2026/08/17 01:00:40 DEBUG : removing 1 level 4 directories 2026/08/17 01:00:40 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/08/17 01:00:40 DEBUG : removing 1 level 3 directories 2026/08/17 01:00:40 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/08/17 01:00:40 DEBUG : removing 1 level 2 directories 2026/08/17 01:00:40 INFO : hello? sausage/êé: Removing directory 2026/08/17 01:00:40 DEBUG : removing 1 level 1 directories 2026/08/17 01:00:40 INFO : hello? sausage: Removing directory 2026/08/17 01:00:40 DEBUG : removing 1 level 0 directories 2026/08/17 01:00:40 INFO : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: Removing directory 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31662") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:56102->127.0.0.1:31662, err= 2026/08/17 01:00:40 ERROR : error listing: directory not found 2026/08/17 01:00:40 DEBUG : Waiting for deletions to finish 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:30770") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:35238->127.0.0.1:30770, err= 2026/08/17 01:00:40 ERROR : error listing: directory not found 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: dial("tcp","127.0.0.1:31522") 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: > dial: conn=127.0.0.1:34034->127.0.0.1:31522, err= 2026/08/17 01:00:40 ERROR : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: Failed to list "": directory not found 2026/08/17 01:00:40 DEBUG : removing 1 level 0 directories 2026/08/17 01:00:40 INFO : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: Removing directory 2026/08/17 01:00:40 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/08/17 01:00:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-wisehuq9nufa: closing 2 unused connections 2026/08/17 01:00:40 NOTICE: TestFTPRclone: Stopping server --- PASS: TestIntegration (4.45s) --- 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 (3.38s) --- 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.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.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.02s) --- 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.02s) --- 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 (2.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.00s) --- 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.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.00s) --- 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.03s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.03s) --- 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.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (0.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (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.00s) --- 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.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (1.47s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (1.47s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Simple (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutShortEOF/Chunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.01s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 4.491s "go test -v -timeout 1h0m0s -remote TestFTPRclone: -verbose" - Finished OK in 9.870134151s (try 1/5)