"go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose -test.run '^TestIntegration$'" - Starting (try 2/5) === RUN TestIntegration fstests.go:438: Using remote "TestFTPPureftpd:" 2026/02/13 04:28:24 NOTICE: TestFTPPureftpd: Starting server 2026/02/13 04:28:25 NOTICE: TestFTPPureftpd: Attempting to connect to "172.17.0.7:21" try 1/100 2026/02/13 04:28:25 DEBUG : TestFTPPureftpd: Read 1, error: 2026/02/13 04:28:25 NOTICE: TestFTPPureftpd: Started server and connected to "172.17.0.7:21" 2026/02/13 04:28:25 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-qapowoz9xine" 2026/02/13 04:28:25 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/02/13 04:28:25 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/02/13 04:28:25 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:25 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:25 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:25 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:25 DEBUG : TestFTPPureftpd: detected overridden config - adding "{HmopG}" suffix to name 2026/02/13 04:28:25 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:25 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:25 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:25 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:25 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: Connecting to FTP server 2026/02/13 04:28:25 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:25 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34892->172.17.0.7:21, err= 2026/02/13 04:28:25 DEBUG : pacer: low level retry 1/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:25 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/02/13 04:28:25 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:25 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34898->172.17.0.7:21, err= 2026/02/13 04:28:25 DEBUG : pacer: low level retry 2/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:25 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2026/02/13 04:28:25 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:25 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34904->172.17.0.7:21, err= 2026/02/13 04:28:25 DEBUG : pacer: low level retry 3/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:25 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2026/02/13 04:28:25 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:25 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34910->172.17.0.7:21, err= 2026/02/13 04:28:25 DEBUG : pacer: low level retry 4/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:25 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2026/02/13 04:28:25 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:25 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34926->172.17.0.7:21, err= 2026/02/13 04:28:25 DEBUG : pacer: low level retry 5/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:25 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2026/02/13 04:28:25 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:25 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34930->172.17.0.7:21, err= 2026/02/13 04:28:25 DEBUG : pacer: low level retry 6/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:25 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2026/02/13 04:28:26 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:26 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34942->172.17.0.7:21, err= 2026/02/13 04:28:26 DEBUG : pacer: low level retry 7/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:26 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2026/02/13 04:28:26 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:26 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34958->172.17.0.7:21, err= 2026/02/13 04:28:26 DEBUG : pacer: low level retry 8/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:26 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/02/13 04:28:28 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:28 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34966->172.17.0.7:21, err= 2026/02/13 04:28:28 DEBUG : pacer: low level retry 9/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34980->172.17.0.7:21, err= 2026/02/13 04:28:30 DEBUG : pacer: Reducing sleep to 1.5s 2026/02/13 04:28:30 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38113") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:41752->172.17.0.7:38113, err= === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38613") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:60808->172.17.0.7:38613, err= === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/02/13 04:28:30 INFO : dir/subdir: Making directory 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:37533") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:37310->172.17.0.7:37533, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38848") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:38954->172.17.0.7:38848, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31115") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:43026->172.17.0.7:31115, err= 2026/02/13 04:28:30 INFO : dir/subdir: Removing directory 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:32916") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:58678->172.17.0.7:32916, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30383") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:47558->172.17.0.7:30383, err= 2026/02/13 04:28:30 INFO : dir: Removing directory 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30479") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:37576->172.17.0.7:30479, err= === RUN TestIntegration/FsMkdir/FsListEmpty 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39714") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:39736->172.17.0.7:39714, err= === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35455") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:40336->172.17.0.7:35455, err= === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:37412") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:56392->172.17.0.7:37412, err= 2026/02/13 04:28:30 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39409") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:47224->172.17.0.7:39409, err= === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:708: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38486") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:48158->172.17.0.7:38486, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36210") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:52504->172.17.0.7:36210, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36600") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:46798->172.17.0.7:36600, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30142") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:45004->172.17.0.7:30142, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:708: testing "." 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:32451") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:52464->172.17.0.7:32451, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30717") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:48574->172.17.0.7:30717, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36194") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:53254->172.17.0.7:36194, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35981") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:36250->172.17.0.7:35981, err= === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:708: testing ".." 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30857") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:49456->172.17.0.7:30857, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30142") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:45018->172.17.0.7:30142, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36066") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:38070->172.17.0.7:36066, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38398") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:40004->172.17.0.7:38398, err= === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:708: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38265") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:47978->172.17.0.7:38265, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38273") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:35716->172.17.0.7:38273, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35705") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:60674->172.17.0.7:35705, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35119") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:57238->172.17.0.7:35119, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:708: testing " leading space" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30745") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:49342->172.17.0.7:30745, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33262") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:46628->172.17.0.7:33262, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35438") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34114->172.17.0.7:35438, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36860") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:45124->172.17.0.7:36860, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:708: testing "~leading tilde" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30475") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:44048->172.17.0.7:30475, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35721") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:54022->172.17.0.7:35721, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33611") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:36438->172.17.0.7:33611, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36263") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:43654->172.17.0.7:36263, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:708: testing "␍leading CR" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33064") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:46750->172.17.0.7:33064, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:32047") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:35780->172.17.0.7:32047, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:37957") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:32916->172.17.0.7:37957, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34009") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:59230->172.17.0.7:34009, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:708: testing "␊leading LF" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34899") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:42596->172.17.0.7:34899, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38973") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:42670->172.17.0.7:38973, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34109") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:35392->172.17.0.7:34109, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38560") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:33070->172.17.0.7:38560, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:708: testing "␉leading HT" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34425") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:35632->172.17.0.7:34425, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:37065") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:40400->172.17.0.7:37065, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36902") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:55734->172.17.0.7:36902, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:32708") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34762->172.17.0.7:32708, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:708: testing "␋leading VT" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30942") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:54342->172.17.0.7:30942, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33128") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:33090->172.17.0.7:33128, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31203") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:44852->172.17.0.7:31203, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34050") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:58458->172.17.0.7:34050, err= === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:708: testing ".leading dot" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:32992") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:33812->172.17.0.7:32992, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31247") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34678->172.17.0.7:31247, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34927") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:47804->172.17.0.7:34927, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34620") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:51370->172.17.0.7:34620, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:708: testing "trailing space " 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31097") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:50346->172.17.0.7:31097, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34881") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:59810->172.17.0.7:34881, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34559") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:59340->172.17.0.7:34559, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34279") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:43510->172.17.0.7:34279, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:708: testing "trailing CR␍" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30249") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:59038->172.17.0.7:30249, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34574") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:54782->172.17.0.7:34574, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31036") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:35422->172.17.0.7:31036, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:37028") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:58458->172.17.0.7:37028, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:708: testing "trailing LF␊" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31548") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:43384->172.17.0.7:31548, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:37898") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:43566->172.17.0.7:37898, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30982") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:47350->172.17.0.7:30982, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:37301") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:40558->172.17.0.7:37301, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:708: testing "trailing HT␉" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30007") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:44798->172.17.0.7:30007, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31446") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:46794->172.17.0.7:31446, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36072") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:56022->172.17.0.7:36072, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36217") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:48800->172.17.0.7:36217, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:708: testing "trailing VT␋" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31655") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:44814->172.17.0.7:31655, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30930") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:49546->172.17.0.7:30930, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38845") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:60678->172.17.0.7:38845, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35110") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:57926->172.17.0.7:35110, err= === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:708: testing "trailing dot." 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34674") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:49916->172.17.0.7:34674, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30616") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:50612->172.17.0.7:30616, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39421") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:57428->172.17.0.7:39421, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30342") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:35870->172.17.0.7:30342, err= === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:708: testing "invalid utf-8\xfe" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30403") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:39300->172.17.0.7:30403, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35774") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:47164->172.17.0.7:35774, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38776") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:35118->172.17.0.7:38776, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35486") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:60686->172.17.0.7:35486, err= === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:708: testing "test%46.txt" 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36193") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:57114->172.17.0.7:36193, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36174") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:37290->172.17.0.7:36174, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33230") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:49786->172.17.0.7:33230, err= 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39791") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:38670->172.17.0.7:39791, err= === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30512") 2026/02/13 04:28:30 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:45816->172.17.0.7:30512, err= 2026/02/13 04:28:31 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: Connecting to FTP server 2026/02/13 04:28:32 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:32 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34998->172.17.0.7:21, err= 2026/02/13 04:28:32 DEBUG : pacer: Reducing sleep to 1.125s 2026/02/13 04:28:32 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Removed after failed upload: 1 error occurred: * potato === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/02/13 04:28:32 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35844") 2026/02/13 04:28:32 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:57086->172.17.0.7:35844, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35279") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:55846->172.17.0.7:35279, err= 2026/02/13 04:28:33 DEBUG : pacer: Reducing sleep to 843.75ms === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:787: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:820: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:869: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39200") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:52520->172.17.0.7:39200, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38922") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:33132->172.17.0.7:38922, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31815") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:52418->172.17.0.7:31815, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:32515") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:55896->172.17.0.7:32515, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35152") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:47990->172.17.0.7:35152, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34916") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:53884->172.17.0.7:34916, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33415") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:51508->172.17.0.7:33415, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31932") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:53306->172.17.0.7:31932, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38353") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:55050->172.17.0.7:38353, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39333") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:35600->172.17.0.7:39333, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39777") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:42270->172.17.0.7:39777, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35427") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:55836->172.17.0.7:35427, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30510") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:48762->172.17.0.7:30510, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:32627") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:37298->172.17.0.7:32627, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34070") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:58682->172.17.0.7:34070, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35142") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34782->172.17.0.7:35142, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38558") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:37998->172.17.0.7:38558, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/02/13 04:28:33 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2026/02/13 04:28:33 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/02/13 04:28:33 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:33 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:33 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:33 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:33 DEBUG : TestFTPPureftpd: detected overridden config - adding "{HmopG}" suffix to name 2026/02/13 04:28:33 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:33 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:33 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:33 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21: Connecting to FTP server 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:35012->172.17.0.7:21, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:37140") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:43102->172.17.0.7:37140, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30605") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:57772->172.17.0.7:30605, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33237") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:49160->172.17.0.7:33237, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:32487") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:36584->172.17.0.7:32487, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34498") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:54238->172.17.0.7:34498, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:37296") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:34360->172.17.0.7:37296, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:32665") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:41808->172.17.0.7:32665, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:32739") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:56736->172.17.0.7:32739, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38194") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:37842->172.17.0.7:38194, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39860") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:60420->172.17.0.7:39860, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1122: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:32191") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:51080->172.17.0.7:32191, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35954") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:59630->172.17.0.7:35954, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36433") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:45460->172.17.0.7:36433, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33859") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:60490->172.17.0.7:33859, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:37450") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:57248->172.17.0.7:37450, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1154: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1191: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/02/13 04:28:33 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-qapowoz9xine/hello? sausage/êé" 2026/02/13 04:28:33 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/02/13 04:28:33 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:33 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:33 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:33 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:33 DEBUG : TestFTPPureftpd: detected overridden config - adding "{HmopG}" suffix to name 2026/02/13 04:28:33 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:33 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:33 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:33 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: Connecting to FTP server 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:35028->172.17.0.7:21, err= 2026/02/13 04:28:33 DEBUG : fs cache: renaming cache item "TestFTPPureftpd:rclone-test-qapowoz9xine/hello? sausage/êé" to be canonical "TestFTPPureftpd{HmopG}:rclone-test-qapowoz9xine/hello? sausage/êé" 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:33253") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:34994->172.17.0.7:33253, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:34805") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:59132->172.17.0.7:34805, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: Connecting to FTP server 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:32400") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:35034->172.17.0.7:21, err= 2026/02/13 04:28:33 DEBUG : pacer: low level retry 1/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:33 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:35120->172.17.0.7:32400, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:30109") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:54772->172.17.0.7:30109, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:33714") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:46566->172.17.0.7:33714, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:39675") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:33498->172.17.0.7:39675, err= 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:35048->172.17.0.7:21, err= 2026/02/13 04:28:33 DEBUG : pacer: low level retry 2/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:33 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:35056->172.17.0.7:21, err= 2026/02/13 04:28:33 DEBUG : pacer: low level retry 3/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:33 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:35064->172.17.0.7:21, err= 2026/02/13 04:28:33 DEBUG : pacer: low level retry 4/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:33 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:33 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:35078->172.17.0.7:21, err= 2026/02/13 04:28:33 DEBUG : pacer: low level retry 5/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:33 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2026/02/13 04:28:34 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:34 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:35080->172.17.0.7:21, err= 2026/02/13 04:28:34 DEBUG : pacer: low level retry 6/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:34 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2026/02/13 04:28:34 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:34 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:43664->172.17.0.7:21, err= 2026/02/13 04:28:34 DEBUG : pacer: low level retry 7/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:34 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2026/02/13 04:28:35 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:35 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:43674->172.17.0.7:21, err= 2026/02/13 04:28:35 DEBUG : pacer: low level retry 8/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:35 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/02/13 04:28:36 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:36 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:43684->172.17.0.7:21, err= 2026/02/13 04:28:36 DEBUG : pacer: low level retry 9/10 (error 421 50 users (the maximum) are already logged in, sorry) 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:43708->172.17.0.7:21, err= 2026/02/13 04:28:38 DEBUG : pacer: Reducing sleep to 1.5s 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:39492") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:46484->172.17.0.7:39492, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:34009") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:47698->172.17.0.7:34009, err= 2026/02/13 04:28:38 DEBUG : Waiting for deletions to finish 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:33579") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:35620->172.17.0.7:33579, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:30300") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:33672->172.17.0.7:30300, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:35524") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:33392->172.17.0.7:35524, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:36448") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:44422->172.17.0.7:36448, err= 2026/02/13 04:28:38 INFO : a/b/c/d/e.txt: Deleted 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:35226") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:54620->172.17.0.7:35226, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:33194") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:49374->172.17.0.7:33194, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:39712") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:49724->172.17.0.7:39712, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: dial("tcp","172.17.0.7:35073") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé: > dial: conn=172.17.0.1:54510->172.17.0.7:35073, err= 2026/02/13 04:28:38 DEBUG : removing 1 level 4 directories 2026/02/13 04:28:38 INFO : a/b/c/d: Removing directory 2026/02/13 04:28:38 DEBUG : removing 1 level 3 directories 2026/02/13 04:28:38 INFO : a/b/c: Removing directory 2026/02/13 04:28:38 DEBUG : removing 1 level 2 directories 2026/02/13 04:28:38 INFO : a/b: Removing directory 2026/02/13 04:28:38 DEBUG : removing 1 level 1 directories 2026/02/13 04:28:38 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy fstests.go:1255: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33273") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:33632->172.17.0.7:33273, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36693") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:43762->172.17.0.7:36693, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31906") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:38172->172.17.0.7:31906, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39040") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:52680->172.17.0.7:39040, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39989") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:48844->172.17.0.7:39989, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39420") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:56068->172.17.0.7:39420, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: Connecting to FTP server 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31823") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:43734->172.17.0.7:21, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:35124->172.17.0.7:31823, err= 2026/02/13 04:28:38 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34651") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:60740->172.17.0.7:34651, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39071") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:46934->172.17.0.7:39071, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31445") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:53438->172.17.0.7:31445, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:32930") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:37264->172.17.0.7:32930, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31823") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:35130->172.17.0.7:31823, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:32065") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:59998->172.17.0.7:32065, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38590") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:50680->172.17.0.7:38590, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39393") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:38190->172.17.0.7:39393, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39630") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:47190->172.17.0.7:39630, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36359") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:59392->172.17.0.7:36359, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31057") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:38784->172.17.0.7:31057, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30633") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:43674->172.17.0.7:30633, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39961") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:37550->172.17.0.7:39961, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36504") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:46340->172.17.0.7:36504, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34998") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:43600->172.17.0.7:34998, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30750") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:33890->172.17.0.7:30750, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1403: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/02/13 04:28:38 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-gipomot0vopi" 2026/02/13 04:28:38 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/02/13 04:28:38 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:38 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:38 DEBUG : TestFTPPureftpd: detected overridden config - adding "{HmopG}" suffix to name 2026/02/13 04:28:38 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:38 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:38 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:38 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: Connecting to FTP server 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: > dial: conn=172.17.0.1:43742->172.17.0.7:21, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31043") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:48186->172.17.0.7:31043, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: dial("tcp","172.17.0.7:34405") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: > dial: conn=172.17.0.1:34256->172.17.0.7:34405, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: dial("tcp","172.17.0.7:33888") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: > dial: conn=172.17.0.1:38640->172.17.0.7:33888, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: dial("tcp","172.17.0.7:32904") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: > dial: conn=172.17.0.1:51938->172.17.0.7:32904, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: dial("tcp","172.17.0.7:36658") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: > dial: conn=172.17.0.1:46398->172.17.0.7:36658, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: dial("tcp","172.17.0.7:31441") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: > dial: conn=172.17.0.1:59630->172.17.0.7:31441, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: dial("tcp","172.17.0.7:30845") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: > dial: conn=172.17.0.1:47268->172.17.0.7:30845, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: dial("tcp","172.17.0.7:33596") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: > dial: conn=172.17.0.1:45484->172.17.0.7:33596, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30427") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:47268->172.17.0.7:30427, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30693") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:37794->172.17.0.7:30693, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39230") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:52608->172.17.0.7:39230, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31008") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:42730->172.17.0.7:31008, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39306") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:57672->172.17.0.7:39306, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: dial("tcp","172.17.0.7:36123") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: > dial: conn=172.17.0.1:44004->172.17.0.7:36123, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: dial("tcp","172.17.0.7:36561") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: > dial: conn=172.17.0.1:52162->172.17.0.7:36561, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: dial("tcp","172.17.0.7:30514") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: > dial: conn=172.17.0.1:42680->172.17.0.7:30514, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: dial("tcp","172.17.0.7:37228") 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: > dial: conn=172.17.0.1:43716->172.17.0.7:37228, err= 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: Purge dir "new_name" 2026/02/13 04:28:38 DEBUG : ftp://172.17.0.7:21/rclone-test-gipomot0vopi: Purge dir "" === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1597: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1628: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1699: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/02/13 04:28:39 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31333") 2026/02/13 04:28:39 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:38138->172.17.0.7:31333, err= 2026/02/13 04:28:39 DEBUG : pacer: Reducing sleep to 474.609375ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/02/13 04:28:39 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31293") 2026/02/13 04:28:39 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:33678->172.17.0.7:31293, err= 2026/02/13 04:28:39 DEBUG : pacer: Reducing sleep to 355.957031ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/02/13 04:28:40 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30498") 2026/02/13 04:28:40 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:56498->172.17.0.7:30498, err= 2026/02/13 04:28:40 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/02/13 04:28:40 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:37750") 2026/02/13 04:28:40 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:42372->172.17.0.7:37750, err= 2026/02/13 04:28:40 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/02/13 04:28:40 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33416") 2026/02/13 04:28:40 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:42924->172.17.0.7:33416, err= 2026/02/13 04:28:40 DEBUG : pacer: Reducing sleep to 150.169371ms 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:38759") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:50390->172.17.0.7:38759, err= 2026/02/13 04:28:41 DEBUG : pacer: Reducing sleep to 112.627028ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31282") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:37550->172.17.0.7:31282, err= 2026/02/13 04:28:41 DEBUG : pacer: Reducing sleep to 84.470271ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35414") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:54452->172.17.0.7:35414, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33080") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:37710->172.17.0.7:33080, err= 2026/02/13 04:28:41 DEBUG : pacer: Reducing sleep to 63.352703ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/02/13 04:28:41 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-qapowoz9xine/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/02/13 04:28:41 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/02/13 04:28:41 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:41 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:41 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:41 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:41 DEBUG : TestFTPPureftpd: detected overridden config - adding "{HmopG}" suffix to name 2026/02/13 04:28:41 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:41 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:41 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:41 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Connecting to FTP server 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:43766->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: dial("tcp","172.17.0.7:32917") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: > dial: conn=172.17.0.1:53620->172.17.0.7:32917, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/02/13 04:28:41 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-qapowoz9xine/not found.txt" 2026/02/13 04:28:41 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/02/13 04:28:41 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:41 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:41 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:41 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:41 DEBUG : TestFTPPureftpd: detected overridden config - adding "{HmopG}" suffix to name 2026/02/13 04:28:41 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:41 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:41 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:41 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/not found.txt: Connecting to FTP server 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/not found.txt: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/not found.txt: > dial: conn=172.17.0.1:43768->172.17.0.7:21, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/not found.txt: dial("tcp","172.17.0.7:39553") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/not found.txt: > dial: conn=172.17.0.1:40810->172.17.0.7:39553, err= 2026/02/13 04:28:41 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1916: Opening root remote "TestFTPPureftpd:" path "rclone-test-qapowoz9xine" from "TestFTPPureftpd:rclone-test-qapowoz9xine" 2026/02/13 04:28:41 DEBUG : Creating backend with remote "TestFTPPureftpd:" 2026/02/13 04:28:41 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/02/13 04:28:41 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:41 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:41 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:41 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:41 DEBUG : TestFTPPureftpd: detected overridden config - adding "{HmopG}" suffix to name 2026/02/13 04:28:41 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:41 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:41 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:41 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: Connecting to FTP server 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:43770->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:30589") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:44570->172.17.0.7:30589, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:34747") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:54572->172.17.0.7:34747, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:32339") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:33338->172.17.0.7:32339, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:35019") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:45518->172.17.0.7:35019, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:37249") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:50510->172.17.0.7:37249, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:36805") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:51410->172.17.0.7:36805, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1953: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:31691") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:55528->172.17.0.7:31691, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:39605") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:33578->172.17.0.7:39605, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:35919") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:60350->172.17.0.7:35919, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:33543") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:39490->172.17.0.7:33543, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:32800") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:46864->172.17.0.7:32800, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:32639") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:42128->172.17.0.7:32639, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:30017") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:50578->172.17.0.7:30017, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:39859") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:51266->172.17.0.7:39859, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:33013") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:43056->172.17.0.7:33013, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:33960") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:33052->172.17.0.7:33960, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: dial("tcp","172.17.0.7:39323") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21: > dial: conn=172.17.0.1:53494->172.17.0.7:39323, err= === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2012: 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:2117: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2133: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36084") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:48794->172.17.0.7:36084, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33175") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:36226->172.17.0.7:33175, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30851") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:56628->172.17.0.7:30851, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36681") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:44200->172.17.0.7:36681, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30396") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:59706->172.17.0.7:30396, err= === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout fstests.go:2289: FS does not support About === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34805") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:33218->172.17.0.7:34805, err= === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33062") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:58204->172.17.0.7:33062, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout 2026/02/13 04:28:41 DEBUG : Creating backend with remote "TestFTPPureftpd,concurrency='0',shut_timeout='1s':rclone-test-qapowoz9xine" 2026/02/13 04:28:41 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/02/13 04:28:41 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:41 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:41 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:41 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:41 DEBUG : TestFTPPureftpd: detected overridden config - adding "{awMHu}" suffix to name 2026/02/13 04:28:41 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:41 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:41 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:41 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: Connecting to FTP server 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:43772->172.17.0.7:21, err= 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36253") 2026/02/13 04:28:41 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:59824->172.17.0.7:36253, err= === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2372: *ftp.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2484: FS has no Copier interface === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30959") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:38206->172.17.0.7:30959, err= === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33684") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:35332->172.17.0.7:33684, err= 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34123") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:48270->172.17.0.7:34123, err= === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/02/13 04:28:42 DEBUG : Creating backend with remote "TestFTPPureftpd:rclone-test-qapowoz9xine/deeper/nonexisting/directory" 2026/02/13 04:28:42 DEBUG : Setting type="ftp" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_TYPE 2026/02/13 04:28:42 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:42 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:42 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:42 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:42 DEBUG : TestFTPPureftpd: detected overridden config - adding "{HmopG}" suffix to name 2026/02/13 04:28:42 DEBUG : Setting host="172.17.0.7" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_HOST 2026/02/13 04:28:42 DEBUG : Setting user="rclone" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_USER 2026/02/13 04:28:42 DEBUG : Setting pass="B6Dj_7T4MoFdMWnEzNB-o0dJiMadPRpiNHauo70s8nY" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_PASS 2026/02/13 04:28:42 DEBUG : Setting encoding="BackSlash,Ctl,Del,Dot,RightSpace,Slash,SquareBracket" for "TestFTPPureftpd" from environment variable RCLONE_CONFIG_TESTFTPPUREFTPD_ENCODING 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/deeper/nonexisting/directory: Connecting to FTP server 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/deeper/nonexisting/directory: dial("tcp","172.17.0.7:21") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine/deeper/nonexisting/directory: > dial: conn=172.17.0.1:43792->172.17.0.7:21, err= === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2633: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2676: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2733: FS has no Directory methods and doesn't Wrap 2026/02/13 04:28:42 DEBUG : Waiting for deletions to finish 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33860") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:47482->172.17.0.7:33860, err= 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31186") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:55614->172.17.0.7:31186, err= 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:33741") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:41860->172.17.0.7:33741, err= 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:31887") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:40130->172.17.0.7:31887, err= 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:34662") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:52554->172.17.0.7:34662, err= 2026/02/13 04:28:42 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:37599") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:38778->172.17.0.7:37599, err= 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:37637") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:36080->172.17.0.7:37637, err= 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30663") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:53858->172.17.0.7:30663, err= 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35198") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:45552->172.17.0.7:35198, err= 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:36148") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:47464->172.17.0.7:36148, err= 2026/02/13 04:28:42 DEBUG : removing 1 level 4 directories 2026/02/13 04:28:42 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠: Removing directory 2026/02/13 04:28:42 DEBUG : removing 1 level 3 directories 2026/02/13 04:28:42 INFO : hello? sausage/êé/Hello, 世界: Removing directory 2026/02/13 04:28:42 DEBUG : removing 1 level 2 directories 2026/02/13 04:28:42 INFO : hello? sausage/êé: Removing directory 2026/02/13 04:28:42 DEBUG : removing 1 level 1 directories 2026/02/13 04:28:42 INFO : hello? sausage: Removing directory 2026/02/13 04:28:42 DEBUG : removing 1 level 0 directories 2026/02/13 04:28:42 INFO : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: Removing directory 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:30297") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:40582->172.17.0.7:30297, err= 2026/02/13 04:28:42 ERROR : error listing: directory not found 2026/02/13 04:28:42 DEBUG : Waiting for deletions to finish 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:35985") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:43498->172.17.0.7:35985, err= 2026/02/13 04:28:42 ERROR : error listing: directory not found 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: dial("tcp","172.17.0.7:39439") 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: > dial: conn=172.17.0.1:42042->172.17.0.7:39439, err= 2026/02/13 04:28:42 ERROR : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: Failed to list "": directory not found 2026/02/13 04:28:42 DEBUG : removing 1 level 0 directories 2026/02/13 04:28:42 INFO : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: Removing directory 2026/02/13 04:28:42 ERROR : Failed to rmdir: directory not found === RUN TestIntegration/FsShutdown 2026/02/13 04:28:42 DEBUG : ftp://172.17.0.7:21/rclone-test-qapowoz9xine: closing 2 unused connections 2026/02/13 04:28:42 NOTICE: TestFTPPureftpd: Stopping server --- PASS: TestIntegration (17.91s) --- 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 (12.26s) --- 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.09s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.01s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutError (1.89s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (1.49s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (8.75s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.03s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (4.64s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.07s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.06s) --- 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.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (1.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.15s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.11s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.05s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (0.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (0.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/UploadTimeout (0.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/TimePrecision (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (0.01s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.00s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.02s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) PASS ok github.com/rclone/rclone/backend/ftp 17.933s "go test -v -timeout 1h0m0s -remote TestFTPPureftpd: -verbose -test.run '^TestIntegration$'" - Finished OK in 18.694882195s (try 2/5)