"./operations.test -test.v -test.timeout 1h0m0s -remote TestFTPRclone: -verbose -test.run '^TestIndexChangedDirTime$'" - Starting (try 4/5) 2026/10/06 04:55:12 DEBUG : Creating backend with remote "TestFTPRclone:rclone-test-vuyiqap9boce" 2026/10/06 04:55:12 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/10/06 04:55:12 DEBUG : Setting type=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_TYPE 2026/10/06 04:55:12 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/10/06 04:55:12 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/10/06 04:55:12 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/10/06 04:55:12 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/10/06 04:55:12 DEBUG : TestFTPRclone: detected overridden config - adding "{tGjim}" suffix to name 2026/10/06 04:55:12 DEBUG : Setting host=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_HOST 2026/10/06 04:55:12 DEBUG : Setting user=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_USER 2026/10/06 04:55:12 DEBUG : Setting pass=XXX for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PASS 2026/10/06 04:55:12 DEBUG : Setting port="28622" for "TestFTPRclone" from environment variable RCLONE_CONFIG_TESTFTPRCLONE_PORT 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: Connecting to FTP server 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:28622") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:51002->127.0.0.1:28622, err= 2026/10/06 04:55:12 DEBUG : Creating backend with remote "/tmp/rclone3700530741" === RUN TestIndexChangedDirTime run.go:198: Remote "ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce", Local "Local file system at /tmp/rclone3700530741", Modify Window "876000h0m0s" 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31301") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:41342->127.0.0.1:31301, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: SetModTime is not supported 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31862") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:54140->127.0.0.1:31862, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: SetModTime is not supported 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31758") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:34382->127.0.0.1:31758, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: SetModTime is not supported 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31735") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:45836->127.0.0.1:31735, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: SetModTime is not supported 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:30552") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:53176->127.0.0.1:30552, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: Connecting to FTP server 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:28622") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:51014->127.0.0.1:28622, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:30717") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:33528->127.0.0.1:30717, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31606") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:34326->127.0.0.1:31606, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31511") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:47898->127.0.0.1:31511, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: Connecting to FTP server 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: Connecting to FTP server 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31715") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:30015") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:32948->127.0.0.1:31715, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:41004->127.0.0.1:30015, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: SetModTime is not supported 2026/10/06 04:55:12 DEBUG : other/index.json.71bb21be.partial: size = 140 OK 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: SetModTime is not supported 2026/10/06 04:55:12 DEBUG : index.json.f8c7a4ea.partial: size = 371 OK 2026/10/06 04:55:12 DEBUG : other/index.json.71bb21be.partial: renamed to: other/index.json 2026/10/06 04:55:12 INFO : other/index.json: Copied (new) 2026/10/06 04:55:12 DEBUG : index.json.f8c7a4ea.partial: renamed to: index.json 2026/10/06 04:55:12 INFO : index.json: Copied (new) 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:28622") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:51016->127.0.0.1:28622, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:30476") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:40914->127.0.0.1:30476, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: SetModTime is not supported 2026/10/06 04:55:12 DEBUG : sub/index.json.7b937302.partial: size = 255 OK 2026/10/06 04:55:12 DEBUG : sub/index.json.7b937302.partial: renamed to: sub/index.json 2026/10/06 04:55:12 INFO : sub/index.json: Copied (new) 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:28622") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:51018->127.0.0.1:28622, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:30951") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:53550->127.0.0.1:30951, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: SetModTime is not supported 2026/10/06 04:55:12 DEBUG : sub/deep/index.json.92d08c04.partial: size = 139 OK 2026/10/06 04:55:12 DEBUG : sub/deep/index.json.92d08c04.partial: renamed to: sub/deep/index.json 2026/10/06 04:55:12 INFO : sub/deep/index.json: Copied (new) 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31698") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:33622->127.0.0.1:31698, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: SetModTime is not supported 2026/10/06 04:55:12 INFO : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: Partial index: listing 3 directories and walking 0 changed directories 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31295") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:42856->127.0.0.1:31295, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:30402") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:51496->127.0.0.1:30402, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31578") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:37192->127.0.0.1:31578, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31670") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:38852->127.0.0.1:31670, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: SetModTime is not supported 2026/10/06 04:55:12 DEBUG : sub/deep/index.json.6ed8e97b.partial: size = 275 OK 2026/10/06 04:55:12 DEBUG : sub/deep/index.json.6ed8e97b.partial: renamed to: sub/deep/index.json 2026/10/06 04:55:12 INFO : sub/deep/index.json: Copied (replaced existing) 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:30272") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:57670->127.0.0.1:30272, err= 2026/10/06 04:55:12 DEBUG : sub/index.json: Unchanged skipping 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:30894") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:41428->127.0.0.1:30894, err= 2026/10/06 04:55:12 DEBUG : index.json: Unchanged skipping index_test.go:540: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/operations/index_test.go:540 Error: Not equal: expected: 3 actual : 1 Test: TestIndexChangedDirTime 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31061") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:39360->127.0.0.1:31061, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31284") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:34448->127.0.0.1:31284, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31302") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:44710->127.0.0.1:31302, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31834") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:40858->127.0.0.1:31834, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:30164") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:33482->127.0.0.1:30164, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:30920") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:48342->127.0.0.1:30920, err= --- FAIL: TestIndexChangedDirTime (0.08s) FAIL 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: dial("tcp","127.0.0.1:31368") 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: > dial: conn=127.0.0.1:45034->127.0.0.1:31368, err= 2026/10/06 04:55:12 DEBUG : ftp://127.0.0.1:28622/rclone-test-vuyiqap9boce: Purge dir "" "./operations.test -test.v -test.timeout 1h0m0s -remote TestFTPRclone: -verbose -test.run '^TestIndexChangedDirTime$'" - Finished ERROR in 129.15967ms (try 4/5): exit status 1: Failed [TestIndexChangedDirTime]