"go test -v -timeout 1h0m0s -remote TestFTPRclone: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPRclone:" 2025/09/20 04:43:33 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-lavaxef8mahu" 2025/09/20 04:43:33 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/20 04:43:33 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/09/20 04:43:33 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:33 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:33 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:33 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:33 DEBUG : TestFTPRclone: detected overridden config - adding "{TQ9T-}" suffix to name 2025/09/20 04:43:33 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:33 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:33 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:33 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: Connecting to FTP server 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:28622") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56466->127.0.0.1:28622, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31457") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40066->127.0.0.1:31457, err= 2025/09/20 04:43:33 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/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31184") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44702->127.0.0.1:31184, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31604") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52892->127.0.0.1:31604, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31552") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33300->127.0.0.1:31552, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31162") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56164->127.0.0.1:31162, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30525") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33470->127.0.0.1:30525, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31686") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44074->127.0.0.1:31686, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30944") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44790->127.0.0.1:30944, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/09/20 04:43:33 INFO : dir/subdir: Making directory 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31136") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47468->127.0.0.1:31136, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30552") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:53710->127.0.0.1:30552, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31302") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:54580->127.0.0.1:31302, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31390") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52616->127.0.0.1:31390, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31395") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:41986->127.0.0.1:31395, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31633") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48228->127.0.0.1:31633, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31907") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56918->127.0.0.1:31907, err= 2025/09/20 04:43:33 INFO : dir/subdir: Removing directory 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31675") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48034->127.0.0.1:31675, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31211") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48550->127.0.0.1:31211, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30028") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:51798->127.0.0.1:30028, err= 2025/09/20 04:43:33 INFO : dir: Removing directory 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31909") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59942->127.0.0.1:31909, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30050") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48962->127.0.0.1:30050, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31107") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:51468->127.0.0.1:31107, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30814") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46934->127.0.0.1:30814, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31376") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:60122->127.0.0.1:31376, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30650") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:60970->127.0.0.1:30650, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31284") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:57234->127.0.0.1:31284, err= 2025/09/20 04:43:33 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/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30111") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40056->127.0.0.1:30111, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31507") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52250->127.0.0.1:31507, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31346") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44646->127.0.0.1:31346, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30739") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:54602->127.0.0.1:30739, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30979") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:41118->127.0.0.1:30979, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30646") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59182->127.0.0.1:30646, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31836") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:37856->127.0.0.1:31836, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30935") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46354->127.0.0.1:30935, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30567") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:57010->127.0.0.1:30567, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30555") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50572->127.0.0.1:30555, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30876") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45040->127.0.0.1:30876, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31855") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40414->127.0.0.1:31855, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31931") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48224->127.0.0.1:31931, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30141") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:60918->127.0.0.1:30141, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30903") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:57740->127.0.0.1:30903, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31321") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52602->127.0.0.1:31321, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30432") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:42084->127.0.0.1:30432, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31582") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:38530->127.0.0.1:31582, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31625") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:42266->127.0.0.1:31625, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30829") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43370->127.0.0.1:30829, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31942") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:58508->127.0.0.1:31942, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30242") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36422->127.0.0.1:30242, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30402") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:42684->127.0.0.1:30402, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31705") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:57458->127.0.0.1:31705, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30204") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:32778->127.0.0.1:30204, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30736") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44174->127.0.0.1:30736, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30010") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45600->127.0.0.1:30010, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31604") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52898->127.0.0.1:31604, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30195") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40868->127.0.0.1:30195, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31165") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59572->127.0.0.1:31165, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31783") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45122->127.0.0.1:31783, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31560") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39352->127.0.0.1:31560, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30328") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:38378->127.0.0.1:30328, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31658") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47162->127.0.0.1:31658, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31230") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44564->127.0.0.1:31230, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30372") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43464->127.0.0.1:30372, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30665") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50940->127.0.0.1:30665, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30685") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:41546->127.0.0.1:30685, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30609") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36798->127.0.0.1:30609, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31766") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50896->127.0.0.1:31766, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30716") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59664->127.0.0.1:30716, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30514") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50178->127.0.0.1:30514, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31891") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34794->127.0.0.1:31891, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31432") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46722->127.0.0.1:31432, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31273") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:41340->127.0.0.1:31273, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31302") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:54590->127.0.0.1:31302, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31519") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34676->127.0.0.1:31519, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30188") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36990->127.0.0.1:30188, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31029") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52734->127.0.0.1:31029, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30976") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:51340->127.0.0.1:30976, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31208") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47124->127.0.0.1:31208, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30754") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43314->127.0.0.1:30754, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30223") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:58928->127.0.0.1:30223, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30821") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50918->127.0.0.1:30821, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30780") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48054->127.0.0.1:30780, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30634") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50556->127.0.0.1:30634, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30566") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45366->127.0.0.1:30566, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30811") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43980->127.0.0.1:30811, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30525") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33474->127.0.0.1:30525, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31216") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59008->127.0.0.1:31216, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30566") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45374->127.0.0.1:30566, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31662") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40228->127.0.0.1:31662, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30350") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40988->127.0.0.1:30350, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30730") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:49118->127.0.0.1:30730, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30493") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55492->127.0.0.1:30493, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31356") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44082->127.0.0.1:31356, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30351") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:32874->127.0.0.1:30351, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30919") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59326->127.0.0.1:30919, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30099") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40154->127.0.0.1:30099, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31812") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:35864->127.0.0.1:31812, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31221") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52104->127.0.0.1:31221, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30801") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52716->127.0.0.1:30801, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31535") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59252->127.0.0.1:31535, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30636") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39318->127.0.0.1:30636, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31871") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39864->127.0.0.1:31871, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30519") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34780->127.0.0.1:30519, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30468") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59304->127.0.0.1:30468, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30123") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33036->127.0.0.1:30123, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30757") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56144->127.0.0.1:30757, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30488") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:38658->127.0.0.1:30488, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30290") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40728->127.0.0.1:30290, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30487") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48048->127.0.0.1:30487, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30506") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40422->127.0.0.1:30506, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30000") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56698->127.0.0.1:30000, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30933") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46156->127.0.0.1:30933, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30739") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:54614->127.0.0.1:30739, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31619") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:37104->127.0.0.1:31619, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30952") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:49552->127.0.0.1:30952, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30184") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50638->127.0.0.1:30184, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31215") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:57844->127.0.0.1:31215, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30879") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44774->127.0.0.1:30879, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31410") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56422->127.0.0.1:31410, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31603") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44136->127.0.0.1:31603, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31207") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48152->127.0.0.1:31207, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31601") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44594->127.0.0.1:31601, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30256") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44222->127.0.0.1:30256, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31340") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52492->127.0.0.1:31340, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30367") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55282->127.0.0.1:30367, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31657") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45980->127.0.0.1:31657, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31313") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48836->127.0.0.1:31313, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30453") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43470->127.0.0.1:30453, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31030") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39690->127.0.0.1:31030, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31340") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52504->127.0.0.1:31340, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31634") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50396->127.0.0.1:31634, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30356") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45892->127.0.0.1:30356, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31754") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:32996->127.0.0.1:31754, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30393") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:38484->127.0.0.1:30393, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30321") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:35400->127.0.0.1:30321, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30486") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:57180->127.0.0.1:30486, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31961") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33068->127.0.0.1:31961, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31085") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55356->127.0.0.1:31085, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31104") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:41062->127.0.0.1:31104, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30473") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52922->127.0.0.1:30473, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30217") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:41890->127.0.0.1:30217, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31761") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:60190->127.0.0.1:31761, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30858") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:42890->127.0.0.1:30858, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30439") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33710->127.0.0.1:30439, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30296") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:54276->127.0.0.1:30296, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31822") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44174->127.0.0.1:31822, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31395") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:42000->127.0.0.1:31395, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31074") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:41094->127.0.0.1:31074, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31928") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47910->127.0.0.1:31928, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31793") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39544->127.0.0.1:31793, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31139") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:37892->127.0.0.1:31139, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30817") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33186->127.0.0.1:30817, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31001") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:38260->127.0.0.1:31001, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31689") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:38066->127.0.0.1:31689, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31856") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50114->127.0.0.1:31856, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30811") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43982->127.0.0.1:30811, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31018") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:51982->127.0.0.1:31018, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31042") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:60518->127.0.0.1:31042, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30494") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34522->127.0.0.1:30494, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30518") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:37834->127.0.0.1:30518, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30415") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:41212->127.0.0.1:30415, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30516") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:53668->127.0.0.1:30516, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30726") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:35978->127.0.0.1:30726, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30173") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:35538->127.0.0.1:30173, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31912") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46796->127.0.0.1:31912, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31390") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52632->127.0.0.1:31390, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30183") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45638->127.0.0.1:30183, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31046") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:60810->127.0.0.1:31046, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30805") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:37848->127.0.0.1:30805, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31623") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46060->127.0.0.1:31623, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31801") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:51308->127.0.0.1:31801, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31807") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:53926->127.0.0.1:31807, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30017") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:37088->127.0.0.1:30017, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31243") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:51532->127.0.0.1:31243, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30486") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:57196->127.0.0.1:30486, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31106") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:51278->127.0.0.1:31106, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30135") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59442->127.0.0.1:30135, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31377") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44626->127.0.0.1:31377, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30882") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:35906->127.0.0.1:30882, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31985") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43864->127.0.0.1:31985, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31712") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39750->127.0.0.1:31712, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30248") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48308->127.0.0.1:30248, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30523") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46502->127.0.0.1:30523, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31818") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50724->127.0.0.1:31818, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31244") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34354->127.0.0.1:31244, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31442") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:42212->127.0.0.1:31442, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30957") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47996->127.0.0.1:30957, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31924") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46452->127.0.0.1:31924, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31257") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44444->127.0.0.1:31257, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30133") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55610->127.0.0.1:30133, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30573") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:49186->127.0.0.1:30573, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30270") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:42948->127.0.0.1:30270, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30825") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47896->127.0.0.1:30825, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31324") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50984->127.0.0.1:31324, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30088") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50792->127.0.0.1:30088, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31513") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47002->127.0.0.1:31513, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30230") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45020->127.0.0.1:30230, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30530") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55090->127.0.0.1:30530, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31514") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:42982->127.0.0.1:31514, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30013") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:53544->127.0.0.1:30013, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30161") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43680->127.0.0.1:30161, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31294") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50892->127.0.0.1:31294, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30901") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:58938->127.0.0.1:30901, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31348") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:37208->127.0.0.1:31348, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31659") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47152->127.0.0.1:31659, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30583") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43484->127.0.0.1:30583, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31771") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46690->127.0.0.1:31771, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31059") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34160->127.0.0.1:31059, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30123") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33038->127.0.0.1:30123, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30634") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50568->127.0.0.1:30634, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30115") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:53560->127.0.0.1:30115, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31025") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:37896->127.0.0.1:31025, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31331") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36700->127.0.0.1:31331, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31413") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50438->127.0.0.1:31413, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31674") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34180->127.0.0.1:31674, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30288") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44888->127.0.0.1:30288, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31320") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46510->127.0.0.1:31320, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30656") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44062->127.0.0.1:30656, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31062") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39128->127.0.0.1:31062, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30184") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50652->127.0.0.1:30184, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31080") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:35680->127.0.0.1:31080, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31573") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45402->127.0.0.1:31573, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31688") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50146->127.0.0.1:31688, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30579") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39260->127.0.0.1:30579, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30783") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56946->127.0.0.1:30783, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31542") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:37466->127.0.0.1:31542, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31127") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43176->127.0.0.1:31127, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30988") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:41894->127.0.0.1:30988, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31194") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:42550->127.0.0.1:31194, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31555") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:49638->127.0.0.1:31555, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31448") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39392->127.0.0.1:31448, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30796") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48154->127.0.0.1:30796, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31877") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45092->127.0.0.1:31877, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30985") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46180->127.0.0.1:30985, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30944") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44794->127.0.0.1:30944, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31850") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:42134->127.0.0.1:31850, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30887") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:32806->127.0.0.1:30887, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30107") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33124->127.0.0.1:30107, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30656") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44066->127.0.0.1:30656, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31428") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:54926->127.0.0.1:31428, err= === RUN TestIntegration/FsMkdir/FsPutError 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30133") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55614->127.0.0.1:30133, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30799") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55304->127.0.0.1:30799, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31835") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47530->127.0.0.1:31835, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30262") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:54194->127.0.0.1:30262, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30067") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43074->127.0.0.1:30067, err= 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30885") 2025/09/20 04:43:33 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46880->127.0.0.1:30885, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: Connecting to FTP server 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:28622") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56482->127.0.0.1:28622, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30534") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59750->127.0.0.1:30534, err= 2025/09/20 04:43:34 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31728") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:60836->127.0.0.1:31728, err= === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31406") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36612->127.0.0.1:31406, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30703") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:49124->127.0.0.1:30703, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30949") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:51064->127.0.0.1:30949, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31120") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:53514->127.0.0.1:31120, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30056") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:32852->127.0.0.1:30056, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30731") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56228->127.0.0.1:30731, err= === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31082") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46260->127.0.0.1:31082, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30440") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40728->127.0.0.1:30440, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31447") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55140->127.0.0.1:31447, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30047") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:42520->127.0.0.1:30047, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31700") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36600->127.0.0.1:31700, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31596") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56244->127.0.0.1:31596, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31965") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:35074->127.0.0.1:31965, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30038") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36594->127.0.0.1:30038, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31922") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45178->127.0.0.1:31922, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31237") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56328->127.0.0.1:31237, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31890") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:53720->127.0.0.1:31890, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31222") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48526->127.0.0.1:31222, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30643") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:51286->127.0.0.1:30643, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30709") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:38398->127.0.0.1:30709, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31054") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40320->127.0.0.1:31054, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31220") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55502->127.0.0.1:31220, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31621") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:51978->127.0.0.1:31621, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30341") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:42098->127.0.0.1:30341, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31323") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52326->127.0.0.1:31323, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30502") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43012->127.0.0.1:30502, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31280") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:35518->127.0.0.1:31280, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30855") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46884->127.0.0.1:30855, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30875") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40248->127.0.0.1:30875, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31581") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33884->127.0.0.1:31581, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30474") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34602->127.0.0.1:30474, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31282") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52680->127.0.0.1:31282, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/09/20 04:43:34 DEBUG : Creating backend with remote "TestFTPRclone:" 2025/09/20 04:43:34 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/09/20 04:43:34 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:34 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:34 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:34 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:34 DEBUG : TestFTPRclone: detected overridden config - adding "{TQ9T-}" suffix to name 2025/09/20 04:43:34 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:34 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:34 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:34 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: Connecting to FTP server 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:28622") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:56496->127.0.0.1:28622, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31849") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:51012->127.0.0.1:31849, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31086") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55154->127.0.0.1:31086, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31743") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47338->127.0.0.1:31743, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31758") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:57562->127.0.0.1:31758, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31687") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50546->127.0.0.1:31687, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30819") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47286->127.0.0.1:30819, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31898") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:60196->127.0.0.1:31898, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31715") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:58658->127.0.0.1:31715, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31867") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56374->127.0.0.1:31867, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31928") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47920->127.0.0.1:31928, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30751") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47718->127.0.0.1:30751, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1121: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31674") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34186->127.0.0.1:31674, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30238") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40574->127.0.0.1:30238, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30164") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40100->127.0.0.1:30164, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31789") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45622->127.0.0.1:31789, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31847") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:57430->127.0.0.1:31847, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31090") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40926->127.0.0.1:31090, 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/09/20 04:43:34 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-lavaxef8mahu/hello? sausage/êé" 2025/09/20 04:43:34 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/09/20 04:43:34 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:34 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:34 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:34 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:34 DEBUG : TestFTPRclone: detected overridden config - adding "{TQ9T-}" suffix to name 2025/09/20 04:43:34 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:34 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:34 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:34 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: Connecting to FTP server 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:28622") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:56506->127.0.0.1:28622, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31651") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:58974->127.0.0.1:31651, err= 2025/09/20 04:43:34 DEBUG : fs cache: renaming cache item "TestFTPRclone:rclone-test-lavaxef8mahu/hello? sausage/êé" to be canonical "TestFTPRclone{TQ9T-}:rclone-test-lavaxef8mahu/hello? sausage/êé" 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31910") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:35512->127.0.0.1:31910, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:30664") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:43158->127.0.0.1:30664, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:30099") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:40166->127.0.0.1:30099, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31641") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:59412->127.0.0.1:31641, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31374") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:37612->127.0.0.1:31374, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31428") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:54932->127.0.0.1:31428, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: SetModTime is not supported 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:30656") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:44074->127.0.0.1:30656, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31719") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:53626->127.0.0.1:31719, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31669") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:49318->127.0.0.1:31669, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: Connecting to FTP server 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:28622") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:56508->127.0.0.1:28622, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:30622") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:37154->127.0.0.1:30622, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31411") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:41396->127.0.0.1:31411, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:30235") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:55354->127.0.0.1:30235, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:30983") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:43712->127.0.0.1:30983, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:30914") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31534") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:58290->127.0.0.1:31534, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:42254->127.0.0.1:30914, err= 2025/09/20 04:43:34 DEBUG : Waiting for deletions to finish 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31933") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:34452->127.0.0.1:31933, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31798") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:33216->127.0.0.1:31798, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31337") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:41034->127.0.0.1:31337, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:30254") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:47382->127.0.0.1:30254, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31359") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:42020->127.0.0.1:31359, err= 2025/09/20 04:43:34 INFO : a/b/c/d/e.txt: Deleted 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31807") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:53934->127.0.0.1:31807, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:30970") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:53406->127.0.0.1:30970, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:30183") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:45646->127.0.0.1:30183, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:31943") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:55828->127.0.0.1:31943, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: dial("tcp","127.0.0.1:30812") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé: > dial: conn=127.0.0.1:37778->127.0.0.1:30812, err= 2025/09/20 04:43:34 DEBUG : removing 1 level 4 directories 2025/09/20 04:43:34 INFO : a/b/c/d: Removing directory 2025/09/20 04:43:34 DEBUG : removing 1 level 3 directories 2025/09/20 04:43:34 INFO : a/b/c: Removing directory 2025/09/20 04:43:34 DEBUG : removing 1 level 2 directories 2025/09/20 04:43:34 INFO : a/b: Removing directory 2025/09/20 04:43:34 DEBUG : removing 1 level 1 directories 2025/09/20 04:43:34 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1254: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31929") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43800->127.0.0.1:31929, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30197") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:53566->127.0.0.1:30197, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31156") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:57688->127.0.0.1:31156, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30845") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:35312->127.0.0.1:30845, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30492") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48884->127.0.0.1:30492, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31140") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46216->127.0.0.1:31140, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30121") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50868->127.0.0.1:30121, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31467") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40284->127.0.0.1:31467, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31632") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39616->127.0.0.1:31632, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30303") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:53182->127.0.0.1:30303, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31970") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34464->127.0.0.1:31970, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30960") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40322->127.0.0.1:30960, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30123") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33046->127.0.0.1:30123, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30483") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:51932->127.0.0.1:30483, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: Connecting to FTP server 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31928") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:28622") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47930->127.0.0.1:31928, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56520->127.0.0.1:28622, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30149") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43578->127.0.0.1:30149, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31102") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:35302->127.0.0.1:31102, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30058") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:60482->127.0.0.1:30058, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31819") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48534->127.0.0.1:31819, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31639") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55578->127.0.0.1:31639, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30678") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:32874->127.0.0.1:30678, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30167") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:38892->127.0.0.1:30167, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30926") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:38144->127.0.0.1:30926, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31949") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:42300->127.0.0.1:31949, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31988") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31401") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48028->127.0.0.1:31988, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56554->127.0.0.1:31401, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31412") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30012") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:60406->127.0.0.1:30012, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:49170->127.0.0.1:31412, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30194") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46114->127.0.0.1:30194, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30056") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:32854->127.0.0.1:30056, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30528") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:57440->127.0.0.1:30528, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31449") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:51062->127.0.0.1:31449, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30342") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43288->127.0.0.1:30342, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31765") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40048->127.0.0.1:31765, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31297") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:41960->127.0.0.1:31297, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31414") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40614->127.0.0.1:31414, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30263") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:57144->127.0.0.1:30263, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31813") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52928->127.0.0.1:31813, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30175") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56916->127.0.0.1:30175, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30529") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:54222->127.0.0.1:30529, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31413") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50444->127.0.0.1:31413, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30960") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40332->127.0.0.1:30960, err= 2025/09/20 04:43:34 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-bogikey0baru" 2025/09/20 04:43:34 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/09/20 04:43:34 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:34 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:34 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:34 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:34 DEBUG : TestFTPRclone: detected overridden config - adding "{TQ9T-}" suffix to name 2025/09/20 04:43:34 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:34 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:34 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:34 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: Connecting to FTP server 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:28622") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:56524->127.0.0.1:28622, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:30218") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:47792->127.0.0.1:30218, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:31253") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:53974->127.0.0.1:31253, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:30638") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:45998->127.0.0.1:30638, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:30247") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:47042->127.0.0.1:30247, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30180") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34590->127.0.0.1:30180, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:30833") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:55638->127.0.0.1:30833, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:30084") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:42216->127.0.0.1:30084, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:30080") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:41926->127.0.0.1:30080, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:31606") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:60722->127.0.0.1:31606, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:30201") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:46608->127.0.0.1:30201, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:31694") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:46716->127.0.0.1:31694, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:30710") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:51600->127.0.0.1:30710, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31151") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36688->127.0.0.1:31151, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30604") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52826->127.0.0.1:30604, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30101") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43520->127.0.0.1:30101, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30122") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56740->127.0.0.1:30122, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31602") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48522->127.0.0.1:31602, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30738") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33582->127.0.0.1:30738, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:30551") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:52190->127.0.0.1:30551, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:31063") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:39382->127.0.0.1:31063, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:31882") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:39826->127.0.0.1:31882, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:31625") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:42282->127.0.0.1:31625, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:30548") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:47720->127.0.0.1:30548, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: dial("tcp","127.0.0.1:31787") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: > dial: conn=127.0.0.1:37120->127.0.0.1:31787, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: Purge dir "new_name" 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-bogikey0baru: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30396") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:41302->127.0.0.1:30396, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30254") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:47398->127.0.0.1:30254, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30293") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33286->127.0.0.1:30293, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30334") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39408->127.0.0.1:30334, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31026") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50244->127.0.0.1:31026, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31242") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39906->127.0.0.1:31242, err= fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30646") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59186->127.0.0.1:30646, err= fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31740") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48584->127.0.0.1:31740, err= fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30491") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34658->127.0.0.1:30491, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30437") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:38184->127.0.0.1:30437, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31299") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:35666->127.0.0.1:31299, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30412") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50318->127.0.0.1:30412, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31530") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:35884->127.0.0.1:31530, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31511") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:51082->127.0.0.1:31511, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31573") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45406->127.0.0.1:31573, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30523") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46512->127.0.0.1:30523, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30437") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:38196->127.0.0.1:30437, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30347") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34072->127.0.0.1:30347, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31093") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:41820->127.0.0.1:31093, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30445") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48912->127.0.0.1:30445, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30948") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50130->127.0.0.1:30948, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31500") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55288->127.0.0.1:31500, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31203") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36086->127.0.0.1:31203, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31260") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52378->127.0.0.1:31260, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30212") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:54876->127.0.0.1:30212, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31329") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59960->127.0.0.1:31329, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30755") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55364->127.0.0.1:30755, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31101") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:41974->127.0.0.1:31101, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/09/20 04:43:34 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-lavaxef8mahu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2025/09/20 04:43:34 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/09/20 04:43:34 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:34 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:34 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:34 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:34 DEBUG : TestFTPRclone: detected overridden config - adding "{TQ9T-}" suffix to name 2025/09/20 04:43:34 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:34 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:34 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:34 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:28622") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:56536->127.0.0.1:28622, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:30159") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:39614->127.0.0.1:30159, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","127.0.0.1:31791") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=127.0.0.1:60612->127.0.0.1:31791, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/09/20 04:43:34 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-lavaxef8mahu/not found.txt" 2025/09/20 04:43:34 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/09/20 04:43:34 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:34 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:34 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:34 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:34 DEBUG : TestFTPRclone: detected overridden config - adding "{TQ9T-}" suffix to name 2025/09/20 04:43:34 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:34 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:34 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:34 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/not found.txt: Connecting to FTP server 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/not found.txt: dial("tcp","127.0.0.1:28622") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/not found.txt: > dial: conn=127.0.0.1:56544->127.0.0.1:28622, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/not found.txt: dial("tcp","127.0.0.1:31323") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/not found.txt: > dial: conn=127.0.0.1:52340->127.0.0.1:31323, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/not found.txt: dial("tcp","127.0.0.1:31090") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/not found.txt: > dial: conn=127.0.0.1:40930->127.0.0.1:31090, err= 2025/09/20 04:43:34 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestFTPRclone:" path "rclone-test-lavaxef8mahu" from "TestFTPRclone:rclone-test-lavaxef8mahu" 2025/09/20 04:43:34 DEBUG : Creating backend with remote "TestFTPRclone:" 2025/09/20 04:43:34 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/09/20 04:43:34 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:34 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:34 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:34 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:34 DEBUG : TestFTPRclone: detected overridden config - adding "{TQ9T-}" suffix to name 2025/09/20 04:43:34 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:34 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:34 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:34 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: Connecting to FTP server 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:28622") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:56550->127.0.0.1:28622, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30005") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:35338->127.0.0.1:30005, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31365") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:35920->127.0.0.1:31365, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31557") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:54896->127.0.0.1:31557, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30576") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:52640->127.0.0.1:30576, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30266") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:47532->127.0.0.1:30266, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31680") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:44306->127.0.0.1:31680, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31809") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:58064->127.0.0.1:31809, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31397") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:42976->127.0.0.1:31397, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: SetModTime is not supported 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31339") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:45128->127.0.0.1:31339, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31329") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:59966->127.0.0.1:31329, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31910") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:35526->127.0.0.1:31910, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30297") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:49510->127.0.0.1:30297, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30024") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:51214->127.0.0.1:30024, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31950") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:57580->127.0.0.1:31950, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30796") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:48158->127.0.0.1:30796, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30528") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:57454->127.0.0.1:30528, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30103") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:37876->127.0.0.1:30103, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30166") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:38722->127.0.0.1:30166, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31001") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:38270->127.0.0.1:31001, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:30622") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:37158->127.0.0.1:30622, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: dial("tcp","127.0.0.1:31287") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622: > dial: conn=127.0.0.1:45928->127.0.0.1:31287, 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/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30171") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40988->127.0.0.1:30171, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30335") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55526->127.0.0.1:30335, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31850") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:42146->127.0.0.1:31850, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31892") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39520->127.0.0.1:31892, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31787") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:37134->127.0.0.1:31787, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30842") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43844->127.0.0.1:30842, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30971") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:37354->127.0.0.1:30971, 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/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31668") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39560->127.0.0.1:31668, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31243") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:51540->127.0.0.1:31243, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31695") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56996->127.0.0.1:31695, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31933") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34462->127.0.0.1:31933, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31051") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43096->127.0.0.1:31051, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30029") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43872->127.0.0.1:30029, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31232") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40498->127.0.0.1:31232, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30754") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43328->127.0.0.1:30754, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31824") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:38276->127.0.0.1:31824, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31014") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:46954->127.0.0.1:31014, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2025/09/20 04:43:34 DEBUG : Creating backend with remote "TestFTPRclone,concurrency='0',shut_timeout='1s':rclone-test-lavaxef8mahu" 2025/09/20 04:43:34 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/09/20 04:43:34 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:34 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:34 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:34 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:34 DEBUG : TestFTPRclone: detected overridden config - adding "{Wfhvx}" suffix to name 2025/09/20 04:43:34 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:34 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:34 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:34 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: Connecting to FTP server 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:28622") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56560->127.0.0.1:28622, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30809") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59214->127.0.0.1:30809, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30053") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55580->127.0.0.1:30053, err= 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31600") 2025/09/20 04:43:34 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:50040->127.0.0.1:31600, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30181") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52672->127.0.0.1:30181, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31154") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59944->127.0.0.1:31154, 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/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30486") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:40034->127.0.0.1:30486, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30718") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36488->127.0.0.1:30718, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31191") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52258->127.0.0.1:31191, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30115") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:38060->127.0.0.1:30115, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30499") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:54098->127.0.0.1:30499, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30004") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:56704->127.0.0.1:30004, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31565") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36302->127.0.0.1:31565, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31177") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45394->127.0.0.1:31177, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31624") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33282->127.0.0.1:31624, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31877") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36548->127.0.0.1:31877, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: SetModTime is not supported 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31567") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:57020->127.0.0.1:31567, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31388") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:33130->127.0.0.1:31388, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/09/20 04:43:35 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-lavaxef8mahu/deeper/nonexisting/directory" 2025/09/20 04:43:35 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/09/20 04:43:35 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:35 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:35 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:35 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:35 DEBUG : TestFTPRclone: detected overridden config - adding "{TQ9T-}" suffix to name 2025/09/20 04:43:35 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/09/20 04:43:35 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/09/20 04:43:35 DEBUG : Setting pass="uEDZ0Q30t52jVn1G54HVO23AN03nmD7KQeLEtR3xXfLA" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/09/20 04:43:35 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/deeper/nonexisting/directory: Connecting to FTP server 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/deeper/nonexisting/directory: dial("tcp","127.0.0.1:28622") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/deeper/nonexisting/directory: > dial: conn=127.0.0.1:57668->127.0.0.1:28622, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/deeper/nonexisting/directory: dial("tcp","127.0.0.1:30430") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/deeper/nonexisting/directory: > dial: conn=127.0.0.1:47932->127.0.0.1:30430, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/deeper/nonexisting/directory: dial("tcp","127.0.0.1:31808") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu/deeper/nonexisting/directory: > dial: conn=127.0.0.1:40228->127.0.0.1:31808, 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/09/20 04:43:35 DEBUG : Waiting for deletions to finish 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31166") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:41410->127.0.0.1:31166, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31560") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:52992->127.0.0.1:31560, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30808") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:59896->127.0.0.1:30808, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30155") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:48300->127.0.0.1:30155, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30803") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:34558->127.0.0.1:30803, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31547") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:44476->127.0.0.1:31547, err= 2025/09/20 04:43:35 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30203") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:45480->127.0.0.1:30203, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31602") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:43296->127.0.0.1:31602, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31677") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55096->127.0.0.1:31677, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30829") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:55578->127.0.0.1:30829, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31175") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36586->127.0.0.1:31175, err= 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30471") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36346->127.0.0.1:30471, err= 2025/09/20 04:43:35 DEBUG : removing 1 level 4 directories 2025/09/20 04:43:35 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2025/09/20 04:43:35 DEBUG : removing 1 level 3 directories 2025/09/20 04:43:35 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2025/09/20 04:43:35 DEBUG : removing 1 level 2 directories 2025/09/20 04:43:35 INFO : hello? sausage/êé: Removing directory 2025/09/20 04:43:35 DEBUG : removing 1 level 1 directories 2025/09/20 04:43:35 INFO : hello? sausage: Removing directory 2025/09/20 04:43:35 DEBUG : removing 1 level 0 directories 2025/09/20 04:43:35 INFO : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: Removing directory 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31767") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:39200->127.0.0.1:31767, err= 2025/09/20 04:43:35 ERROR : error listing: directory not found 2025/09/20 04:43:35 DEBUG : Waiting for deletions to finish 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:31150") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:36838->127.0.0.1:31150, err= 2025/09/20 04:43:35 ERROR : error listing: directory not found 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: dial("tcp","127.0.0.1:30818") 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: > dial: conn=127.0.0.1:38736->127.0.0.1:30818, err= 2025/09/20 04:43:35 ERROR : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: Failed to list "": directory not found 2025/09/20 04:43:35 DEBUG : removing 1 level 0 directories 2025/09/20 04:43:35 INFO : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: Removing directory 2025/09/20 04:43:35 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2025/09/20 04:43:35 DEBUG : ftp://127.0.0.1:28622/rclone-test-lavaxef8mahu: closing 2 unused connections --- PASS: TestIntegration (2.52s) --- 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.49s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.00s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (0.24s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.02s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.01s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.02s) --- 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.18s) --- 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.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.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.03s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.03s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.04s) --- 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.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) === RUN TestIntegrationProftpd ftp_test.go:23: skipping as -remote is set --- SKIP: TestIntegrationProftpd (0.00s) === RUN TestIntegrationPureftpd ftp_test.go:34: skipping as -remote is set --- SKIP: TestIntegrationPureftpd (0.00s) === RUN TestIntegrationVsftpd ftp_test.go:45: skipping as -remote is set --- SKIP: TestIntegrationVsftpd (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 2.530s "go test -v -timeout 1h0m0s -remote TestFTPRclone: -verbose" - Finished OK in 3.762534473s (try 1/5)