"./vfs.test -test.v -test.timeout 1h0m0s -remote TestFTPProftpd: -verbose -test.run '^TestDirEntryModTimeInvalidation$'" - Starting (try 2/5) 2025/02/18 01:10:53 DEBUG : Creating backend with remote "TestFTPProftpd:rclone-test-kuxewoy8sepa" 2025/02/18 01:10:53 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/02/18 01:10:53 DEBUG : Setting type="ftp" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_TYPE 2025/02/18 01:10:53 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/02/18 01:10:53 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/02/18 01:10:53 DEBUG : Setting pass="mTOPwAlS0Gy249EssiWQIC4N6U2x1l1xv0TwdwqrM58RrQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/02/18 01:10:53 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/02/18 01:10:53 DEBUG : TestFTPProftpd: detected overridden config - adding "{XnWk-}" suffix to name 2025/02/18 01:10:53 DEBUG : Setting host="172.17.0.4" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_HOST 2025/02/18 01:10:53 DEBUG : Setting user="rclone" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_USER 2025/02/18 01:10:53 DEBUG : Setting pass="mTOPwAlS0Gy249EssiWQIC4N6U2x1l1xv0TwdwqrM58RrQ" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_PASS 2025/02/18 01:10:53 DEBUG : Setting encoding="Asterisk,Ctl,Dot,Slash" for "TestFTPProftpd" from environment variable RCLONE_CONFIG_TESTFTPPROFTPD_ENCODING 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: Connecting to FTP server 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: dial("tcp","172.17.0.4:21") 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 01:10:53 DEBUG : Creating backend with remote "/tmp/rclone1497143333" === RUN TestDirEntryModTimeInvalidation run.go:180: Remote "ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa", Local "Local file system at /tmp/rclone1497143333", Modify Window "1s" 2025/02/18 01:10:53 INFO : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: poll-interval is not supported by this remote 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: dial("tcp","172.17.0.4:35492") 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: dial("tcp","172.17.0.4:36560") 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: dial("tcp","172.17.0.4:25815") 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 01:10:53 DEBUG : : Re-reading directory (79.139422ms old) 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: dial("tcp","172.17.0.4:25955") 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: > dial: conn=*fshttp.timeoutConn, err= dir_test.go:687: ModTime not invalidated 2025/02/18 01:10:53 DEBUG : WaitForWriters: timeout=30s 2025/02/18 01:10:53 DEBUG : dir: Looking for writers 2025/02/18 01:10:53 DEBUG : : Looking for writers 2025/02/18 01:10:53 DEBUG : dir: reading active writers 2025/02/18 01:10:53 DEBUG : >WaitForWriters: 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: dial("tcp","172.17.0.4:64896") 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: dial("tcp","172.17.0.4:53937") 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: dial("tcp","172.17.0.4:10895") 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: > dial: conn=*fshttp.timeoutConn, err= --- FAIL: TestDirEntryModTimeInvalidation (0.09s) FAIL 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: dial("tcp","172.17.0.4:60148") 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 01:10:53 DEBUG : ftp://172.17.0.4:21/rclone-test-kuxewoy8sepa: Purge dir "" "./vfs.test -test.v -test.timeout 1h0m0s -remote TestFTPProftpd: -verbose -test.run '^TestDirEntryModTimeInvalidation$'" - Finished ERROR in 300.69335ms (try 2/5): exit status 1: Failed [TestDirEntryModTimeInvalidation]