"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/19 05:31:49 NOTICE: TestFTPRclone: Starting server 2026/08/19 05:31:50 NOTICE: TestFTPRclone: Attempting to connect to "127.0.0.1:28622" try 1/100 2026/08/19 05:31:50 DEBUG : TestFTPRclone: Read 1, error: 2026/08/19 05:31:50 NOTICE: TestFTPRclone: Started server and connected to "127.0.0.1:28622" 2026/08/19 05:31:50 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-rusabix6repo" 2026/08/19 05:31:50 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/19 05:31:50 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/19 05:31:50 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:50 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:50 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:50 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:50 DEBUG : TestFTPRclone: detected overridden config - adding "{4blCV}" suffix to name 2026/08/19 05:31:50 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:50 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:50 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:50 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: Connecting to FTP server 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:28622") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:56196->127.0.0.1:28622, err= 2026/08/19 05:31:50 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/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30244") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:54048->127.0.0.1:30244, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31192") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:57104->127.0.0.1:31192, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/08/19 05:31:50 INFO : dir/subdir: Making directory 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31041") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:35112->127.0.0.1:31041, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31174") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33026->127.0.0.1:31174, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31111") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:32944->127.0.0.1:31111, err= 2026/08/19 05:31:50 INFO : dir/subdir: Removing directory 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31972") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:47884->127.0.0.1:31972, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31710") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:56168->127.0.0.1:31710, err= 2026/08/19 05:31:50 INFO : dir: Removing directory 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31435") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:56042->127.0.0.1:31435, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30340") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:50978->127.0.0.1:30340, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31658") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:60342->127.0.0.1:31658, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31105") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33878->127.0.0.1:31105, err= 2026/08/19 05:31:50 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/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30454") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:59198->127.0.0.1:30454, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:727: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30630") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:37672->127.0.0.1:30630, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31560") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:57732->127.0.0.1:31560, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30727") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:36768->127.0.0.1:30727, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31350") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:40698->127.0.0.1:31350, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:727: testing "．" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30652") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33010->127.0.0.1:30652, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31493") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:58878->127.0.0.1:31493, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31678") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:56258->127.0.0.1:31678, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31074") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:55670->127.0.0.1:31074, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:727: testing "．．" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30567") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:44446->127.0.0.1:30567, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30552") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:47876->127.0.0.1:30552, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30733") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:46768->127.0.0.1:30733, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31455") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:58986->127.0.0.1:31455, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:727: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30727") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:36772->127.0.0.1:30727, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31681") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:49022->127.0.0.1:31681, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31990") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:49918->127.0.0.1:31990, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31418") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33160->127.0.0.1:31418, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:727: testing " leading space" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31547") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:36716->127.0.0.1:31547, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31308") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:53292->127.0.0.1:31308, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30693") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:45020->127.0.0.1:30693, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30843") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:39714->127.0.0.1:30843, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:727: testing "~leading tilde" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31756") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:40390->127.0.0.1:31756, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31277") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:42408->127.0.0.1:31277, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31743") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:50144->127.0.0.1:31743, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31780") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:44366->127.0.0.1:31780, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:727: testing "␍leading CR" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31025") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:46030->127.0.0.1:31025, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31812") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:49548->127.0.0.1:31812, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30076") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:41030->127.0.0.1:30076, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31373") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:38366->127.0.0.1:31373, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:727: testing "␊leading LF" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31264") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:52720->127.0.0.1:31264, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30799") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:34824->127.0.0.1:30799, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31686") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:40772->127.0.0.1:31686, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31501") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:60414->127.0.0.1:31501, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:727: testing "␉leading HT" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30780") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:45064->127.0.0.1:30780, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31085") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:48072->127.0.0.1:31085, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31284") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:46108->127.0.0.1:31284, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31836") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:50158->127.0.0.1:31836, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:727: testing "␋leading VT" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31385") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:53604->127.0.0.1:31385, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30864") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:60374->127.0.0.1:30864, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31568") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:35272->127.0.0.1:31568, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31458") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:40560->127.0.0.1:31458, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:727: testing ".leading dot" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30513") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:41864->127.0.0.1:30513, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31724") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:59670->127.0.0.1:31724, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30727") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:36776->127.0.0.1:30727, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30249") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33846->127.0.0.1:30249, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:727: testing "trailing space " 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31000") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:47316->127.0.0.1:31000, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31897") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:55338->127.0.0.1:31897, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30747") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:57218->127.0.0.1:30747, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31404") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:42148->127.0.0.1:31404, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:727: testing "trailing CR␍" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30386") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:56462->127.0.0.1:30386, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31859") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:36426->127.0.0.1:31859, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31272") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:54322->127.0.0.1:31272, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31287") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:54274->127.0.0.1:31287, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:727: testing "trailing LF␊" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30345") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:57720->127.0.0.1:30345, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30884") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33138->127.0.0.1:30884, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31216") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:53428->127.0.0.1:31216, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30314") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:55218->127.0.0.1:30314, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:727: testing "trailing HT␉" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31847") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:52930->127.0.0.1:31847, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31945") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:38224->127.0.0.1:31945, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30960") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:60382->127.0.0.1:30960, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30989") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:42056->127.0.0.1:30989, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:727: testing "trailing VT␋" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31976") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:54378->127.0.0.1:31976, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31434") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:37968->127.0.0.1:31434, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31203") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:56526->127.0.0.1:31203, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31505") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:45854->127.0.0.1:31505, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:727: testing "trailing dot." 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31842") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:50722->127.0.0.1:31842, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31072") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:42908->127.0.0.1:31072, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30490") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:43872->127.0.0.1:30490, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31014") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:36864->127.0.0.1:31014, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:727: testing "invalid utf-8\xfe" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30165") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:49296->127.0.0.1:30165, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31283") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:38494->127.0.0.1:31283, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30685") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:44292->127.0.0.1:30685, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31942") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:48884->127.0.0.1:31942, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:727: testing "test%46.txt" 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30135") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:57050->127.0.0.1:30135, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30603") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:59882->127.0.0.1:30603, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31039") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:39574->127.0.0.1:31039, err= 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31348") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:55082->127.0.0.1:31348, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30584") 2026/08/19 05:31:50 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:42364->127.0.0.1:30584, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: Connecting to FTP server 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:28622") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:42362->127.0.0.1:28622, err= 2026/08/19 05:31:51 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30325") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:53936->127.0.0.1:30325, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31559") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:44434->127.0.0.1:31559, 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/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31607") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:57538->127.0.0.1:31607, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30026") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:57488->127.0.0.1:30026, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31979") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:49312->127.0.0.1:31979, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30140") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33826->127.0.0.1:30140, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31997") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:37130->127.0.0.1:31997, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31825") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:52384->127.0.0.1:31825, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30438") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:44436->127.0.0.1:30438, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30084") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33458->127.0.0.1:30084, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31068") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33094->127.0.0.1:31068, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30554") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:53378->127.0.0.1:30554, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30762") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:50100->127.0.0.1:30762, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30126") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:43988->127.0.0.1:30126, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31147") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:37204->127.0.0.1:31147, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31969") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:48300->127.0.0.1:31969, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31009") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:56526->127.0.0.1:31009, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31395") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:49804->127.0.0.1:31395, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30797") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:57398->127.0.0.1:30797, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/08/19 05:31:51 DEBUG : Creating backend with remote "TestFTPRclone:" 2026/08/19 05:31:51 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/19 05:31:51 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:51 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:51 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:51 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:51 DEBUG : TestFTPRclone: detected overridden config - adding "{4blCV}" suffix to name 2026/08/19 05:31:51 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:51 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:51 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:51 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622: Connecting to FTP server 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:28622") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:42372->127.0.0.1:28622, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31931") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:45448->127.0.0.1:31931, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31923") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:54586->127.0.0.1:31923, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30496") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:45050->127.0.0.1:30496, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31017") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:40638->127.0.0.1:31017, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31160") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:53176->127.0.0.1:31160, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31021") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:35316->127.0.0.1:31021, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31593") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:60528->127.0.0.1:31593, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31225") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:59802->127.0.0.1:31225, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31244") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:43580->127.0.0.1:31244, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30821") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:42060->127.0.0.1:30821, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1145: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30011") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:47540->127.0.0.1:30011, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30729") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:44840->127.0.0.1:30729, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30427") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:41056->127.0.0.1:30427, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31428") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:58200->127.0.0.1:31428, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30753") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:38170->127.0.0.1:30753, 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/19 05:31:51 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-rusabix6repo/hello? sausage/êé" 2026/08/19 05:31:51 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/19 05:31:51 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:51 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:51 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:51 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:51 DEBUG : TestFTPRclone: detected overridden config - adding "{4blCV}" suffix to name 2026/08/19 05:31:51 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:51 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:51 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:51 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: Connecting to FTP server 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:28622") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:42380->127.0.0.1:28622, err= 2026/08/19 05:31:51 DEBUG : fs cache: renaming cache item "TestFTPRclone:rclone-test-rusabix6repo/hello? sausage/êé" to be canonical "TestFTPRclone{4blCV}:rclone-test-rusabix6repo/hello? sausage/êé" 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:31103") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:39442->127.0.0.1:31103, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: SetModTime is not supported 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:31105") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:40090->127.0.0.1:31105, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: Connecting to FTP server 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:28622") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:42390->127.0.0.1:28622, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:31392") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:57306->127.0.0.1:31392, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:31965") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:57834->127.0.0.1:31965, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:31022") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:30967") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:60686->127.0.0.1:30967, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:54910->127.0.0.1:31022, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:31543") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:30541") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:45312->127.0.0.1:31543, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:47872->127.0.0.1:30541, err= 2026/08/19 05:31:51 DEBUG : Waiting for deletions to finish 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:31411") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:34572->127.0.0.1:31411, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:31801") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:55824->127.0.0.1:31801, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:30427") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:41072->127.0.0.1:30427, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:30989") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:46984->127.0.0.1:30989, err= 2026/08/19 05:31:51 INFO : a/b/c/d/e.txt: Deleted 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:30332") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:51686->127.0.0.1:30332, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:31323") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:35638->127.0.0.1:31323, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:30694") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:55852->127.0.0.1:30694, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: dial("tcp","127.0.0.1:30354") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé: > dial: conn=127.0.0.1:56328->127.0.0.1:30354, err= 2026/08/19 05:31:51 DEBUG : removing 1 level 4 directories 2026/08/19 05:31:51 INFO : a/b/c/d: Removing directory 2026/08/19 05:31:51 DEBUG : removing 1 level 3 directories 2026/08/19 05:31:51 INFO : a/b/c: Removing directory 2026/08/19 05:31:51 DEBUG : removing 1 level 2 directories 2026/08/19 05:31:51 INFO : a/b: Removing directory 2026/08/19 05:31:51 DEBUG : removing 1 level 1 directories 2026/08/19 05:31:51 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1278: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31711") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:55734->127.0.0.1:31711, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31362") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:38688->127.0.0.1:31362, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30149") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:59644->127.0.0.1:30149, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30830") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:52036->127.0.0.1:30830, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31169") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:49242->127.0.0.1:31169, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31641") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:39548->127.0.0.1:31641, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: Connecting to FTP server 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:28622") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30938") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:42402->127.0.0.1:28622, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:54174->127.0.0.1:30938, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31070") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:46816->127.0.0.1:31070, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30563") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:41370->127.0.0.1:30563, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30563") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:41380->127.0.0.1:30563, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30722") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:52092->127.0.0.1:30722, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31213") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:43050->127.0.0.1:31213, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31626") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31441") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:59798->127.0.0.1:31441, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:34860->127.0.0.1:31626, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31594") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:32982->127.0.0.1:31594, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31319") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:52484->127.0.0.1:31319, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31872") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:41522->127.0.0.1:31872, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30801") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:43392->127.0.0.1:30801, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31117") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:57724->127.0.0.1:31117, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31202") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33228->127.0.0.1:31202, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30788") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:35700->127.0.0.1:30788, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31480") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:53730->127.0.0.1:31480, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30844") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:43160->127.0.0.1:30844, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1430: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/08/19 05:31:51 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-butisol8fala" 2026/08/19 05:31:51 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/19 05:31:51 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:51 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:51 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:51 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:51 DEBUG : TestFTPRclone: detected overridden config - adding "{4blCV}" suffix to name 2026/08/19 05:31:51 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:51 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:51 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:51 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: Connecting to FTP server 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: dial("tcp","127.0.0.1:28622") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: > dial: conn=127.0.0.1:42408->127.0.0.1:28622, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30766") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33316->127.0.0.1:30766, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: dial("tcp","127.0.0.1:31024") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: > dial: conn=127.0.0.1:44520->127.0.0.1:31024, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: dial("tcp","127.0.0.1:31728") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: > dial: conn=127.0.0.1:47482->127.0.0.1:31728, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: dial("tcp","127.0.0.1:30744") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: > dial: conn=127.0.0.1:39660->127.0.0.1:30744, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: dial("tcp","127.0.0.1:30471") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: > dial: conn=127.0.0.1:34414->127.0.0.1:30471, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: dial("tcp","127.0.0.1:30144") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: > dial: conn=127.0.0.1:35258->127.0.0.1:30144, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: dial("tcp","127.0.0.1:30655") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: > dial: conn=127.0.0.1:58858->127.0.0.1:30655, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: dial("tcp","127.0.0.1:30341") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: > dial: conn=127.0.0.1:43868->127.0.0.1:30341, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30514") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:52192->127.0.0.1:30514, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31104") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:45302->127.0.0.1:31104, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30269") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33730->127.0.0.1:30269, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31344") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:52958->127.0.0.1:31344, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30984") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:55232->127.0.0.1:30984, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: dial("tcp","127.0.0.1:31151") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: > dial: conn=127.0.0.1:39488->127.0.0.1:31151, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: dial("tcp","127.0.0.1:30710") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: > dial: conn=127.0.0.1:43764->127.0.0.1:30710, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: dial("tcp","127.0.0.1:30239") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: > dial: conn=127.0.0.1:52544->127.0.0.1:30239, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: dial("tcp","127.0.0.1:30977") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: > dial: conn=127.0.0.1:33084->127.0.0.1:30977, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: Purge dir "new_name" 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-butisol8fala: 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/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30605") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:47024->127.0.0.1:30605, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31789") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:40164->127.0.0.1:31789, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31887") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:48816->127.0.0.1:31887, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31572") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:35688->127.0.0.1:31572, err= 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31191") 2026/08/19 05:31:51 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:42284->127.0.0.1:31191, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30612") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33558->127.0.0.1:30612, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31809") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:38646->127.0.0.1:31809, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30661") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:49670->127.0.0.1:30661, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30688") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:42656->127.0.0.1:30688, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30897") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:36672->127.0.0.1:30897, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30621") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:43514->127.0.0.1:30621, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31340") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33540->127.0.0.1:31340, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31367") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:44578->127.0.0.1:31367, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31432") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:42158->127.0.0.1:31432, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30636") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:43482->127.0.0.1:30636, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30708") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:36170->127.0.0.1:30708, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/08/19 05:31:52 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-rusabix6repo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/08/19 05:31:52 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/19 05:31:52 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:52 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:52 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:52 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:52 DEBUG : TestFTPRclone: detected overridden config - adding "{4blCV}" suffix to name 2026/08/19 05:31:52 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:52 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:52 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:52 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:28622") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:42422->127.0.0.1:28622, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:30618") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:55862->127.0.0.1:30618, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/08/19 05:31:52 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-rusabix6repo/not found.txt" 2026/08/19 05:31:52 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/19 05:31:52 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:52 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:52 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:52 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:52 DEBUG : TestFTPRclone: detected overridden config - adding "{4blCV}" suffix to name 2026/08/19 05:31:52 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:52 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:52 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:52 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/not found.txt: Connecting to FTP server 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/not found.txt: dial("tcp","127.0.0.1:28622") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/not found.txt: > dial: conn=127.0.0.1:42428->127.0.0.1:28622, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/not found.txt: dial("tcp","127.0.0.1:30854") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/not found.txt: > dial: conn=127.0.0.1:56632->127.0.0.1:30854, err= 2026/08/19 05:31:52 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1987: Opening root remote "TestFTPRclone:" path "rclone-test-rusabix6repo" from "TestFTPRclone:rclone-test-rusabix6repo" 2026/08/19 05:31:52 DEBUG : Creating backend with remote "TestFTPRclone:" 2026/08/19 05:31:52 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/19 05:31:52 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:52 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:52 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:52 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:52 DEBUG : TestFTPRclone: detected overridden config - adding "{4blCV}" suffix to name 2026/08/19 05:31:52 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:52 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:52 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:52 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: Connecting to FTP server 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:28622") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:42434->127.0.0.1:28622, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30696") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:41174->127.0.0.1:30696, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30890") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:50208->127.0.0.1:30890, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31004") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:42962->127.0.0.1:31004, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31421") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:60568->127.0.0.1:31421, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31164") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:48306->127.0.0.1:31164, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30380") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:49136->127.0.0.1:30380, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2024: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31983") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:50834->127.0.0.1:31983, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: SetModTime is not supported 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30998") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:45924->127.0.0.1:30998, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30152") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:59804->127.0.0.1:30152, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30385") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:43226->127.0.0.1:30385, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30039") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:36608->127.0.0.1:30039, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30731") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:60290->127.0.0.1:30731, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30867") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:34398->127.0.0.1:30867, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30594") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:33590->127.0.0.1:30594, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30619") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:35114->127.0.0.1:30619, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31284") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:33538->127.0.0.1:31284, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31780") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:60980->127.0.0.1:31780, 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/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30281") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:57354->127.0.0.1:30281, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30456") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:51318->127.0.0.1:30456, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31770") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:38776->127.0.0.1:31770, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30835") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:45130->127.0.0.1:30835, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31343") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:39524->127.0.0.1:31343, 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/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30610") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:52626->127.0.0.1:30610, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30614") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:39420->127.0.0.1:30614, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/08/19 05:31:52 DEBUG : Creating backend with remote "TestFTPRclone,concurrency='0',shut_timeout='1s':rclone-test-rusabix6repo" 2026/08/19 05:31:52 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/19 05:31:52 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:52 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:52 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:52 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:52 DEBUG : TestFTPRclone: detected overridden config - adding "{D54VQ}" suffix to name 2026/08/19 05:31:52 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:52 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:52 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:52 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: Connecting to FTP server 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:28622") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:42450->127.0.0.1:28622, err= 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30137") 2026/08/19 05:31:52 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:42068->127.0.0.1:30137, err= 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: 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/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30836") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33896->127.0.0.1:30836, err= 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: 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/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30753") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:38184->127.0.0.1:30753, err= 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30896") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:35932->127.0.0.1:30896, err= 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30514") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:52208->127.0.0.1:30514, err= 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: SetModTime is not supported === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/08/19 05:31:53 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-rusabix6repo/deeper/nonexisting/directory" 2026/08/19 05:31:53 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/08/19 05:31:53 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:53 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:53 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:53 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:53 DEBUG : TestFTPRclone: detected overridden config - adding "{4blCV}" suffix to name 2026/08/19 05:31:53 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/08/19 05:31:53 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/08/19 05:31:53 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/08/19 05:31:53 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/deeper/nonexisting/directory: Connecting to FTP server 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/deeper/nonexisting/directory: dial("tcp","127.0.0.1:28622") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo/deeper/nonexisting/directory: > dial: conn=127.0.0.1:42462->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/19 05:31:53 DEBUG : Waiting for deletions to finish 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30796") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:39792->127.0.0.1:30796, err= 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30795") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:40626->127.0.0.1:30795, err= 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31559") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:44436->127.0.0.1:31559, err= 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30830") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:52050->127.0.0.1:30830, err= 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30899") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:33614->127.0.0.1:30899, err= 2026/08/19 05:31:53 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30292") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:47420->127.0.0.1:30292, err= 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31348") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:55694->127.0.0.1:31348, err= 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31212") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:60370->127.0.0.1:31212, err= 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30846") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:60796->127.0.0.1:30846, err= 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31600") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:43620->127.0.0.1:31600, err= 2026/08/19 05:31:53 DEBUG : removing 1 level 4 directories 2026/08/19 05:31:53 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/08/19 05:31:53 DEBUG : removing 1 level 3 directories 2026/08/19 05:31:53 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/08/19 05:31:53 DEBUG : removing 1 level 2 directories 2026/08/19 05:31:53 INFO : hello? sausage/êé: Removing directory 2026/08/19 05:31:53 DEBUG : removing 1 level 1 directories 2026/08/19 05:31:53 INFO : hello? sausage: Removing directory 2026/08/19 05:31:53 DEBUG : removing 1 level 0 directories 2026/08/19 05:31:53 INFO : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: Removing directory 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30004") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:50968->127.0.0.1:30004, err= 2026/08/19 05:31:53 ERROR : error listing: directory not found 2026/08/19 05:31:53 DEBUG : Waiting for deletions to finish 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:30653") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:55920->127.0.0.1:30653, err= 2026/08/19 05:31:53 ERROR : error listing: directory not found 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: dial("tcp","127.0.0.1:31860") 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: > dial: conn=127.0.0.1:52108->127.0.0.1:31860, err= 2026/08/19 05:31:53 ERROR : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: Failed to list "": directory not found 2026/08/19 05:31:53 DEBUG : removing 1 level 0 directories 2026/08/19 05:31:53 INFO : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: Removing directory 2026/08/19 05:31:53 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/08/19 05:31:53 DEBUG : ftp://127.0.0.1:28622/rclone-test-rusabix6repo: closing 2 unused connections 2026/08/19 05:31:53 NOTICE: TestFTPRclone: Stopping server --- PASS: TestIntegration (3.54s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.00s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir (2.48s) --- 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.13s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.01s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.03s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.02s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.02s) --- 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.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (0.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.03s) --- 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.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.88s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.88s) --- 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.00s) --- 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 3.559s "go test -v -timeout 1h0m0s -remote TestFTPRclone: -verbose" - Finished OK in 4.540013409s (try 1/5)