"go test -v -timeout 1h0m0s -remote TestFTPRclone: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPRclone:" 2025/10/02 03:33:21 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-vuxodur5duvi" 2025/10/02 03:33:21 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/02 03:33:21 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/10/02 03:33:21 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:21 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:21 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:21 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:21 DEBUG : TestFTPRclone: detected overridden config - adding "{bn_EK}" suffix to name 2025/10/02 03:33:21 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:21 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:21 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:21 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: Connecting to FTP server 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:28622") 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52776->127.0.0.1:28622, err= 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30353") 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57488->127.0.0.1:30353, err= 2025/10/02 03:33:21 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 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31004") 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:55540->127.0.0.1:31004, err= 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31340") 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:49652->127.0.0.1:31340, err= 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30543") 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59806->127.0.0.1:30543, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30966") 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:44632->127.0.0.1:30966, err= 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31256") 2025/10/02 03:33:21 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:60916->127.0.0.1:31256, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30954") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38300->127.0.0.1:30954, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30575") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59170->127.0.0.1:30575, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/10/02 03:33:22 INFO : dir/subdir: Making directory 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31196") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:56108->127.0.0.1:31196, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31378") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:43226->127.0.0.1:31378, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31120") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:49718->127.0.0.1:31120, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30984") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:49092->127.0.0.1:30984, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30589") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52142->127.0.0.1:30589, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31557") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:51504->127.0.0.1:31557, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30952") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:39436->127.0.0.1:30952, err= 2025/10/02 03:33:22 INFO : dir/subdir: Removing directory 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30748") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:41418->127.0.0.1:30748, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31112") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37044->127.0.0.1:31112, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30466") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36430->127.0.0.1:30466, err= 2025/10/02 03:33:22 INFO : dir: Removing directory 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30019") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:55360->127.0.0.1:30019, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30053") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:51678->127.0.0.1:30053, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30799") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:42762->127.0.0.1:30799, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31933") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:60984->127.0.0.1:31933, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30119") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58016->127.0.0.1:30119, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31955") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58290->127.0.0.1:31955, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31059") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47136->127.0.0.1:31059, err= 2025/10/02 03:33:22 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31911") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35960->127.0.0.1:31911, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31596") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38404->127.0.0.1:31596, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30939") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:55812->127.0.0.1:30939, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30460") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53704->127.0.0.1:30460, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31518") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57728->127.0.0.1:31518, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31781") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52700->127.0.0.1:31781, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30950") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36182->127.0.0.1:30950, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30082") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33034->127.0.0.1:30082, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30050") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33194->127.0.0.1:30050, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30387") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47932->127.0.0.1:30387, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30563") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38086->127.0.0.1:30563, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31193") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:56384->127.0.0.1:31193, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30516") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46522->127.0.0.1:30516, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31686") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:56686->127.0.0.1:31686, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31448") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:42292->127.0.0.1:31448, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30433") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:43940->127.0.0.1:30433, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31884") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53908->127.0.0.1:31884, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31141") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:41052->127.0.0.1:31141, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30615") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47628->127.0.0.1:30615, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30622") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57562->127.0.0.1:30622, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30546") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:40522->127.0.0.1:30546, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31381") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35464->127.0.0.1:31381, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31102") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33926->127.0.0.1:31102, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31194") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:55868->127.0.0.1:31194, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31400") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:60480->127.0.0.1:31400, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30374") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:34258->127.0.0.1:30374, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30390") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47874->127.0.0.1:30390, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30902") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38200->127.0.0.1:30902, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31318") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:42568->127.0.0.1:31318, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31471") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38234->127.0.0.1:31471, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30296") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35094->127.0.0.1:30296, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30547") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46086->127.0.0.1:30547, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31502") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52838->127.0.0.1:31502, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31071") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57128->127.0.0.1:31071, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30715") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37926->127.0.0.1:30715, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31300") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57248->127.0.0.1:31300, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30996") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35426->127.0.0.1:30996, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30679") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:56010->127.0.0.1:30679, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31182") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:32816->127.0.0.1:31182, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30467") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52326->127.0.0.1:30467, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31932") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:54790->127.0.0.1:31932, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31160") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:43940->127.0.0.1:31160, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30530") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36498->127.0.0.1:30530, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31955") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58302->127.0.0.1:31955, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30381") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38250->127.0.0.1:30381, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31642") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:50816->127.0.0.1:31642, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30477") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59154->127.0.0.1:30477, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30788") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47426->127.0.0.1:30788, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31542") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38786->127.0.0.1:31542, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30129") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:40874->127.0.0.1:30129, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30524") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47992->127.0.0.1:30524, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31357") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59654->127.0.0.1:31357, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31010") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46134->127.0.0.1:31010, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30337") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:41826->127.0.0.1:30337, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30281") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:54552->127.0.0.1:30281, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31225") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:51040->127.0.0.1:31225, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31198") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:44394->127.0.0.1:31198, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30915") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58362->127.0.0.1:30915, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30915") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58364->127.0.0.1:30915, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31351") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37860->127.0.0.1:31351, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30989") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46668->127.0.0.1:30989, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31723") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46162->127.0.0.1:31723, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31551") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53010->127.0.0.1:31551, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31895") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52552->127.0.0.1:31895, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31072") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35462->127.0.0.1:31072, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30167") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38142->127.0.0.1:30167, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30555") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:39882->127.0.0.1:30555, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31246") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38230->127.0.0.1:31246, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30850") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52994->127.0.0.1:30850, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31419") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:51200->127.0.0.1:31419, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30090") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:50448->127.0.0.1:30090, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31173") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:51464->127.0.0.1:31173, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30837") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:45920->127.0.0.1:30837, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30170") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48906->127.0.0.1:30170, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31122") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:40352->127.0.0.1:31122, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31196") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:56110->127.0.0.1:31196, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30693") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37072->127.0.0.1:30693, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30481") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35416->127.0.0.1:30481, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31632") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36650->127.0.0.1:31632, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30977") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:51710->127.0.0.1:30977, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30241") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37210->127.0.0.1:30241, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31850") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46296->127.0.0.1:31850, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30892") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:34098->127.0.0.1:30892, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31501") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:42510->127.0.0.1:31501, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30775") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47400->127.0.0.1:30775, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31318") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:42578->127.0.0.1:31318, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31350") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36650->127.0.0.1:31350, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31946") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46904->127.0.0.1:31946, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30150") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37770->127.0.0.1:30150, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31469") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:50590->127.0.0.1:31469, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30546") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:40536->127.0.0.1:30546, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30048") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38822->127.0.0.1:30048, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30986") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:42604->127.0.0.1:30986, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30868") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37844->127.0.0.1:30868, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30727") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46658->127.0.0.1:30727, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30513") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48718->127.0.0.1:30513, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30100") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36054->127.0.0.1:30100, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30443") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57198->127.0.0.1:30443, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31800") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36732->127.0.0.1:31800, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30630") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:43540->127.0.0.1:30630, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31851") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:39140->127.0.0.1:31851, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30532") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35000->127.0.0.1:30532, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30658") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:34566->127.0.0.1:30658, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31850") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46308->127.0.0.1:31850, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30723") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35796->127.0.0.1:30723, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30966") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:44648->127.0.0.1:30966, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31733") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59844->127.0.0.1:31733, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30780") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:34564->127.0.0.1:30780, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30627") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36406->127.0.0.1:30627, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31588") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46656->127.0.0.1:31588, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31757") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57910->127.0.0.1:31757, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31785") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:56690->127.0.0.1:31785, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30849") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:45280->127.0.0.1:30849, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31938") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59770->127.0.0.1:31938, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30378") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:45836->127.0.0.1:30378, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31794") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:56466->127.0.0.1:31794, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30167") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38156->127.0.0.1:30167, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31775") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46182->127.0.0.1:31775, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31290") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:51798->127.0.0.1:31290, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30525") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:56118->127.0.0.1:30525, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31385") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38362->127.0.0.1:31385, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30840") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:32964->127.0.0.1:30840, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31515") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:50896->127.0.0.1:31515, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30846") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46446->127.0.0.1:30846, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30958") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48430->127.0.0.1:30958, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30152") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38356->127.0.0.1:30152, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30495") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:55692->127.0.0.1:30495, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30299") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:60560->127.0.0.1:30299, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31632") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36662->127.0.0.1:31632, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31581") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:42990->127.0.0.1:31581, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31952") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33202->127.0.0.1:31952, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31412") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38836->127.0.0.1:31412, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31262") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52736->127.0.0.1:31262, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30675") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48046->127.0.0.1:30675, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30523") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52632->127.0.0.1:30523, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31168") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48794->127.0.0.1:31168, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31466") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58858->127.0.0.1:31466, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30891") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58796->127.0.0.1:30891, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30493") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37120->127.0.0.1:30493, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30034") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47840->127.0.0.1:30034, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31286") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:40902->127.0.0.1:31286, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31199") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:51520->127.0.0.1:31199, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30266") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38272->127.0.0.1:30266, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30839") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48164->127.0.0.1:30839, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31827") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33790->127.0.0.1:31827, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31101") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:55152->127.0.0.1:31101, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30220") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:41568->127.0.0.1:30220, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31350") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36664->127.0.0.1:31350, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31566") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59128->127.0.0.1:31566, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30440") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52486->127.0.0.1:30440, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31792") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57054->127.0.0.1:31792, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31594") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:49838->127.0.0.1:31594, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31594") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:49844->127.0.0.1:31594, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30491") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36184->127.0.0.1:30491, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31105") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36794->127.0.0.1:31105, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31165") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:54568->127.0.0.1:31165, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30912") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59822->127.0.0.1:30912, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30223") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38912->127.0.0.1:30223, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30154") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37736->127.0.0.1:30154, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30612") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:49538->127.0.0.1:30612, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31271") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:41520->127.0.0.1:31271, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30937") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47040->127.0.0.1:30937, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30256") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33952->127.0.0.1:30256, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31041") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46578->127.0.0.1:31041, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31978") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53096->127.0.0.1:31978, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31118") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:60116->127.0.0.1:31118, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30017") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:34496->127.0.0.1:30017, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30801") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:60852->127.0.0.1:30801, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30408") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46092->127.0.0.1:30408, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30226") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52358->127.0.0.1:30226, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30586") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:50670->127.0.0.1:30586, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30466") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36436->127.0.0.1:30466, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30925") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:45088->127.0.0.1:30925, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30423") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48516->127.0.0.1:30423, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31560") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:42370->127.0.0.1:31560, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30327") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52852->127.0.0.1:30327, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31554") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:50458->127.0.0.1:31554, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31630") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48950->127.0.0.1:31630, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31750") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57020->127.0.0.1:31750, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31354") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:34042->127.0.0.1:31354, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31047") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:42254->127.0.0.1:31047, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30666") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59950->127.0.0.1:30666, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31182") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:32820->127.0.0.1:31182, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30434") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53856->127.0.0.1:30434, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30483") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:40246->127.0.0.1:30483, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31473") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36760->127.0.0.1:31473, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30613") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36578->127.0.0.1:30613, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31737") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37184->127.0.0.1:31737, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31124") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58338->127.0.0.1:31124, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31315") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:40314->127.0.0.1:31315, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30781") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53792->127.0.0.1:30781, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30486") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:39088->127.0.0.1:30486, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30304") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:45036->127.0.0.1:30304, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30941") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:50602->127.0.0.1:30941, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30217") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35864->127.0.0.1:30217, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31038") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38856->127.0.0.1:31038, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31519") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:54658->127.0.0.1:31519, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31760") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59974->127.0.0.1:31760, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31725") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:42384->127.0.0.1:31725, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30453") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58880->127.0.0.1:30453, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31583") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46396->127.0.0.1:31583, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30347") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59204->127.0.0.1:30347, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31186") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:44788->127.0.0.1:31186, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31624") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47402->127.0.0.1:31624, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31117") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46908->127.0.0.1:31117, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31922") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48168->127.0.0.1:31922, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31032") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46966->127.0.0.1:31032, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31710") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:56594->127.0.0.1:31710, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30555") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:39884->127.0.0.1:30555, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31295") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33256->127.0.0.1:31295, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30745") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36486->127.0.0.1:30745, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30506") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53174->127.0.0.1:30506, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30099") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:40312->127.0.0.1:30099, err= === RUN TestIntegration/FsMkdir/FsPutError 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30098") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:34026->127.0.0.1:30098, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30996") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35432->127.0.0.1:30996, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30749") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:54872->127.0.0.1:30749, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30590") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59586->127.0.0.1:30590, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31751") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52692->127.0.0.1:31751, err= 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30920") 2025/10/02 03:33:22 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:34248->127.0.0.1:30920, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: Connecting to FTP server 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:28622") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52782->127.0.0.1:28622, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30329") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:42480->127.0.0.1:30329, err= 2025/10/02 03:33:23 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30804") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:44716->127.0.0.1:30804, err= === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31927") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57746->127.0.0.1:31927, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31884") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53914->127.0.0.1:31884, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31879") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:45482->127.0.0.1:31879, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30294") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33246->127.0.0.1:30294, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31564") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59564->127.0.0.1:31564, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30731") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:40570->127.0.0.1:30731, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31205") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37998->127.0.0.1:31205, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31534") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36048->127.0.0.1:31534, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31094") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46646->127.0.0.1:31094, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30254") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:41976->127.0.0.1:30254, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31344") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:41668->127.0.0.1:31344, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30254") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:41980->127.0.0.1:30254, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31128") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:34234->127.0.0.1:31128, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30792") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37718->127.0.0.1:30792, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31305") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38804->127.0.0.1:31305, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30880") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59218->127.0.0.1:30880, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30095") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33336->127.0.0.1:30095, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30569") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:55362->127.0.0.1:30569, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31009") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33846->127.0.0.1:31009, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31739") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58690->127.0.0.1:31739, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31374") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:34786->127.0.0.1:31374, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30070") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35730->127.0.0.1:30070, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30992") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59036->127.0.0.1:30992, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30166") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:43956->127.0.0.1:30166, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31539") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:55124->127.0.0.1:31539, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31452") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37450->127.0.0.1:31452, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30728") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:51426->127.0.0.1:30728, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30381") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38266->127.0.0.1:30381, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30666") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59958->127.0.0.1:30666, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31512") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38066->127.0.0.1:31512, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31229") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:43208->127.0.0.1:31229, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30248") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:40054->127.0.0.1:30248, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/10/02 03:33:23 DEBUG : Creating backend with remote "TestFTPRclone:" 2025/10/02 03:33:23 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/10/02 03:33:23 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:23 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:23 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:23 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:23 DEBUG : TestFTPRclone: detected overridden config - adding "{bn_EK}" suffix to name 2025/10/02 03:33:23 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:23 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:23 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:23 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: Connecting to FTP server 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:28622") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:52796->127.0.0.1:28622, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31739") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:58702->127.0.0.1:31739, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31377") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52882->127.0.0.1:31377, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31257") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48376->127.0.0.1:31257, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31815") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37772->127.0.0.1:31815, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31741") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37878->127.0.0.1:31741, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30743") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58498->127.0.0.1:30743, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31344") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:41678->127.0.0.1:31344, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31098") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:56534->127.0.0.1:31098, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30577") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:39226->127.0.0.1:30577, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31928") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35754->127.0.0.1:31928, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30196") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:55722->127.0.0.1:30196, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31943") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:34290->127.0.0.1:31943, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31987") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48010->127.0.0.1:31987, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31895") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52558->127.0.0.1:31895, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30756") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:60628->127.0.0.1:30756, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31208") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:45016->127.0.0.1:31208, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31123") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:34530->127.0.0.1:31123, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1153: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1190: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/10/02 03:33:23 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-vuxodur5duvi/hello? sausage/êé" 2025/10/02 03:33:23 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/10/02 03:33:23 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:23 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:23 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:23 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:23 DEBUG : TestFTPRclone: detected overridden config - adding "{bn_EK}" suffix to name 2025/10/02 03:33:23 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:23 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:23 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:23 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: Connecting to FTP server 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:28622") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:52806->127.0.0.1:28622, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30755") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:37808->127.0.0.1:30755, err= 2025/10/02 03:33:23 DEBUG : fs cache: renaming cache item "TestFTPRclone:rclone-test-vuxodur5duvi/hello? sausage/êé" to be canonical "TestFTPRclone{bn_EK}:rclone-test-vuxodur5duvi/hello? sausage/êé" 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:31650") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:48882->127.0.0.1:31650, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:31437") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:48700->127.0.0.1:31437, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30209") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:54410->127.0.0.1:30209, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:31830") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:54400->127.0.0.1:31830, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30182") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:55052->127.0.0.1:30182, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30531") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:55352->127.0.0.1:30531, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: SetModTime is not supported 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30711") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:41520->127.0.0.1:30711, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:31988") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:50824->127.0.0.1:31988, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30855") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:50756->127.0.0.1:30855, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: Connecting to FTP server 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:28622") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:52818->127.0.0.1:28622, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30495") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:55694->127.0.0.1:30495, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30034") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:47842->127.0.0.1:30034, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:31464") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:31979") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:56404->127.0.0.1:31464, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:35706->127.0.0.1:31979, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30879") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:42362->127.0.0.1:30879, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30652") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:48882->127.0.0.1:30652, err= 2025/10/02 03:33:23 DEBUG : Waiting for deletions to finish 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30264") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:39226->127.0.0.1:30264, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30844") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:45880->127.0.0.1:30844, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:31517") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:53436->127.0.0.1:31517, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30620") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:47244->127.0.0.1:30620, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:31958") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:36328->127.0.0.1:31958, err= 2025/10/02 03:33:23 INFO : a/b/c/d/e.txt: Deleted 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:31839") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:53010->127.0.0.1:31839, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30619") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:37494->127.0.0.1:30619, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:31705") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:53570->127.0.0.1:31705, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:30027") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:38788->127.0.0.1:30027, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: dial("tcp","127.0.0.1:31756") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé: > dial: conn=127.0.0.1:59832->127.0.0.1:31756, err= 2025/10/02 03:33:23 DEBUG : removing 1 level 4 directories 2025/10/02 03:33:23 INFO : a/b/c/d: Removing directory 2025/10/02 03:33:23 DEBUG : removing 1 level 3 directories 2025/10/02 03:33:23 INFO : a/b/c: Removing directory 2025/10/02 03:33:23 DEBUG : removing 1 level 2 directories 2025/10/02 03:33:23 INFO : a/b: Removing directory 2025/10/02 03:33:23 DEBUG : removing 1 level 1 directories 2025/10/02 03:33:23 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31003") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:49472->127.0.0.1:31003, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31181") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59174->127.0.0.1:31181, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30686") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36752->127.0.0.1:30686, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31804") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47400->127.0.0.1:31804, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30118") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38694->127.0.0.1:30118, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30705") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:49518->127.0.0.1:30705, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30705") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:49528->127.0.0.1:30705, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31462") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53802->127.0.0.1:31462, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30099") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:40322->127.0.0.1:30099, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31261") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48770->127.0.0.1:31261, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30877") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:39316->127.0.0.1:30877, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31307") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58008->127.0.0.1:31307, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30840") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:32970->127.0.0.1:30840, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30063") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:54258->127.0.0.1:30063, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: Connecting to FTP server 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:28622") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52832->127.0.0.1:28622, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31384") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58566->127.0.0.1:31384, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31457") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53208->127.0.0.1:31457, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30667") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35574->127.0.0.1:30667, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31226") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58984->127.0.0.1:31226, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31555") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:32848->127.0.0.1:31555, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30174") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38472->127.0.0.1:30174, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31527") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46746->127.0.0.1:31527, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31924") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:44710->127.0.0.1:31924, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31880") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57160->127.0.0.1:31880, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31031") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46648->127.0.0.1:31031, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30748") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31794") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:56474->127.0.0.1:31794, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:41422->127.0.0.1:30748, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31111") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31076") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33716->127.0.0.1:31076, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:56620->127.0.0.1:31111, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31631") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52688->127.0.0.1:31631, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31837") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:55900->127.0.0.1:31837, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31812") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:54714->127.0.0.1:31812, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31833") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52256->127.0.0.1:31833, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31597") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46064->127.0.0.1:31597, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30501") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:42122->127.0.0.1:30501, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30132") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:60218->127.0.0.1:30132, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30945") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53262->127.0.0.1:30945, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30417") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36956->127.0.0.1:30417, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31568") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:43022->127.0.0.1:31568, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30020") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46110->127.0.0.1:30020, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31576") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37426->127.0.0.1:31576, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31696") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:39982->127.0.0.1:31696, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31293") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52874->127.0.0.1:31293, err= 2025/10/02 03:33:23 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-zasohug9maqi" 2025/10/02 03:33:23 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/10/02 03:33:23 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:23 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:23 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:23 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:23 DEBUG : TestFTPRclone: detected overridden config - adding "{bn_EK}" suffix to name 2025/10/02 03:33:23 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:23 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:23 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:23 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: Connecting to FTP server 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:28622") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:52846->127.0.0.1:28622, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:30977") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:51720->127.0.0.1:30977, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:30256") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:33960->127.0.0.1:30256, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:31924") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:44714->127.0.0.1:31924, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:30660") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:46044->127.0.0.1:30660, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30674") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46692->127.0.0.1:30674, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:30825") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:52318->127.0.0.1:30825, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:31382") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:44544->127.0.0.1:31382, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:30279") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:38206->127.0.0.1:30279, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:31470") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:36086->127.0.0.1:31470, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:31447") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:52614->127.0.0.1:31447, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:30149") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:45860->127.0.0.1:30149, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:30116") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:55686->127.0.0.1:30116, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31222") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47406->127.0.0.1:31222, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30624") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:49784->127.0.0.1:30624, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30824") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57552->127.0.0.1:30824, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31734") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:55184->127.0.0.1:31734, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31038") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38858->127.0.0.1:31038, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30024") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47550->127.0.0.1:30024, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:30221") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:47578->127.0.0.1:30221, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:31825") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:37686->127.0.0.1:31825, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:31578") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:51862->127.0.0.1:31578, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:30644") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:34110->127.0.0.1:30644, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:30405") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:53960->127.0.0.1:30405, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: dial("tcp","127.0.0.1:30379") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: > dial: conn=127.0.0.1:53608->127.0.0.1:30379, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: Purge dir "new_name" 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-zasohug9maqi: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31757") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57912->127.0.0.1:31757, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30995") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52096->127.0.0.1:30995, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31576") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37432->127.0.0.1:31576, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30926") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:39456->127.0.0.1:30926, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30938") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47740->127.0.0.1:30938, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30911") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48988->127.0.0.1:30911, err= fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31955") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58310->127.0.0.1:31955, err= fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31050") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:43792->127.0.0.1:31050, err= fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30317") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:49816->127.0.0.1:30317, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31449") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53718->127.0.0.1:31449, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30856") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48536->127.0.0.1:30856, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31577") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35690->127.0.0.1:31577, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31149") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:56564->127.0.0.1:31149, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30631") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46098->127.0.0.1:30631, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31235") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52070->127.0.0.1:31235, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30721") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36538->127.0.0.1:30721, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31789") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:60344->127.0.0.1:31789, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31440") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53334->127.0.0.1:31440, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30219") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46020->127.0.0.1:30219, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31657") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:34846->127.0.0.1:31657, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30790") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:60564->127.0.0.1:30790, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30106") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:49568->127.0.0.1:30106, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31806") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:39494->127.0.0.1:31806, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30928") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38412->127.0.0.1:30928, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31656") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:34096->127.0.0.1:31656, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31597") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46066->127.0.0.1:31597, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31181") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59176->127.0.0.1:31181, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30890") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46888->127.0.0.1:30890, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/10/02 03:33:23 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-vuxodur5duvi/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/10/02 03:33:23 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/10/02 03:33:23 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:23 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:23 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:23 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:23 DEBUG : TestFTPRclone: detected overridden config - adding "{bn_EK}" suffix to name 2025/10/02 03:33:23 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:23 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:23 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:23 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:28622") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:52858->127.0.0.1:28622, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:31201") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:47790->127.0.0.1:31201, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:31819") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:34818->127.0.0.1:31819, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/10/02 03:33:23 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-vuxodur5duvi/not found.txt" 2025/10/02 03:33:23 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/10/02 03:33:23 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:23 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:23 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:23 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:23 DEBUG : TestFTPRclone: detected overridden config - adding "{bn_EK}" suffix to name 2025/10/02 03:33:23 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:23 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:23 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:23 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/not found.txt: Connecting to FTP server 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/not found.txt: dial("tcp","127.0.0.1:28622") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/not found.txt: > dial: conn=127.0.0.1:52868->127.0.0.1:28622, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/not found.txt: dial("tcp","127.0.0.1:30760") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/not found.txt: > dial: conn=127.0.0.1:39388->127.0.0.1:30760, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/not found.txt: dial("tcp","127.0.0.1:31427") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/not found.txt: > dial: conn=127.0.0.1:53860->127.0.0.1:31427, err= 2025/10/02 03:33:23 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPRclone:" path "rclone-test-vuxodur5duvi" from "TestFTPRclone:rclone-test-vuxodur5duvi" 2025/10/02 03:33:23 DEBUG : Creating backend with remote "TestFTPRclone:" 2025/10/02 03:33:23 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/10/02 03:33:23 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:23 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:23 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:23 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:23 DEBUG : TestFTPRclone: detected overridden config - adding "{bn_EK}" suffix to name 2025/10/02 03:33:23 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:23 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:23 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:23 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: Connecting to FTP server 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:28622") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:52878->127.0.0.1:28622, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30834") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:35322->127.0.0.1:30834, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30462") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:59292->127.0.0.1:30462, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30203") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:51804->127.0.0.1:30203, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30052") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:47198->127.0.0.1:30052, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30962") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:39742->127.0.0.1:30962, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30583") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:58178->127.0.0.1:30583, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31520") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:41958->127.0.0.1:31520, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31943") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:34306->127.0.0.1:31943, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: SetModTime is not supported 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31318") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:42590->127.0.0.1:31318, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30819") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:58308->127.0.0.1:30819, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30739") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:37946->127.0.0.1:30739, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30756") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:60630->127.0.0.1:30756, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31349") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:53998->127.0.0.1:31349, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31330") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:49364->127.0.0.1:31330, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30953") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:33400->127.0.0.1:30953, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30619") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:37510->127.0.0.1:30619, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30391") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:51742->127.0.0.1:30391, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31462") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:53816->127.0.0.1:31462, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31544") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:42776->127.0.0.1:31544, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31216") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:58650->127.0.0.1:31216, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30959") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:46676->127.0.0.1:30959, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2004: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2109: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30854") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57558->127.0.0.1:30854, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31645") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:39898->127.0.0.1:31645, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31405") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57328->127.0.0.1:31405, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31079") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47096->127.0.0.1:31079, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30235") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:41628->127.0.0.1:30235, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30750") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35704->127.0.0.1:30750, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31589") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:58890->127.0.0.1:31589, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2281: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30693") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37088->127.0.0.1:30693, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30977") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:51732->127.0.0.1:30977, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31235") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52086->127.0.0.1:31235, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31105") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36806->127.0.0.1:31105, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31545") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53712->127.0.0.1:31545, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31482") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38798->127.0.0.1:31482, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31063") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:54564->127.0.0.1:31063, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31873") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:43844->127.0.0.1:31873, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30462") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:59306->127.0.0.1:30462, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31110") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:50918->127.0.0.1:31110, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/10/02 03:33:23 DEBUG : Creating backend with remote "TestFTPRclone,concurrency='0',shut_timeout='1s':rclone-test-vuxodur5duvi" 2025/10/02 03:33:23 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/10/02 03:33:23 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:23 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:23 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:23 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:23 DEBUG : TestFTPRclone: detected overridden config - adding "{wwdKd}" suffix to name 2025/10/02 03:33:23 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:23 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:23 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:23 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: Connecting to FTP server 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:28622") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:52890->127.0.0.1:28622, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30078") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36800->127.0.0.1:30078, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30807") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48834->127.0.0.1:30807, err= 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31690") 2025/10/02 03:33:23 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47096->127.0.0.1:31690, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31051") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:51182->127.0.0.1:31051, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31675") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33796->127.0.0.1:31675, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2476: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30931") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35810->127.0.0.1:30931, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31548") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:36698->127.0.0.1:31548, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30665") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:45052->127.0.0.1:30665, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31948") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:57732->127.0.0.1:31948, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30971") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53704->127.0.0.1:30971, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31008") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:39334->127.0.0.1:31008, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30697") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48222->127.0.0.1:30697, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30158") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:50422->127.0.0.1:30158, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30978") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35730->127.0.0.1:30978, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31729") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33766->127.0.0.1:31729, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: SetModTime is not supported 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31636") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:35162->127.0.0.1:31636, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31319") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38562->127.0.0.1:31319, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/02 03:33:24 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-vuxodur5duvi/deeper/nonexisting/directory" 2025/10/02 03:33:24 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/10/02 03:33:24 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:24 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:24 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:24 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:24 DEBUG : TestFTPRclone: detected overridden config - adding "{bn_EK}" suffix to name 2025/10/02 03:33:24 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/10/02 03:33:24 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/10/02 03:33:24 DEBUG : Setting pass="fmyg0V7NLX-_S3AP-qLCMEQfxodLnux3rm4hoo2BoZ-y" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/10/02 03:33:24 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/deeper/nonexisting/directory: Connecting to FTP server 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/deeper/nonexisting/directory: dial("tcp","127.0.0.1:28622") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/deeper/nonexisting/directory: > dial: conn=127.0.0.1:52900->127.0.0.1:28622, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/deeper/nonexisting/directory: dial("tcp","127.0.0.1:30472") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/deeper/nonexisting/directory: > dial: conn=127.0.0.1:54710->127.0.0.1:30472, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/deeper/nonexisting/directory: dial("tcp","127.0.0.1:31587") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi/deeper/nonexisting/directory: > dial: conn=127.0.0.1:54032->127.0.0.1:31587, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/10/02 03:33:24 DEBUG : Waiting for deletions to finish 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31341") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33704->127.0.0.1:31341, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30619") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:37518->127.0.0.1:30619, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30040") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:47634->127.0.0.1:30040, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31784") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38126->127.0.0.1:31784, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31472") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:33336->127.0.0.1:31472, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30081") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:38356->127.0.0.1:30081, err= 2025/10/02 03:33:24 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30186") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:41650->127.0.0.1:30186, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31302") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:43266->127.0.0.1:31302, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30068") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:42326->127.0.0.1:30068, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31839") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:53024->127.0.0.1:31839, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31099") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:60080->127.0.0.1:31099, err= 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30020") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:46124->127.0.0.1:30020, err= 2025/10/02 03:33:24 DEBUG : removing 1 level 4 directories 2025/10/02 03:33:24 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/10/02 03:33:24 DEBUG : removing 1 level 3 directories 2025/10/02 03:33:24 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/10/02 03:33:24 DEBUG : removing 1 level 2 directories 2025/10/02 03:33:24 INFO : hello? sausage/êé: Removing directory 2025/10/02 03:33:24 DEBUG : removing 1 level 1 directories 2025/10/02 03:33:24 INFO : hello? sausage: Removing directory 2025/10/02 03:33:24 DEBUG : removing 1 level 0 directories 2025/10/02 03:33:24 INFO : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: Removing directory 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31719") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:49096->127.0.0.1:31719, err= 2025/10/02 03:33:24 ERROR : error listing: directory not found 2025/10/02 03:33:24 DEBUG : Waiting for deletions to finish 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:31104") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:50334->127.0.0.1:31104, err= 2025/10/02 03:33:24 ERROR : error listing: directory not found 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: dial("tcp","127.0.0.1:30474") 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: > dial: conn=127.0.0.1:48802->127.0.0.1:30474, err= 2025/10/02 03:33:24 ERROR : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: Failed to list "": directory not found 2025/10/02 03:33:24 DEBUG : removing 1 level 0 directories 2025/10/02 03:33:24 INFO : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: Removing directory 2025/10/02 03:33:24 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/10/02 03:33:24 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuxodur5duvi: closing 2 unused connections --- PASS: TestIntegration (2.62s) --- 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.61s) --- 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.32s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.02s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.02s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.02s) --- 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.20s) --- 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.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.03s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/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.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.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 2.636s "go test -v -timeout 1h0m0s -remote TestFTPRclone: -verbose" - Finished OK in 4.292742427s (try 1/5)