"go test -v -timeout 1h0m0s -remote TestFTPRclone: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPRclone:" 2026/05/21 04:16:44 NOTICE: TestFTPRclone: Starting server 2026/05/21 04:16:45 NOTICE: TestFTPRclone: Attempting to connect to "127.0.0.1:28622" try 1/100 2026/05/21 04:16:45 DEBUG : TestFTPRclone: Read 1, error: 2026/05/21 04:16:45 NOTICE: TestFTPRclone: Started server and connected to "127.0.0.1:28622" 2026/05/21 04:16:45 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-wudeyes0gocu" 2026/05/21 04:16:45 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/05/21 04:16:45 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/05/21 04:16:45 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:45 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:45 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:45 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:45 DEBUG : TestFTPRclone: detected overridden config - adding "{569HL}" suffix to name 2026/05/21 04:16:45 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:45 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:45 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:45 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: Connecting to FTP server 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:28622") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:49268->127.0.0.1:28622, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31244") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33026->127.0.0.1:31244, err= 2026/05/21 04:16:45 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30716") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50442->127.0.0.1:30716, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30012") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33848->127.0.0.1:30012, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30767") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:37896->127.0.0.1:30767, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30188") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:56592->127.0.0.1:30188, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30954") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:47356->127.0.0.1:30954, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31555") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:45306->127.0.0.1:31555, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31482") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50292->127.0.0.1:31482, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/05/21 04:16:45 INFO : dir/subdir: Making directory 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31549") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43562->127.0.0.1:31549, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31296") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:55716->127.0.0.1:31296, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30293") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42690->127.0.0.1:30293, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31963") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53554->127.0.0.1:31963, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31846") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57996->127.0.0.1:31846, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30544") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:56670->127.0.0.1:30544, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31816") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38022->127.0.0.1:31816, err= 2026/05/21 04:16:45 INFO : dir/subdir: Removing directory 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31530") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38758->127.0.0.1:31530, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30018") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:35946->127.0.0.1:30018, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31356") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:55800->127.0.0.1:31356, err= 2026/05/21 04:16:45 INFO : dir: Removing directory 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30023") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:45342->127.0.0.1:30023, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31760") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40874->127.0.0.1:31760, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30417") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:58082->127.0.0.1:30417, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31861") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:59996->127.0.0.1:31861, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30766") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53246->127.0.0.1:30766, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30267") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48218->127.0.0.1:30267, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30619") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50424->127.0.0.1:30619, err= 2026/05/21 04:16:45 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31482") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50306->127.0.0.1:31482, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31940") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:56924->127.0.0.1:31940, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:708: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30092") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33420->127.0.0.1:30092, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30750") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46922->127.0.0.1:30750, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30752") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:58918->127.0.0.1:30752, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31036") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:47824->127.0.0.1:31036, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30244") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42542->127.0.0.1:30244, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30064") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33196->127.0.0.1:30064, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31328") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:37790->127.0.0.1:31328, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30108") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46758->127.0.0.1:30108, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30428") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36046->127.0.0.1:30428, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31975") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:51332->127.0.0.1:31975, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30489") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:55542->127.0.0.1:30489, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:708: testing "." 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31366") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39464->127.0.0.1:31366, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30736") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:51950->127.0.0.1:30736, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31208") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57384->127.0.0.1:31208, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30679") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36604->127.0.0.1:30679, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31812") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:37236->127.0.0.1:31812, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30597") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:47322->127.0.0.1:30597, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30539") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36944->127.0.0.1:30539, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31461") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:45796->127.0.0.1:31461, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30406") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38552->127.0.0.1:30406, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31670") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:58956->127.0.0.1:31670, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31966") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:56100->127.0.0.1:31966, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:708: testing ".." 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31818") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42994->127.0.0.1:31818, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30465") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40860->127.0.0.1:30465, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30906") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:51576->127.0.0.1:30906, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31418") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53802->127.0.0.1:31418, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30196") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:60574->127.0.0.1:30196, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30267") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48228->127.0.0.1:30267, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31253") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:55166->127.0.0.1:31253, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30805") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43192->127.0.0.1:30805, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31657") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48922->127.0.0.1:31657, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30235") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:55664->127.0.0.1:30235, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31014") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:60134->127.0.0.1:31014, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:708: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31282") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33164->127.0.0.1:31282, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31093") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53246->127.0.0.1:31093, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31767") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:35078->127.0.0.1:31767, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30017") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:54338->127.0.0.1:30017, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30755") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:37890->127.0.0.1:30755, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30731") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:47620->127.0.0.1:30731, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30242") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:41272->127.0.0.1:30242, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30746") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:58122->127.0.0.1:30746, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31533") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:55652->127.0.0.1:31533, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30802") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:58398->127.0.0.1:30802, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31416") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:32794->127.0.0.1:31416, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:708: testing " leading space" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31327") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50438->127.0.0.1:31327, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30808") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:44238->127.0.0.1:30808, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31846") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:58002->127.0.0.1:31846, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31812") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:37248->127.0.0.1:31812, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30127") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:60288->127.0.0.1:30127, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31278") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:56796->127.0.0.1:31278, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30413") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:35580->127.0.0.1:30413, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31092") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:52682->127.0.0.1:31092, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31629") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43202->127.0.0.1:31629, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30777") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53942->127.0.0.1:30777, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30267") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48240->127.0.0.1:30267, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:708: testing "~leading tilde" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31170") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34148->127.0.0.1:31170, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30951") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36626->127.0.0.1:30951, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30003") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38598->127.0.0.1:30003, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31024") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50090->127.0.0.1:31024, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30460") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:54494->127.0.0.1:30460, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31269") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36936->127.0.0.1:31269, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31470") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33072->127.0.0.1:31470, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30820") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:32814->127.0.0.1:30820, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30934") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48870->127.0.0.1:30934, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31521") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:47552->127.0.0.1:31521, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30695") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50724->127.0.0.1:30695, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:708: testing "␍leading CR" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31352") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:44738->127.0.0.1:31352, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31371") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39458->127.0.0.1:31371, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30906") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:51590->127.0.0.1:30906, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30623") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:35994->127.0.0.1:30623, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31032") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:54996->127.0.0.1:31032, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30599") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:52426->127.0.0.1:30599, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30009") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48872->127.0.0.1:30009, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30851") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:56734->127.0.0.1:30851, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30218") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36538->127.0.0.1:30218, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30443") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34674->127.0.0.1:30443, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30336") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:54010->127.0.0.1:30336, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:708: testing "␊leading LF" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30465") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40868->127.0.0.1:30465, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31418") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53810->127.0.0.1:31418, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31066") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53836->127.0.0.1:31066, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30614") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:54110->127.0.0.1:30614, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30453") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:44046->127.0.0.1:30453, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30150") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:44846->127.0.0.1:30150, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31604") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43530->127.0.0.1:31604, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30590") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:45818->127.0.0.1:30590, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31696") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42198->127.0.0.1:31696, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30822") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43556->127.0.0.1:30822, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30552") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42178->127.0.0.1:30552, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:708: testing "␉leading HT" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31062") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:58236->127.0.0.1:31062, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30968") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40860->127.0.0.1:30968, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30784") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53720->127.0.0.1:30784, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30705") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:58420->127.0.0.1:30705, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31508") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46748->127.0.0.1:31508, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31929") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:52496->127.0.0.1:31929, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31737") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57306->127.0.0.1:31737, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30497") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40940->127.0.0.1:30497, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30684") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:35534->127.0.0.1:30684, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31324") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:52274->127.0.0.1:31324, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31634") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38374->127.0.0.1:31634, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:708: testing "␋leading VT" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31001") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:52074->127.0.0.1:31001, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30849") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40440->127.0.0.1:30849, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31293") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:49834->127.0.0.1:31293, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30855") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50072->127.0.0.1:30855, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31246") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43774->127.0.0.1:31246, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31165") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40588->127.0.0.1:31165, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30789") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50526->127.0.0.1:30789, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31009") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46524->127.0.0.1:31009, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30220") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:37320->127.0.0.1:30220, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31246") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43778->127.0.0.1:31246, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30291") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43558->127.0.0.1:30291, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:708: testing ".leading dot" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31411") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57658->127.0.0.1:31411, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31580") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38768->127.0.0.1:31580, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31937") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43966->127.0.0.1:31937, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30029") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40988->127.0.0.1:30029, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30557") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:45524->127.0.0.1:30557, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31265") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33140->127.0.0.1:31265, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31525") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38640->127.0.0.1:31525, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31519") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:52004->127.0.0.1:31519, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31663") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36818->127.0.0.1:31663, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31536") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:55436->127.0.0.1:31536, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30957") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:47808->127.0.0.1:30957, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:708: testing "trailing space " 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31164") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39868->127.0.0.1:31164, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30655") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:37806->127.0.0.1:30655, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31938") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:45858->127.0.0.1:31938, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31814") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:54854->127.0.0.1:31814, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31027") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34586->127.0.0.1:31027, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30907") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34430->127.0.0.1:30907, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31137") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40186->127.0.0.1:31137, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30598") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53048->127.0.0.1:30598, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31576") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:41168->127.0.0.1:31576, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31117") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36508->127.0.0.1:31117, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31556") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:37628->127.0.0.1:31556, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:708: testing "trailing CR␍" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30822") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43562->127.0.0.1:30822, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31859") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:55230->127.0.0.1:31859, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31793") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:60782->127.0.0.1:31793, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31672") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:59320->127.0.0.1:31672, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30445") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:49080->127.0.0.1:30445, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31401") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33146->127.0.0.1:31401, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31745") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:58386->127.0.0.1:31745, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30693") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:60252->127.0.0.1:30693, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30197") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40008->127.0.0.1:30197, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30369") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46124->127.0.0.1:30369, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31647") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38070->127.0.0.1:31647, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:708: testing "trailing LF␊" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31421") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:59966->127.0.0.1:31421, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30005") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33126->127.0.0.1:30005, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30417") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:58084->127.0.0.1:30417, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30237") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36246->127.0.0.1:30237, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31695") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53814->127.0.0.1:31695, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30048") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:49498->127.0.0.1:30048, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30904") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36892->127.0.0.1:30904, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30187") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:52874->127.0.0.1:30187, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30355") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36412->127.0.0.1:30355, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30040") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:37018->127.0.0.1:30040, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30601") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48520->127.0.0.1:30601, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:708: testing "trailing HT␉" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30959") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:51708->127.0.0.1:30959, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30844") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53866->127.0.0.1:30844, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31710") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39256->127.0.0.1:31710, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31538") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:52748->127.0.0.1:31538, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30321") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:41012->127.0.0.1:30321, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30745") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38280->127.0.0.1:30745, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30043") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:41994->127.0.0.1:30043, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31180") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46276->127.0.0.1:31180, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31591") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33964->127.0.0.1:31591, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31004") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57722->127.0.0.1:31004, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30601") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48526->127.0.0.1:30601, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:708: testing "trailing VT␋" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31538") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:52760->127.0.0.1:31538, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31268") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:45732->127.0.0.1:31268, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30663") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48400->127.0.0.1:30663, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31465") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:47024->127.0.0.1:31465, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30028") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:49768->127.0.0.1:30028, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31353") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:52916->127.0.0.1:31353, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31856") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36744->127.0.0.1:31856, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30858") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33070->127.0.0.1:30858, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30492") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34660->127.0.0.1:30492, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30136") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57884->127.0.0.1:30136, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30757") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57914->127.0.0.1:30757, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:708: testing "trailing dot." 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30630") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57102->127.0.0.1:30630, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31748") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:35304->127.0.0.1:31748, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30313") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:56704->127.0.0.1:30313, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31892") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:37162->127.0.0.1:31892, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30146") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:49134->127.0.0.1:30146, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31164") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39874->127.0.0.1:31164, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31076") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:32804->127.0.0.1:31076, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30768") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:52712->127.0.0.1:30768, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30579") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:44096->127.0.0.1:30579, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31755") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53572->127.0.0.1:31755, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31932") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42188->127.0.0.1:31932, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:708: testing "invalid utf-8\xfe" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31308") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57850->127.0.0.1:31308, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30397") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:58952->127.0.0.1:30397, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31353") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:52928->127.0.0.1:31353, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31485") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38114->127.0.0.1:31485, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30584") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:35102->127.0.0.1:30584, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31742") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39862->127.0.0.1:31742, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30325") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53780->127.0.0.1:30325, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31351") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36276->127.0.0.1:31351, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31951") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40110->127.0.0.1:31951, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30408") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:60480->127.0.0.1:30408, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30712") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34960->127.0.0.1:30712, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:708: testing "test%46.txt" 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30864") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43634->127.0.0.1:30864, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31797") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43838->127.0.0.1:31797, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30578") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42306->127.0.0.1:30578, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30939") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43818->127.0.0.1:30939, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31212") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:44100->127.0.0.1:31212, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30741") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:45776->127.0.0.1:30741, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30723") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:32842->127.0.0.1:30723, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30672") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:47126->127.0.0.1:30672, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30852") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36164->127.0.0.1:30852, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30514") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46826->127.0.0.1:30514, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30446") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:51466->127.0.0.1:30446, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30133") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36750->127.0.0.1:30133, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31151") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:44060->127.0.0.1:31151, err= === RUN TestIntegration/FsMkdir/FsPutError 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30921") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:55594->127.0.0.1:30921, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30253") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46742->127.0.0.1:30253, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31329") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39364->127.0.0.1:31329, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30270") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36538->127.0.0.1:30270, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30366") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38622->127.0.0.1:30366, err= 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31947") 2026/05/21 04:16:45 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:56840->127.0.0.1:31947, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: Connecting to FTP server 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:28622") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:49270->127.0.0.1:28622, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31642") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34998->127.0.0.1:31642, err= 2026/05/21 04:16:46 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30527") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38422->127.0.0.1:30527, err= === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31202") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42888->127.0.0.1:31202, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31010") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:51524->127.0.0.1:31010, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30576") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:60044->127.0.0.1:30576, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31568") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48724->127.0.0.1:31568, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30751") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:55802->127.0.0.1:30751, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30815") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39868->127.0.0.1:30815, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:787: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:820: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:873: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30408") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:60490->127.0.0.1:30408, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31634") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38378->127.0.0.1:31634, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30412") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:54218->127.0.0.1:30412, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30927") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40758->127.0.0.1:30927, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30129") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40754->127.0.0.1:30129, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31241") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:45382->127.0.0.1:31241, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31641") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:59134->127.0.0.1:31641, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31322") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:41822->127.0.0.1:31322, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30362") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:51346->127.0.0.1:30362, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31523") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40774->127.0.0.1:31523, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30772") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34874->127.0.0.1:30772, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30831") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43106->127.0.0.1:30831, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31579") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57350->127.0.0.1:31579, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31085") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34852->127.0.0.1:31085, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30440") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:47056->127.0.0.1:30440, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31111") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:55208->127.0.0.1:31111, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30081") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50264->127.0.0.1:30081, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31322") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:41836->127.0.0.1:31322, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31170") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34164->127.0.0.1:31170, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31853") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46638->127.0.0.1:31853, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31277") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:56184->127.0.0.1:31277, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31807") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43490->127.0.0.1:31807, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30571") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48584->127.0.0.1:30571, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30652") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39372->127.0.0.1:30652, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31072") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42846->127.0.0.1:31072, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30916") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:49008->127.0.0.1:30916, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/05/21 04:16:46 DEBUG : Creating backend with remote "TestFTPRclone:" 2026/05/21 04:16:46 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/05/21 04:16:46 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:46 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:46 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:46 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:46 DEBUG : TestFTPRclone: detected overridden config - adding "{569HL}" suffix to name 2026/05/21 04:16:46 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:46 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:46 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:46 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622: Connecting to FTP server 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:28622") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:49272->127.0.0.1:28622, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31164") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:39878->127.0.0.1:31164, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31483") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46452->127.0.0.1:31483, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31020") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43150->127.0.0.1:31020, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31624") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43188->127.0.0.1:31624, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31483") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46466->127.0.0.1:31483, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30259") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:49514->127.0.0.1:30259, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30027") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43928->127.0.0.1:30027, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31224") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48826->127.0.0.1:31224, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30704") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:58652->127.0.0.1:30704, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30383") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57506->127.0.0.1:30383, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31440") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34674->127.0.0.1:31440, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1126: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30168") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43304->127.0.0.1:30168, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31387") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34360->127.0.0.1:31387, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31221") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50562->127.0.0.1:31221, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31878") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:41126->127.0.0.1:31878, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30685") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:51730->127.0.0.1:30685, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31537") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:44182->127.0.0.1:31537, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1158: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1195: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/05/21 04:16:46 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-wudeyes0gocu/hello? sausage/êé" 2026/05/21 04:16:46 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/05/21 04:16:46 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:46 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:46 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:46 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:46 DEBUG : TestFTPRclone: detected overridden config - adding "{569HL}" suffix to name 2026/05/21 04:16:46 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:46 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:46 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:46 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: Connecting to FTP server 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:28622") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:49288->127.0.0.1:28622, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:31703") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:45726->127.0.0.1:31703, err= 2026/05/21 04:16:46 DEBUG : fs cache: renaming cache item "TestFTPRclone:rclone-test-wudeyes0gocu/hello? sausage/êé" to be canonical "TestFTPRclone{569HL}:rclone-test-wudeyes0gocu/hello? sausage/êé" 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:31880") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:43110->127.0.0.1:31880, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:31287") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:41244->127.0.0.1:31287, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:30066") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:32850->127.0.0.1:30066, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:30345") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:35572->127.0.0.1:30345, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:30914") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:49540->127.0.0.1:30914, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:30452") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:59814->127.0.0.1:30452, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: SetModTime is not supported 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:31577") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:39324->127.0.0.1:31577, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:31013") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:43036->127.0.0.1:31013, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:31418") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:53814->127.0.0.1:31418, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: Connecting to FTP server 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:30618") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:52304->127.0.0.1:30618, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:30179") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:33398->127.0.0.1:30179, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:28622") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:49290->127.0.0.1:28622, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:31964") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:44684->127.0.0.1:31964, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:30999") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:33494->127.0.0.1:30999, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:31315") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:58504->127.0.0.1:31315, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:31370") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:35932->127.0.0.1:31370, err= 2026/05/21 04:16:46 DEBUG : Waiting for deletions to finish 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:30095") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:52732->127.0.0.1:30095, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:30501") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:54758->127.0.0.1:30501, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:30207") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:40238->127.0.0.1:30207, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:31745") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:58394->127.0.0.1:31745, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:31780") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:40816->127.0.0.1:31780, err= 2026/05/21 04:16:46 INFO : a/b/c/d/e.txt: Deleted 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:30230") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:49242->127.0.0.1:30230, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:31813") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:40030->127.0.0.1:31813, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:30762") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:45710->127.0.0.1:30762, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:30803") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:34328->127.0.0.1:30803, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: dial("tcp","127.0.0.1:30189") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé: > dial: conn=127.0.0.1:43562->127.0.0.1:30189, err= 2026/05/21 04:16:46 DEBUG : removing 1 level 4 directories 2026/05/21 04:16:46 INFO : a/b/c/d: Removing directory 2026/05/21 04:16:46 DEBUG : removing 1 level 3 directories 2026/05/21 04:16:46 INFO : a/b/c: Removing directory 2026/05/21 04:16:46 DEBUG : removing 1 level 2 directories 2026/05/21 04:16:46 INFO : a/b: Removing directory 2026/05/21 04:16:46 DEBUG : removing 1 level 1 directories 2026/05/21 04:16:46 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1259: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31023") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46736->127.0.0.1:31023, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31699") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:55238->127.0.0.1:31699, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31283") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48370->127.0.0.1:31283, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30061") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42758->127.0.0.1:30061, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31930") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:56090->127.0.0.1:31930, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31608") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:58298->127.0.0.1:31608, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30398") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42120->127.0.0.1:30398, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30148") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:59638->127.0.0.1:30148, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31734") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39340->127.0.0.1:31734, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30201") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40378->127.0.0.1:30201, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31313") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40050->127.0.0.1:31313, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31543") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:47296->127.0.0.1:31543, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31518") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:60290->127.0.0.1:31518, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30706") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:44332->127.0.0.1:30706, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: Connecting to FTP server 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:28622") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:49292->127.0.0.1:28622, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30675") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34228->127.0.0.1:30675, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30754") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34974->127.0.0.1:30754, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30006") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34620->127.0.0.1:30006, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31287") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:41260->127.0.0.1:31287, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31764") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:32850->127.0.0.1:31764, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30333") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:35658->127.0.0.1:30333, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30547") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:54764->127.0.0.1:30547, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31798") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39438->127.0.0.1:31798, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30170") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:52686->127.0.0.1:30170, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31662") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53172->127.0.0.1:31662, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30843") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30128") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33252->127.0.0.1:30843, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50612->127.0.0.1:30128, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31260") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30249") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34190->127.0.0.1:31260, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36322->127.0.0.1:30249, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30245") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43596->127.0.0.1:30245, err= 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31090") 2026/05/21 04:16:46 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:35006->127.0.0.1:31090, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30081") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50266->127.0.0.1:30081, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31102") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:35980->127.0.0.1:31102, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30393") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36346->127.0.0.1:30393, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31737") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57312->127.0.0.1:31737, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30695") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50736->127.0.0.1:30695, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30463") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:55030->127.0.0.1:30463, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31168") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:47828->127.0.0.1:31168, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31353") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30945") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:52940->127.0.0.1:31353, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39838->127.0.0.1:30945, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30108") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46770->127.0.0.1:30108, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31534") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50940->127.0.0.1:31534, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1407: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31274") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:54768->127.0.0.1:31274, err= 2026/05/21 04:16:47 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-luruzag3fiti" 2026/05/21 04:16:47 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/05/21 04:16:47 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:47 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:47 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:47 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:47 DEBUG : TestFTPRclone: detected overridden config - adding "{569HL}" suffix to name 2026/05/21 04:16:47 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:47 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:47 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:47 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: Connecting to FTP server 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:28622") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:49296->127.0.0.1:28622, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:31896") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:43698->127.0.0.1:31896, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:30010") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:53788->127.0.0.1:30010, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:30608") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:43692->127.0.0.1:30608, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:31772") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:45944->127.0.0.1:31772, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30158") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39166->127.0.0.1:30158, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:30144") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:59104->127.0.0.1:30144, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:31706") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:52232->127.0.0.1:31706, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:30674") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:49556->127.0.0.1:30674, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:30713") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:35996->127.0.0.1:30713, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:31499") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:33334->127.0.0.1:31499, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:31284") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:48202->127.0.0.1:31284, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:31600") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:33098->127.0.0.1:31600, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31719") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57834->127.0.0.1:31719, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30459") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36102->127.0.0.1:30459, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31790") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36642->127.0.0.1:31790, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30703") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38910->127.0.0.1:30703, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31400") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:56520->127.0.0.1:31400, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30492") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34672->127.0.0.1:30492, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:30255") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:51658->127.0.0.1:30255, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:30959") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:51720->127.0.0.1:30959, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:30177") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:49780->127.0.0.1:30177, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:30310") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:58326->127.0.0.1:30310, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:31287") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:41264->127.0.0.1:31287, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: dial("tcp","127.0.0.1:31000") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: > dial: conn=127.0.0.1:43782->127.0.0.1:31000, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: Purge dir "new_name" 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-luruzag3fiti: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31289") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:60712->127.0.0.1:31289, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30729") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42586->127.0.0.1:30729, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31457") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46656->127.0.0.1:31457, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31050") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42004->127.0.0.1:31050, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31834") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:59712->127.0.0.1:31834, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30081") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50282->127.0.0.1:30081, err= fstests.go:1601: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30287") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:56770->127.0.0.1:30287, err= fstests.go:1632: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31646") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:53718->127.0.0.1:31646, err= fstests.go:1703: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31009") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46536->127.0.0.1:31009, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30031") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:41884->127.0.0.1:30031, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30291") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43570->127.0.0.1:30291, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30978") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38772->127.0.0.1:30978, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31395") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:44598->127.0.0.1:31395, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31689") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:60096->127.0.0.1:31689, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31406") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46322->127.0.0.1:31406, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31251") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40786->127.0.0.1:31251, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30673") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50662->127.0.0.1:30673, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31340") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:49212->127.0.0.1:31340, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30989") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:32800->127.0.0.1:30989, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31735") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38490->127.0.0.1:31735, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30961") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34554->127.0.0.1:30961, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31352") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:44754->127.0.0.1:31352, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30904") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36906->127.0.0.1:30904, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31747") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:60542->127.0.0.1:31747, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31468") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42086->127.0.0.1:31468, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30436") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:47454->127.0.0.1:30436, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30114") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34046->127.0.0.1:30114, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31448") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:37816->127.0.0.1:31448, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/05/21 04:16:47 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-wudeyes0gocu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/05/21 04:16:47 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/05/21 04:16:47 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:47 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:47 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:47 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:47 DEBUG : TestFTPRclone: detected overridden config - adding "{569HL}" suffix to name 2026/05/21 04:16:47 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:47 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:47 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:47 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:28622") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:49300->127.0.0.1:28622, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:30984") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:55024->127.0.0.1:30984, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:30695") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:50752->127.0.0.1:30695, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/05/21 04:16:47 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-wudeyes0gocu/not found.txt" 2026/05/21 04:16:47 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/05/21 04:16:47 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:47 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:47 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:47 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:47 DEBUG : TestFTPRclone: detected overridden config - adding "{569HL}" suffix to name 2026/05/21 04:16:47 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:47 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:47 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:47 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/not found.txt: Connecting to FTP server 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/not found.txt: dial("tcp","127.0.0.1:28622") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/not found.txt: > dial: conn=127.0.0.1:49302->127.0.0.1:28622, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/not found.txt: dial("tcp","127.0.0.1:31221") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/not found.txt: > dial: conn=127.0.0.1:50572->127.0.0.1:31221, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/not found.txt: dial("tcp","127.0.0.1:30183") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/not found.txt: > dial: conn=127.0.0.1:42008->127.0.0.1:30183, err= 2026/05/21 04:16:47 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1920: Opening root remote "TestFTPRclone:" path "rclone-test-wudeyes0gocu" from "TestFTPRclone:rclone-test-wudeyes0gocu" 2026/05/21 04:16:47 DEBUG : Creating backend with remote "TestFTPRclone:" 2026/05/21 04:16:47 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/05/21 04:16:47 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:47 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:47 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:47 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:47 DEBUG : TestFTPRclone: detected overridden config - adding "{569HL}" suffix to name 2026/05/21 04:16:47 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:47 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:47 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:47 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: Connecting to FTP server 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:28622") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:49316->127.0.0.1:28622, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30917") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:42758->127.0.0.1:30917, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31590") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:50672->127.0.0.1:31590, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31570") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:60818->127.0.0.1:31570, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31799") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:34102->127.0.0.1:31799, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30293") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:42692->127.0.0.1:30293, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30962") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:45554->127.0.0.1:30962, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1957: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30702") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:53890->127.0.0.1:30702, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30420") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:51034->127.0.0.1:30420, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: SetModTime is not supported 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31011") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:43026->127.0.0.1:31011, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30786") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:60588->127.0.0.1:30786, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30989") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:32814->127.0.0.1:30989, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31842") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:41490->127.0.0.1:31842, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30140") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:46594->127.0.0.1:30140, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31313") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:40060->127.0.0.1:31313, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31362") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:48594->127.0.0.1:31362, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31480") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:55566->127.0.0.1:31480, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30492") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:34674->127.0.0.1:30492, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30719") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:35876->127.0.0.1:30719, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30018") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:35958->127.0.0.1:30018, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30825") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:34906->127.0.0.1:30825, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30557") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:45538->127.0.0.1:30557, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2016: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2121: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2137: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31936") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36416->127.0.0.1:31936, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31521") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:47562->127.0.0.1:31521, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30121") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:43960->127.0.0.1:30121, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31262") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:35070->127.0.0.1:31262, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31308") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57860->127.0.0.1:31308, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30878") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:37560->127.0.0.1:30878, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30153") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:37954->127.0.0.1:30153, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2293: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31785") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46458->127.0.0.1:31785, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30935") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:54736->127.0.0.1:30935, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31911") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:45034->127.0.0.1:31911, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30806") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:47028->127.0.0.1:30806, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31112") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48048->127.0.0.1:31112, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31613") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33364->127.0.0.1:31613, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31590") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50674->127.0.0.1:31590, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30876") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:41202->127.0.0.1:30876, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30872") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38282->127.0.0.1:30872, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31968") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:60614->127.0.0.1:31968, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/05/21 04:16:47 DEBUG : Creating backend with remote "TestFTPRclone,concurrency='0',shut_timeout='1s':rclone-test-wudeyes0gocu" 2026/05/21 04:16:47 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/05/21 04:16:47 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:47 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:47 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:47 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:47 DEBUG : TestFTPRclone: detected overridden config - adding "{XYesv}" suffix to name 2026/05/21 04:16:47 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:47 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:47 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:47 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: Connecting to FTP server 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:28622") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:49328->127.0.0.1:28622, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30064") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33210->127.0.0.1:30064, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31214") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:35090->127.0.0.1:31214, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30177") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:49788->127.0.0.1:30177, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31826") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:42052->127.0.0.1:31826, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30136") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:57896->127.0.0.1:30136, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2376: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2488: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31058") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:60998->127.0.0.1:31058, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30691") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:51570->127.0.0.1:30691, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30735") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:35682->127.0.0.1:30735, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30841") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50094->127.0.0.1:30841, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31058") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:32768->127.0.0.1:31058, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30488") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:33152->127.0.0.1:30488, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30490") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:41934->127.0.0.1:30490, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31854") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:45212->127.0.0.1:31854, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31766") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39664->127.0.0.1:31766, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31434") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:54262->127.0.0.1:31434, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: SetModTime is not supported 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30569") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40946->127.0.0.1:30569, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30486") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39238->127.0.0.1:30486, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/05/21 04:16:47 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-wudeyes0gocu/deeper/nonexisting/directory" 2026/05/21 04:16:47 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/05/21 04:16:47 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:47 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:47 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:47 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:47 DEBUG : TestFTPRclone: detected overridden config - adding "{569HL}" suffix to name 2026/05/21 04:16:47 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/05/21 04:16:47 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/05/21 04:16:47 DEBUG : Setting pass="K4aXet__toCDgT9XcUpvawxsWeIPyLJE246k7t5fEEqh" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/05/21 04:16:47 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/deeper/nonexisting/directory: Connecting to FTP server 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/deeper/nonexisting/directory: dial("tcp","127.0.0.1:28622") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/deeper/nonexisting/directory: > dial: conn=127.0.0.1:49334->127.0.0.1:28622, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/deeper/nonexisting/directory: dial("tcp","127.0.0.1:30687") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/deeper/nonexisting/directory: > dial: conn=127.0.0.1:51758->127.0.0.1:30687, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/deeper/nonexisting/directory: dial("tcp","127.0.0.1:30126") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu/deeper/nonexisting/directory: > dial: conn=127.0.0.1:54280->127.0.0.1:30126, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2637: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2680: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2737: FS has no Directory methods and doesn't Wrap 2026/05/21 04:16:47 DEBUG : Waiting for deletions to finish 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30512") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:59500->127.0.0.1:30512, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30659") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:56054->127.0.0.1:30659, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31954") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:45098->127.0.0.1:31954, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30794") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:34482->127.0.0.1:30794, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31601") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:54670->127.0.0.1:31601, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30024") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:54248->127.0.0.1:30024, err= 2026/05/21 04:16:47 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31788") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38114->127.0.0.1:31788, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30465") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:40880->127.0.0.1:30465, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30827") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:38636->127.0.0.1:30827, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:30679") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:36610->127.0.0.1:30679, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31348") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:50576->127.0.0.1:31348, err= 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31112") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:48056->127.0.0.1:31112, err= 2026/05/21 04:16:47 DEBUG : removing 1 level 4 directories 2026/05/21 04:16:47 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/05/21 04:16:47 DEBUG : removing 1 level 3 directories 2026/05/21 04:16:47 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/05/21 04:16:47 DEBUG : removing 1 level 2 directories 2026/05/21 04:16:47 INFO : hello? sausage/êé: Removing directory 2026/05/21 04:16:47 DEBUG : removing 1 level 1 directories 2026/05/21 04:16:47 INFO : hello? sausage: Removing directory 2026/05/21 04:16:47 DEBUG : removing 1 level 0 directories 2026/05/21 04:16:47 INFO : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: Removing directory 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31410") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:44476->127.0.0.1:31410, err= 2026/05/21 04:16:47 ERROR : error listing: directory not found 2026/05/21 04:16:47 DEBUG : Waiting for deletions to finish 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31088") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:46318->127.0.0.1:31088, err= 2026/05/21 04:16:47 ERROR : error listing: directory not found 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: dial("tcp","127.0.0.1:31259") 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: > dial: conn=127.0.0.1:39900->127.0.0.1:31259, err= 2026/05/21 04:16:47 ERROR : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: Failed to list "": directory not found 2026/05/21 04:16:47 DEBUG : removing 1 level 0 directories 2026/05/21 04:16:47 INFO : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: Removing directory 2026/05/21 04:16:47 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/05/21 04:16:47 DEBUG : ftp://127.0.0.1:28622/rclone-test-wudeyes0gocu: closing 2 unused connections 2026/05/21 04:16:47 NOTICE: TestFTPRclone: Stopping server --- PASS: TestIntegration (3.24s) --- 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.21s) --- 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.14s) --- 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.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.00s) --- 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.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.00s) --- 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.02s) --- 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/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.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.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.252s "go test -v -timeout 1h0m0s -remote TestFTPRclone: -verbose" - Finished OK in 4.138256658s (try 1/5)