"go test -v -timeout 1h0m0s -remote TestFTPRclone: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPRclone:" 2025/11/23 01:03:38 NOTICE: TestFTPRclone: Starting server 2025/11/23 01:03:39 NOTICE: TestFTPRclone: Attempting to connect to "127.0.0.1:28622" try 1/100 2025/11/23 01:03:39 DEBUG : TestFTPRclone: Read 1, error: 2025/11/23 01:03:39 NOTICE: TestFTPRclone: Started server and connected to "127.0.0.1:28622" 2025/11/23 01:03:39 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-tupicez4lipa" 2025/11/23 01:03:39 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/11/23 01:03:39 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/11/23 01:03:39 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:39 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:39 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:39 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:39 DEBUG : TestFTPRclone: detected overridden config - adding "{ASYmx}" suffix to name 2025/11/23 01:03:39 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:39 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:39 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:39 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: Connecting to FTP server 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:28622") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:56792->127.0.0.1:28622, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30583") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:53404->127.0.0.1:30583, err= 2025/11/23 01:03:39 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/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30429") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:40392->127.0.0.1:30429, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30975") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43086->127.0.0.1:30975, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30634") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:34056->127.0.0.1:30634, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31820") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58568->127.0.0.1:31820, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31511") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33100->127.0.0.1:31511, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30945") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59052->127.0.0.1:30945, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31752") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33948->127.0.0.1:31752, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/11/23 01:03:39 INFO : dir/subdir: Making directory 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30718") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52526->127.0.0.1:30718, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30145") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:55422->127.0.0.1:30145, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30273") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48382->127.0.0.1:30273, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31579") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:55518->127.0.0.1:31579, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30603") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:56948->127.0.0.1:30603, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31567") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:49536->127.0.0.1:31567, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30022") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36120->127.0.0.1:30022, err= 2025/11/23 01:03:39 INFO : dir/subdir: Removing directory 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31711") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:49048->127.0.0.1:31711, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30157") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36104->127.0.0.1:30157, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30653") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59974->127.0.0.1:30653, err= 2025/11/23 01:03:39 INFO : dir: Removing directory 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31733") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42642->127.0.0.1:31733, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31860") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:35414->127.0.0.1:31860, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30109") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54086->127.0.0.1:30109, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31777") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43166->127.0.0.1:31777, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31429") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37002->127.0.0.1:31429, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30754") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48178->127.0.0.1:30754, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30629") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:60996->127.0.0.1:30629, err= 2025/11/23 01:03:39 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/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31479") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:38896->127.0.0.1:31479, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31761") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42954->127.0.0.1:31761, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31017") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45826->127.0.0.1:31017, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30634") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:34060->127.0.0.1:30634, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30385") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48392->127.0.0.1:30385, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30677") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57986->127.0.0.1:30677, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30696") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:49342->127.0.0.1:30696, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30009") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48770->127.0.0.1:30009, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30603") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:56954->127.0.0.1:30603, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31503") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59486->127.0.0.1:31503, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30400") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:56992->127.0.0.1:30400, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31600") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44260->127.0.0.1:31600, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31809") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57006->127.0.0.1:31809, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31313") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:32974->127.0.0.1:31313, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30215") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47214->127.0.0.1:30215, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30571") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:49094->127.0.0.1:30571, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30038") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45262->127.0.0.1:30038, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30322") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:56104->127.0.0.1:30322, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31008") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:50878->127.0.0.1:31008, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30227") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57678->127.0.0.1:30227, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31834") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48814->127.0.0.1:31834, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30165") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:38548->127.0.0.1:30165, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30550") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:56276->127.0.0.1:30550, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31772") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58754->127.0.0.1:31772, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31253") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:40858->127.0.0.1:31253, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30088") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46656->127.0.0.1:30088, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30269") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37088->127.0.0.1:30269, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31189") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33084->127.0.0.1:31189, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30899") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58452->127.0.0.1:30899, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31805") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:38218->127.0.0.1:31805, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30866") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48450->127.0.0.1:30866, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30287") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59014->127.0.0.1:30287, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30496") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:32992->127.0.0.1:30496, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31948") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:53048->127.0.0.1:31948, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30255") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54256->127.0.0.1:30255, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31023") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48838->127.0.0.1:31023, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31014") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43424->127.0.0.1:31014, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31082") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54452->127.0.0.1:31082, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31885") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:50022->127.0.0.1:31885, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31097") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:39906->127.0.0.1:31097, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30814") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47228->127.0.0.1:30814, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31160") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:50566->127.0.0.1:31160, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30076") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:40740->127.0.0.1:30076, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30734") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45158->127.0.0.1:30734, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30484") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59310->127.0.0.1:30484, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30048") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52754->127.0.0.1:30048, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30906") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36382->127.0.0.1:30906, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30991") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33274->127.0.0.1:30991, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30503") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:40700->127.0.0.1:30503, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31566") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52438->127.0.0.1:31566, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31407") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42920->127.0.0.1:31407, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31982") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:41190->127.0.0.1:31982, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31801") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52948->127.0.0.1:31801, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31414") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57816->127.0.0.1:31414, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30542") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:49472->127.0.0.1:30542, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30756") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54102->127.0.0.1:30756, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31774") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:34548->127.0.0.1:31774, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30699") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52818->127.0.0.1:30699, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30849") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54708->127.0.0.1:30849, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31758") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:49400->127.0.0.1:31758, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30245") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47148->127.0.0.1:30245, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30793") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44026->127.0.0.1:30793, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30848") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:39206->127.0.0.1:30848, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31977") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:35828->127.0.0.1:31977, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31324") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:41148->127.0.0.1:31324, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30524") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:39984->127.0.0.1:30524, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30359") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:60268->127.0.0.1:30359, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31472") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58592->127.0.0.1:31472, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31446") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:41480->127.0.0.1:31446, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31563") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54272->127.0.0.1:31563, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30613") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47210->127.0.0.1:30613, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31415") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58068->127.0.0.1:31415, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30371") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36146->127.0.0.1:30371, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30891") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57490->127.0.0.1:30891, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30412") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:38306->127.0.0.1:30412, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30535") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57080->127.0.0.1:30535, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31605") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:60232->127.0.0.1:31605, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31352") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:40822->127.0.0.1:31352, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30370") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42174->127.0.0.1:30370, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31353") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:55156->127.0.0.1:31353, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31093") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45316->127.0.0.1:31093, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30670") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:51564->127.0.0.1:30670, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30614") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:60772->127.0.0.1:30614, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31295") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48244->127.0.0.1:31295, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31989") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33236->127.0.0.1:31989, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31761") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42956->127.0.0.1:31761, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31382") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44372->127.0.0.1:31382, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30167") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44540->127.0.0.1:30167, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31839") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33898->127.0.0.1:31839, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31872") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:51940->127.0.0.1:31872, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31237") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42890->127.0.0.1:31237, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30249") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36000->127.0.0.1:30249, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31766") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45806->127.0.0.1:31766, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30541") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:34284->127.0.0.1:30541, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30080") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43394->127.0.0.1:30080, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30954") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52470->127.0.0.1:30954, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31514") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48254->127.0.0.1:31514, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31532") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:35376->127.0.0.1:31532, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30131") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37718->127.0.0.1:30131, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31028") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:60772->127.0.0.1:31028, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31213") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43194->127.0.0.1:31213, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30813") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:55542->127.0.0.1:30813, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31166") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48180->127.0.0.1:31166, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30840") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44354->127.0.0.1:30840, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31674") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43122->127.0.0.1:31674, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31952") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48122->127.0.0.1:31952, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30885") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:55462->127.0.0.1:30885, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30728") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42510->127.0.0.1:30728, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31534") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42050->127.0.0.1:31534, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30790") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47802->127.0.0.1:30790, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31508") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37234->127.0.0.1:31508, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31811") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47766->127.0.0.1:31811, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31049") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47148->127.0.0.1:31049, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31990") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33978->127.0.0.1:31990, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31868") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:53290->127.0.0.1:31868, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30906") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36394->127.0.0.1:30906, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31491") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52154->127.0.0.1:31491, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31761") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42970->127.0.0.1:31761, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30479") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58184->127.0.0.1:30479, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30516") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:40910->127.0.0.1:30516, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31680") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37534->127.0.0.1:31680, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30754") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48184->127.0.0.1:30754, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31119") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46584->127.0.0.1:31119, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30149") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58998->127.0.0.1:30149, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31406") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59726->127.0.0.1:31406, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30402") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44528->127.0.0.1:30402, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30795") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54612->127.0.0.1:30795, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31567") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:49552->127.0.0.1:31567, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30384") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37450->127.0.0.1:30384, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31521") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43938->127.0.0.1:31521, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30793") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44038->127.0.0.1:30793, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31761") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42974->127.0.0.1:31761, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31178") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:39246->127.0.0.1:31178, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31492") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:55828->127.0.0.1:31492, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31258") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45214->127.0.0.1:31258, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31656") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36360->127.0.0.1:31656, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30851") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37830->127.0.0.1:30851, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31149") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52130->127.0.0.1:31149, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31230") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47426->127.0.0.1:31230, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30195") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:51778->127.0.0.1:30195, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30063") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37848->127.0.0.1:30063, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31983") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57728->127.0.0.1:31983, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31358") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47774->127.0.0.1:31358, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30623") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37508->127.0.0.1:30623, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30042") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:53734->127.0.0.1:30042, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30579") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52530->127.0.0.1:30579, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31737") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:53756->127.0.0.1:31737, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31442") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54844->127.0.0.1:31442, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30434") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37772->127.0.0.1:30434, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30461") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:35072->127.0.0.1:30461, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30618") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:35160->127.0.0.1:30618, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31173") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37312->127.0.0.1:31173, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30033") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:60914->127.0.0.1:30033, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30622") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33618->127.0.0.1:30622, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31115") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:41466->127.0.0.1:31115, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30287") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59016->127.0.0.1:30287, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30552") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52122->127.0.0.1:30552, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30999") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:53102->127.0.0.1:30999, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30919") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46920->127.0.0.1:30919, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31880") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:41866->127.0.0.1:31880, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31550") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:53974->127.0.0.1:31550, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30835") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58436->127.0.0.1:30835, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30570") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43412->127.0.0.1:30570, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31807") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37704->127.0.0.1:31807, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30741") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33406->127.0.0.1:30741, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31105") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:50066->127.0.0.1:31105, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31941") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:60188->127.0.0.1:31941, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31808") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44654->127.0.0.1:31808, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31124") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:41456->127.0.0.1:31124, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31380") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36958->127.0.0.1:31380, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31598") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:49078->127.0.0.1:31598, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30130") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44456->127.0.0.1:30130, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30820") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:38634->127.0.0.1:30820, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30985") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:51008->127.0.0.1:30985, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31986") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:60372->127.0.0.1:31986, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30168") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57056->127.0.0.1:30168, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30098") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43812->127.0.0.1:30098, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31121") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59840->127.0.0.1:31121, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31075") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52110->127.0.0.1:31075, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30565") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44128->127.0.0.1:30565, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31608") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:50212->127.0.0.1:31608, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31650") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59376->127.0.0.1:31650, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31427") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:49622->127.0.0.1:31427, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30427") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58728->127.0.0.1:30427, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30403") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37564->127.0.0.1:30403, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31462") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:50856->127.0.0.1:31462, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30366") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:50664->127.0.0.1:30366, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30660") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37072->127.0.0.1:30660, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31967") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:41262->127.0.0.1:31967, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30153") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:49036->127.0.0.1:30153, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31233") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:34588->127.0.0.1:31233, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31467") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33864->127.0.0.1:31467, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31231") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:49412->127.0.0.1:31231, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30682") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47162->127.0.0.1:30682, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31255") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59350->127.0.0.1:31255, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30772") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:53068->127.0.0.1:30772, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31954") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:38042->127.0.0.1:31954, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31643") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52422->127.0.0.1:31643, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30246") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58860->127.0.0.1:30246, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30691") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:41434->127.0.0.1:30691, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31640") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45414->127.0.0.1:31640, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31118") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52878->127.0.0.1:31118, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30561") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46670->127.0.0.1:30561, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30501") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:56148->127.0.0.1:30501, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30702") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57346->127.0.0.1:30702, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31619") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47366->127.0.0.1:31619, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31407") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42926->127.0.0.1:31407, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30630") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46044->127.0.0.1:30630, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31130") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36102->127.0.0.1:31130, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31713") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45280->127.0.0.1:31713, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30062") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58718->127.0.0.1:30062, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30119") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43340->127.0.0.1:30119, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30425") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:38676->127.0.0.1:30425, err= === RUN TestIntegration/FsMkdir/FsPutError 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31604") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:53374->127.0.0.1:31604, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31474") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:32924->127.0.0.1:31474, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31556") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43216->127.0.0.1:31556, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30595") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47176->127.0.0.1:30595, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30864") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48204->127.0.0.1:30864, err= 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30290") 2025/11/23 01:03:39 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:38892->127.0.0.1:30290, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: Connecting to FTP server 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:28622") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:56804->127.0.0.1:28622, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31041") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44312->127.0.0.1:31041, err= 2025/11/23 01:03:40 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30128") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46318->127.0.0.1:30128, err= === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30344") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43780->127.0.0.1:30344, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31985") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:41410->127.0.0.1:31985, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30343") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:35816->127.0.0.1:30343, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30252") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46966->127.0.0.1:30252, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31371") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36892->127.0.0.1:31371, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31542") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54248->127.0.0.1:31542, 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/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30624") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:60190->127.0.0.1:30624, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31713") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45286->127.0.0.1:31713, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30793") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44040->127.0.0.1:30793, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30416") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47442->127.0.0.1:30416, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30742") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:34872->127.0.0.1:30742, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31913") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46860->127.0.0.1:31913, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31274") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:53096->127.0.0.1:31274, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30526") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:35838->127.0.0.1:30526, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31261") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42656->127.0.0.1:31261, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31280") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59124->127.0.0.1:31280, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30965") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:49544->127.0.0.1:30965, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30349") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45432->127.0.0.1:30349, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30065") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46460->127.0.0.1:30065, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30492") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48336->127.0.0.1:30492, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30405") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:41036->127.0.0.1:30405, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30310") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:39230->127.0.0.1:30310, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31553") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52690->127.0.0.1:31553, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30673") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:50310->127.0.0.1:30673, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30665") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33630->127.0.0.1:30665, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31414") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57820->127.0.0.1:31414, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30996") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54574->127.0.0.1:30996, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31597") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:40884->127.0.0.1:31597, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30735") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52310->127.0.0.1:30735, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31885") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:50036->127.0.0.1:31885, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31765") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:60788->127.0.0.1:31765, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31057") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:34794->127.0.0.1:31057, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/11/23 01:03:40 DEBUG : Creating backend with remote "TestFTPRclone:" 2025/11/23 01:03:40 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/11/23 01:03:40 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:40 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:40 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:40 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:40 DEBUG : TestFTPRclone: detected overridden config - adding "{ASYmx}" suffix to name 2025/11/23 01:03:40 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:40 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:40 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:40 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622: Connecting to FTP server 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:28622") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:56820->127.0.0.1:28622, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30529") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:54688->127.0.0.1:30529, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30603") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:56968->127.0.0.1:30603, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31726") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52116->127.0.0.1:31726, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31796") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47126->127.0.0.1:31796, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31762") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:35732->127.0.0.1:31762, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30235") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:35418->127.0.0.1:30235, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31410") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47378->127.0.0.1:31410, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31039") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45832->127.0.0.1:31039, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31987") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43802->127.0.0.1:31987, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30752") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57194->127.0.0.1:30752, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31414") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57834->127.0.0.1:31414, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30028") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33906->127.0.0.1:30028, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30299") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36992->127.0.0.1:30299, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30454") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57818->127.0.0.1:30454, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31753") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36762->127.0.0.1:31753, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31291") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:56312->127.0.0.1:31291, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31205") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54578->127.0.0.1:31205, 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/11/23 01:03:40 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-tupicez4lipa/hello? sausage/êé" 2025/11/23 01:03:40 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/11/23 01:03:40 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:40 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:40 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:40 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:40 DEBUG : TestFTPRclone: detected overridden config - adding "{ASYmx}" suffix to name 2025/11/23 01:03:40 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:40 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:40 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:40 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: Connecting to FTP server 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:28622") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:56836->127.0.0.1:28622, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:30452") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:56988->127.0.0.1:30452, err= 2025/11/23 01:03:40 DEBUG : fs cache: renaming cache item "TestFTPRclone:rclone-test-tupicez4lipa/hello? sausage/êé" to be canonical "TestFTPRclone{ASYmx}:rclone-test-tupicez4lipa/hello? sausage/êé" 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:30558") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:50788->127.0.0.1:30558, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:31010") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:55628->127.0.0.1:31010, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:31566") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:52442->127.0.0.1:31566, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:30988") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:47570->127.0.0.1:30988, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:31296") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:55104->127.0.0.1:31296, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:30666") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:40838->127.0.0.1:30666, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: SetModTime is not supported 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:31281") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:42900->127.0.0.1:31281, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:31904") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:52138->127.0.0.1:31904, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:30354") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:42322->127.0.0.1:30354, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: Connecting to FTP server 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:28622") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:30408") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:56852->127.0.0.1:28622, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:60828->127.0.0.1:30408, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:30768") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:41954->127.0.0.1:30768, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:30304") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:47178->127.0.0.1:30304, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:31172") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:57182->127.0.0.1:31172, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:30019") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:49396->127.0.0.1:30019, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:31086") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:34686->127.0.0.1:31086, err= 2025/11/23 01:03:40 DEBUG : Waiting for deletions to finish 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:31199") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:35562->127.0.0.1:31199, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:30356") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:40542->127.0.0.1:30356, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:31231") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:49426->127.0.0.1:31231, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:31430") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:43272->127.0.0.1:31430, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:30775") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:52488->127.0.0.1:30775, err= 2025/11/23 01:03:40 INFO : a/b/c/d/e.txt: Deleted 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:31864") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:49794->127.0.0.1:31864, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:30417") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:59914->127.0.0.1:30417, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:31848") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:50910->127.0.0.1:31848, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:31595") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:55146->127.0.0.1:31595, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: dial("tcp","127.0.0.1:31271") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé: > dial: conn=127.0.0.1:33150->127.0.0.1:31271, err= 2025/11/23 01:03:40 DEBUG : removing 1 level 4 directories 2025/11/23 01:03:40 INFO : a/b/c/d: Removing directory 2025/11/23 01:03:40 DEBUG : removing 1 level 3 directories 2025/11/23 01:03:40 INFO : a/b/c: Removing directory 2025/11/23 01:03:40 DEBUG : removing 1 level 2 directories 2025/11/23 01:03:40 INFO : a/b: Removing directory 2025/11/23 01:03:40 DEBUG : removing 1 level 1 directories 2025/11/23 01:03:40 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30045") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59610->127.0.0.1:30045, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31039") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45840->127.0.0.1:31039, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30008") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:34718->127.0.0.1:30008, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31593") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33960->127.0.0.1:31593, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31262") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58860->127.0.0.1:31262, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30680") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:60794->127.0.0.1:30680, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30833") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54664->127.0.0.1:30833, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30699") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52828->127.0.0.1:30699, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31205") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54584->127.0.0.1:31205, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31183") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54238->127.0.0.1:31183, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31239") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36770->127.0.0.1:31239, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30021") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:51138->127.0.0.1:30021, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31838") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59260->127.0.0.1:31838, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30027") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54194->127.0.0.1:30027, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: Connecting to FTP server 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:28622") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:56868->127.0.0.1:28622, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30433") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59352->127.0.0.1:30433, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30439") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:50856->127.0.0.1:30439, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31317") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52886->127.0.0.1:31317, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31408") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:60476->127.0.0.1:31408, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31715") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45030->127.0.0.1:31715, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31884") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33836->127.0.0.1:31884, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30342") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:35626->127.0.0.1:30342, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30383") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:49914->127.0.0.1:30383, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30935") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59482->127.0.0.1:30935, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30192") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:53536->127.0.0.1:30192, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30046") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33320->127.0.0.1:30046, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30478") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:35062->127.0.0.1:30478, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31650") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59388->127.0.0.1:31650, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31831") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46110->127.0.0.1:31831, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30127") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59522->127.0.0.1:30127, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31494") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:40480->127.0.0.1:31494, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30560") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33250->127.0.0.1:30560, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30104") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:60936->127.0.0.1:30104, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30014") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:55320->127.0.0.1:30014, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30147") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:40472->127.0.0.1:30147, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31432") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:35394->127.0.0.1:31432, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31885") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30630") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46056->127.0.0.1:30630, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:50046->127.0.0.1:31885, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31997") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30409") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:53050->127.0.0.1:31997, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36712->127.0.0.1:30409, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30780") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42026->127.0.0.1:30780, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31126") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36678->127.0.0.1:31126, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31181") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54634->127.0.0.1:31181, err= 2025/11/23 01:03:40 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-yojinuf0kupa" 2025/11/23 01:03:40 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/11/23 01:03:40 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:40 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:40 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:40 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:40 DEBUG : TestFTPRclone: detected overridden config - adding "{ASYmx}" suffix to name 2025/11/23 01:03:40 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:40 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:40 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:40 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: Connecting to FTP server 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:28622") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:56872->127.0.0.1:28622, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:31116") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:46330->127.0.0.1:31116, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:30205") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:52266->127.0.0.1:30205, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:30431") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:60784->127.0.0.1:30431, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:30634") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:34064->127.0.0.1:30634, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31657") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33452->127.0.0.1:31657, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:30483") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:51772->127.0.0.1:30483, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:31818") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:44528->127.0.0.1:31818, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:31755") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:45488->127.0.0.1:31755, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:30494") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:52826->127.0.0.1:30494, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:31994") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:43256->127.0.0.1:31994, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:31278") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:46448->127.0.0.1:31278, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:31086") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:34688->127.0.0.1:31086, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31051") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:55494->127.0.0.1:31051, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30631") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52006->127.0.0.1:30631, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30097") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44444->127.0.0.1:30097, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30385") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48404->127.0.0.1:30385, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31623") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:48268->127.0.0.1:31623, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31759") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45186->127.0.0.1:31759, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:30117") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:38538->127.0.0.1:30117, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:31800") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:38344->127.0.0.1:31800, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:31436") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:43922->127.0.0.1:31436, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:30718") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:52542->127.0.0.1:30718, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:30198") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:46430->127.0.0.1:30198, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: dial("tcp","127.0.0.1:31435") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: > dial: conn=127.0.0.1:45462->127.0.0.1:31435, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: Purge dir "new_name" 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-yojinuf0kupa: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31853") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33742->127.0.0.1:31853, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31851") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:34296->127.0.0.1:31851, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30440") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44664->127.0.0.1:30440, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31315") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37464->127.0.0.1:31315, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30429") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:40404->127.0.0.1:30429, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31227") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54484->127.0.0.1:31227, err= fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31648") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33952->127.0.0.1:31648, err= fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31458") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:38540->127.0.0.1:31458, err= fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30020") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44100->127.0.0.1:30020, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30205") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:52280->127.0.0.1:30205, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31818") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:44540->127.0.0.1:31818, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30517") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37926->127.0.0.1:30517, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30862") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33576->127.0.0.1:30862, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30247") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43618->127.0.0.1:30247, err= 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31036") 2025/11/23 01:03:40 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37086->127.0.0.1:31036, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30139") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47580->127.0.0.1:30139, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31701") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:32910->127.0.0.1:31701, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31276") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:40102->127.0.0.1:31276, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31959") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:40146->127.0.0.1:31959, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31312") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43386->127.0.0.1:31312, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31254") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59728->127.0.0.1:31254, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31454") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:33074->127.0.0.1:31454, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30915") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54932->127.0.0.1:30915, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30114") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59782->127.0.0.1:30114, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30644") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:39610->127.0.0.1:30644, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31127") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:40976->127.0.0.1:31127, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30341") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54200->127.0.0.1:30341, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30651") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:56858->127.0.0.1:30651, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/11/23 01:03:41 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-tupicez4lipa/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/11/23 01:03:41 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/11/23 01:03:41 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:41 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:41 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:41 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:41 DEBUG : TestFTPRclone: detected overridden config - adding "{ASYmx}" suffix to name 2025/11/23 01:03:41 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:41 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:41 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:41 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:28622") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:56886->127.0.0.1:28622, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:31649") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:39232->127.0.0.1:31649, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:31621") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:48658->127.0.0.1:31621, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/11/23 01:03:41 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-tupicez4lipa/not found.txt" 2025/11/23 01:03:41 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/11/23 01:03:41 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:41 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:41 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:41 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:41 DEBUG : TestFTPRclone: detected overridden config - adding "{ASYmx}" suffix to name 2025/11/23 01:03:41 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:41 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:41 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:41 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/not found.txt: Connecting to FTP server 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/not found.txt: dial("tcp","127.0.0.1:28622") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/not found.txt: > dial: conn=127.0.0.1:56892->127.0.0.1:28622, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/not found.txt: dial("tcp","127.0.0.1:31926") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/not found.txt: > dial: conn=127.0.0.1:54590->127.0.0.1:31926, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/not found.txt: dial("tcp","127.0.0.1:31308") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/not found.txt: > dial: conn=127.0.0.1:45852->127.0.0.1:31308, err= 2025/11/23 01:03:41 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPRclone:" path "rclone-test-tupicez4lipa" from "TestFTPRclone:rclone-test-tupicez4lipa" 2025/11/23 01:03:41 DEBUG : Creating backend with remote "TestFTPRclone:" 2025/11/23 01:03:41 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/11/23 01:03:41 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:41 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:41 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:41 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:41 DEBUG : TestFTPRclone: detected overridden config - adding "{ASYmx}" suffix to name 2025/11/23 01:03:41 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:41 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:41 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:41 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: Connecting to FTP server 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:28622") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:56898->127.0.0.1:28622, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30237") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:34188->127.0.0.1:30237, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30321") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:39652->127.0.0.1:30321, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31763") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:44686->127.0.0.1:31763, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30103") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:38914->127.0.0.1:30103, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30829") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:42680->127.0.0.1:30829, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30957") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:57418->127.0.0.1:30957, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30330") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:54790->127.0.0.1:30330, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30265") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:50490->127.0.0.1:30265, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: SetModTime is not supported 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31518") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:52946->127.0.0.1:31518, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30897") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:54314->127.0.0.1:30897, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30804") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:35710->127.0.0.1:30804, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31594") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:34862->127.0.0.1:31594, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30662") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:38118->127.0.0.1:30662, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31244") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:38196->127.0.0.1:31244, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31234") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:33768->127.0.0.1:31234, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30840") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:44358->127.0.0.1:30840, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31496") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:46452->127.0.0.1:31496, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31171") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:48494->127.0.0.1:31171, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30357") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:57800->127.0.0.1:30357, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30754") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:48198->127.0.0.1:30754, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31722") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:43920->127.0.0.1:31722, 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/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31594") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:34864->127.0.0.1:31594, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30753") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57468->127.0.0.1:30753, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30473") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:55212->127.0.0.1:30473, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30123") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46644->127.0.0.1:30123, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30816") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45598->127.0.0.1:30816, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30008") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:34728->127.0.0.1:30008, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30449") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36268->127.0.0.1:30449, 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/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30404") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:41578->127.0.0.1:30404, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30199") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47488->127.0.0.1:30199, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31169") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58486->127.0.0.1:31169, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30649") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:53374->127.0.0.1:30649, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31396") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:55380->127.0.0.1:31396, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30527") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:55520->127.0.0.1:30527, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30554") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58832->127.0.0.1:30554, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31913") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46862->127.0.0.1:31913, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31142") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36686->127.0.0.1:31142, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31110") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45872->127.0.0.1:31110, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/11/23 01:03:41 DEBUG : Creating backend with remote "TestFTPRclone,concurrency='0',shut_timeout='1s':rclone-test-tupicez4lipa" 2025/11/23 01:03:41 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/11/23 01:03:41 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:41 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:41 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:41 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:41 DEBUG : TestFTPRclone: detected overridden config - adding "{QbU5E}" suffix to name 2025/11/23 01:03:41 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:41 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:41 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:41 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: Connecting to FTP server 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:28622") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:56910->127.0.0.1:28622, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31968") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:47526->127.0.0.1:31968, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30340") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58796->127.0.0.1:30340, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30618") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:35174->127.0.0.1:30618, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30566") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45362->127.0.0.1:30566, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30207") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:36030->127.0.0.1:30207, 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/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31058") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:50230->127.0.0.1:31058, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30133") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:41520->127.0.0.1:30133, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31917") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:57026->127.0.0.1:31917, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31614") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:39026->127.0.0.1:31614, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30269") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37100->127.0.0.1:30269, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30971") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46430->127.0.0.1:30971, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31822") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42746->127.0.0.1:31822, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31941") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:60190->127.0.0.1:31941, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31938") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58640->127.0.0.1:31938, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31022") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:45772->127.0.0.1:31022, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: SetModTime is not supported 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30999") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:53116->127.0.0.1:30999, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30379") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:40654->127.0.0.1:30379, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/11/23 01:03:41 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-tupicez4lipa/deeper/nonexisting/directory" 2025/11/23 01:03:41 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/11/23 01:03:41 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:41 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:41 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:41 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:41 DEBUG : TestFTPRclone: detected overridden config - adding "{ASYmx}" suffix to name 2025/11/23 01:03:41 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/11/23 01:03:41 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/11/23 01:03:41 DEBUG : Setting pass="xbJ19CjsiASZEHW8t8rgwtLp2INSly06qXIdTkpUa4S0" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/11/23 01:03:41 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/deeper/nonexisting/directory: Connecting to FTP server 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/deeper/nonexisting/directory: dial("tcp","127.0.0.1:28622") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/deeper/nonexisting/directory: > dial: conn=127.0.0.1:56926->127.0.0.1:28622, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/deeper/nonexisting/directory: dial("tcp","127.0.0.1:31270") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/deeper/nonexisting/directory: > dial: conn=127.0.0.1:37446->127.0.0.1:31270, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/deeper/nonexisting/directory: dial("tcp","127.0.0.1:30416") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa/deeper/nonexisting/directory: > dial: conn=127.0.0.1:47448->127.0.0.1:30416, 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/11/23 01:03:41 DEBUG : Waiting for deletions to finish 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31655") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43668->127.0.0.1:31655, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30328") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:35014->127.0.0.1:30328, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31683") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:46928->127.0.0.1:31683, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31421") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42638->127.0.0.1:31421, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30415") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:58236->127.0.0.1:30415, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31452") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59842->127.0.0.1:31452, err= 2025/11/23 01:03:41 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31403") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:51512->127.0.0.1:31403, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30307") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:59610->127.0.0.1:30307, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31490") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:42434->127.0.0.1:31490, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31270") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:37458->127.0.0.1:31270, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31851") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:34298->127.0.0.1:31851, err= 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31975") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:51392->127.0.0.1:31975, err= 2025/11/23 01:03:41 DEBUG : removing 1 level 4 directories 2025/11/23 01:03:41 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/11/23 01:03:41 DEBUG : removing 1 level 3 directories 2025/11/23 01:03:41 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/11/23 01:03:41 DEBUG : removing 1 level 2 directories 2025/11/23 01:03:41 INFO : hello? sausage/êé: Removing directory 2025/11/23 01:03:41 DEBUG : removing 1 level 1 directories 2025/11/23 01:03:41 INFO : hello? sausage: Removing directory 2025/11/23 01:03:41 DEBUG : removing 1 level 0 directories 2025/11/23 01:03:41 INFO : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: Removing directory 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:31556") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:43232->127.0.0.1:31556, err= 2025/11/23 01:03:41 ERROR : error listing: directory not found 2025/11/23 01:03:41 DEBUG : Waiting for deletions to finish 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30184") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:54002->127.0.0.1:30184, err= 2025/11/23 01:03:41 ERROR : error listing: directory not found 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: dial("tcp","127.0.0.1:30651") 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: > dial: conn=127.0.0.1:56860->127.0.0.1:30651, err= 2025/11/23 01:03:41 ERROR : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: Failed to list "": directory not found 2025/11/23 01:03:41 DEBUG : removing 1 level 0 directories 2025/11/23 01:03:41 INFO : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: Removing directory 2025/11/23 01:03:41 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/11/23 01:03:41 DEBUG : ftp://127.0.0.1:28622/rclone-test-tupicez4lipa: closing 2 unused connections 2025/11/23 01:03:41 NOTICE: TestFTPRclone: Stopping server --- PASS: TestIntegration (3.51s) --- 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.46s) --- 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.23s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.01s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.01s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (1.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.04s) --- 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.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.74s) --- 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 3.526s "go test -v -timeout 1h0m0s -remote TestFTPRclone: -verbose" - Finished OK in 4.388838932s (try 1/5)