"./vfs.test -test.v -test.timeout 1h0m0s -remote TestFTPRclone: -verbose -test.run '^TestDirEntryModTimeInvalidation$'" - Starting (try 5/5) 2025/02/18 04:10:08 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-nujiwaf1wemu" 2025/02/18 04:10:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/02/18 04:10:08 DEBUG : Setting type="ftp" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2025/02/18 04:10:08 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/02/18 04:10:08 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/02/18 04:10:08 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/02/18 04:10:08 DEBUG : Setting pass="WuN6Jldx3KpSphCDxpsCR2w1X-p-WpsYadqnHf5LT0Rd" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/02/18 04:10:08 DEBUG : TestFTPRclone: detected overridden config - adding "{RYB7-}" suffix to name 2025/02/18 04:10:08 DEBUG : Setting host="127.0.0.1" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2025/02/18 04:10:08 DEBUG : Setting user="rclone" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2025/02/18 04:10:08 DEBUG : Setting pass="WuN6Jldx3KpSphCDxpsCR2w1X-p-WpsYadqnHf5LT0Rd" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2025/02/18 04:10:08 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: Connecting to FTP server 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:28622") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:31844") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : Creating backend with remote "/tmp/rclone3149949604" === RUN TestDirEntryModTimeInvalidation run.go:180: Remote "ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu", Local "Local file system at /tmp/rclone3149949604", Modify Window "876000h0m0s" 2025/02/18 04:10:08 INFO : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: poll-interval is not supported by this remote 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:31588") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:31294") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:31855") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:30290") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: SetModTime is not supported 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:31990") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:31266") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:31872") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:30375") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: SetModTime is not supported 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:30344") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : : Re-reading directory (78.724155ms old) 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:30361") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= dir_test.go:687: ModTime not invalidated 2025/02/18 04:10:08 DEBUG : WaitForWriters: timeout=30s 2025/02/18 04:10:08 DEBUG : dir: Looking for writers 2025/02/18 04:10:08 DEBUG : : Looking for writers 2025/02/18 04:10:08 DEBUG : dir: reading active writers 2025/02/18 04:10:08 DEBUG : >WaitForWriters: 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:30817") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:31505") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:31101") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:30134") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:31020") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:31702") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= --- FAIL: TestDirEntryModTimeInvalidation (0.09s) FAIL 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:30555") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: dial("tcp","127.0.0.1:31483") 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: > dial: conn=*fshttp.timeoutConn, err= 2025/02/18 04:10:08 DEBUG : ftp://127.0.0.1:28622/rclone-test-nujiwaf1wemu: Purge dir "" "./vfs.test -test.v -test.timeout 1h0m0s -remote TestFTPRclone: -verbose -test.run '^TestDirEntryModTimeInvalidation$'" - Finished ERROR in 145.888413ms (try 5/5): exit status 1: Failed [TestDirEntryModTimeInvalidation]