"./gitannex.test -test.v -test.timeout 2h0m0s -remote TestDrime: -verbose" - Starting (try 1/5) 2026/02/05 04:03:08 DEBUG : Creating backend with remote "TestDrime:rclone-test-kasudax9patu" 2026/02/05 04:03:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/02/05 04:03:09 DEBUG : Creating backend with remote "/tmp/rclone4154492722" === RUN TestEndToEnd e2e_test.go:189: Skipping because fstest remote was specified. --- SKIP: TestEndToEnd (0.00s) === RUN TestEndToEndMigration e2e_test.go:189: Skipping because fstest remote was specified. --- SKIP: TestEndToEndMigration (0.00s) === RUN TestEndToEndRepoLayoutCompat e2e_test.go:189: Skipping because fstest remote was specified. --- SKIP: TestEndToEndRepoLayoutCompat (0.00s) === RUN TestFixArgsForSymlinkIdentity --- PASS: TestFixArgsForSymlinkIdentity (0.00s) === RUN TestFixArgsForSymlinkCorrectName --- PASS: TestFixArgsForSymlinkCorrectName (0.00s) === RUN TestMessageParser === RUN TestMessageParser/OneParam === PAUSE TestMessageParser/OneParam === RUN TestMessageParser/TwoParams === PAUSE TestMessageParser/TwoParams === RUN TestMessageParser/TwoParamsNoTrailingNewline === PAUSE TestMessageParser/TwoParamsNoTrailingNewline === RUN TestMessageParser/ThreeParamsWhereFinalParamContainsSpaces === PAUSE TestMessageParser/ThreeParamsWhereFinalParamContainsSpaces === RUN TestMessageParser/OneLongFinalParameter === PAUSE TestMessageParser/OneLongFinalParameter === RUN TestMessageParser/MultipleSpaces === PAUSE TestMessageParser/MultipleSpaces === RUN TestMessageParser/StartsWithSpace === PAUSE TestMessageParser/StartsWithSpace === CONT TestMessageParser/OneParam === CONT TestMessageParser/OneLongFinalParameter === CONT TestMessageParser/TwoParamsNoTrailingNewline === CONT TestMessageParser/StartsWithSpace === CONT TestMessageParser/TwoParams === CONT TestMessageParser/MultipleSpaces === CONT TestMessageParser/ThreeParamsWhereFinalParamContainsSpaces === RUN TestMessageParser/OneLongFinalParameter/lineEnding === RUN TestMessageParser/OneLongFinalParameter/lineEnding0a === RUN TestMessageParser/OneLongFinalParameter/lineEnding0d === RUN TestMessageParser/OneLongFinalParameter/lineEnding0d0a === RUN TestMessageParser/OneLongFinalParameter/lineEnding0a0d --- PASS: TestMessageParser (0.00s) --- PASS: TestMessageParser/StartsWithSpace (0.00s) --- PASS: TestMessageParser/TwoParams (0.00s) --- PASS: TestMessageParser/MultipleSpaces (0.00s) --- PASS: TestMessageParser/ThreeParamsWhereFinalParamContainsSpaces (0.00s) --- PASS: TestMessageParser/OneLongFinalParameter (0.00s) --- PASS: TestMessageParser/OneLongFinalParameter/lineEnding (0.00s) --- PASS: TestMessageParser/OneLongFinalParameter/lineEnding0a (0.00s) --- PASS: TestMessageParser/OneLongFinalParameter/lineEnding0d (0.00s) --- PASS: TestMessageParser/OneLongFinalParameter/lineEnding0d0a (0.00s) --- PASS: TestMessageParser/OneLongFinalParameter/lineEnding0a0d (0.00s) --- PASS: TestMessageParser/TwoParamsNoTrailingNewline (0.00s) --- PASS: TestMessageParser/OneParam (0.00s) === RUN TestConfigDefinitionOneName --- PASS: TestConfigDefinitionOneName (0.00s) === RUN TestConfigDefinitionTwoNames --- PASS: TestConfigDefinitionTwoNames (0.00s) === RUN TestConfigDefinitionThreeNames --- PASS: TestConfigDefinitionThreeNames (0.00s) === RUN TestWindowsFilepathRelQuirk gitannex_test.go:371: --- SKIP: TestWindowsFilepathRelQuirk (0.00s) === RUN TestReadLineHasShortDeadline --- PASS: TestReadLineHasShortDeadline (0.05s) === RUN TestGitAnnexFstestBackendCases === RUN TestGitAnnexFstestBackendCases/HandlesInit run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:10 ERROR : error listing: directory not found 2026/02/05 04:03:13 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/HandlesListConfigs run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:17 ERROR : error listing: directory not found 2026/02/05 04:03:20 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/HandlesPrepare run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:21 ERROR : error listing: directory not found 2026/02/05 04:03:22 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/HandlesPrepareWithUnknownLayout run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:22 DEBUG : Config file has changed externally - reloading 2026/02/05 04:03:22 ERROR : error listing: directory not found 2026/02/05 04:03:22 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/HandlesPrepareWithNonexistentRemote run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:22 ERROR : error listing: directory not found 2026/02/05 04:03:23 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/HandlesPrepareWithPathAsRemote run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:23 ERROR : error listing: directory not found 2026/02/05 04:03:23 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/HandlesPrepareWithNonexistentBackendAsRemote run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:23 ERROR : error listing: directory not found 2026/02/05 04:03:24 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/HandlesPrepareWithBackendAsRemote run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:24 ERROR : error listing: directory not found 2026/02/05 04:03:24 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/HandlesPrepareWithBackendMissingTrailingColonAsRemote run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:24 ERROR : error listing: directory not found 2026/02/05 04:03:24 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/HandlesPrepareWithBackendContainingOptionsAsRemote run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:25 ERROR : error listing: directory not found 2026/02/05 04:03:25 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/HandlesPrepareWithBackendContainingOptionsAndIllegalPathAsRemote run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:25 ERROR : error listing: directory not found 2026/02/05 04:03:25 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/HandlesPrepareWithRemoteContainingOptions run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:25 ERROR : error listing: directory not found 2026/02/05 04:03:26 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/HandlesPrepareWithSynonyms run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:26 ERROR : error listing: directory not found 2026/02/05 04:03:26 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/HandlesPrepareAndDoesNotTrimWhitespaceFromValue run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:26 ERROR : error listing: directory not found 2026/02/05 04:03:27 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/HandlesEarlyError run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:27 ERROR : error listing: directory not found 2026/02/05 04:03:27 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/ConfigFail run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:27 ERROR : error listing: directory not found 2026/02/05 04:03:27 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/TransferStoreEmptyPath run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:28 ERROR : error listing: directory not found 2026/02/05 04:03:28 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/ExtensionsCompound run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:28 ERROR : error listing: directory not found 2026/02/05 04:03:28 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/ExtensionsIdempotent run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:28 ERROR : error listing: directory not found 2026/02/05 04:03:29 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/ExtensionsSupportsMultiple run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:29 ERROR : error listing: directory not found 2026/02/05 04:03:29 ERROR : error listing: directory not found === RUN TestGitAnnexFstestBackendCases/TransferStoreAbsolute run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:03:29 DEBUG : Creating backend with remote "TestDrime:rclone-test-kasudax9patu" 2026/02/05 04:03:30 DEBUG : Creating backend with remote "/tmp/rclone4154492722" 2026/02/05 04:03:30 DEBUG : file.txt: Need to transfer - File not found at Destination 2026/02/05 04:03:33 DEBUG : KeyAbsolute: size = 5 OK 2026/02/05 04:03:33 INFO : file.txt: Copied (new) to: KeyAbsolute 2026/02/05 04:03:33 ERROR : error listing: directory not found fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2026/02/05 04:03:35 ERROR : error listing: directory not found fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2026/02/05 04:03:37 ERROR : error listing: directory not found fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:994 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Should be true Test: TestGitAnnexFstestBackendCases/TransferStoreAbsolute Messages: listing wrong, want KeyAbsolute (5) got fstest.go:203: Not found "KeyAbsolute" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:994 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 Error: Not equal: expected: 0 actual : 1 Test: TestGitAnnexFstestBackendCases/TransferStoreAbsolute Messages: 1 objects not found 2026/02/05 04:03:41 DEBUG : file.txt: Need to transfer - File not found at Destination 2026/02/05 04:03:44 DEBUG : KeyAbsolute2: size = 5 OK 2026/02/05 04:03:44 INFO : file.txt: Copied (new) to: KeyAbsolute2 fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1002 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Should be true Test: TestGitAnnexFstestBackendCases/TransferStoreAbsolute Messages: listing wrong, want KeyAbsolute (5), KeyAbsolute2 (5) got KeyAbsolute (5) fstest.go:203: Not found "KeyAbsolute2" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1002 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 Error: Not equal: expected: 0 actual : 1 Test: TestGitAnnexFstestBackendCases/TransferStoreAbsolute Messages: 1 objects not found fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1417 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Should be true Test: TestGitAnnexFstestBackendCases/TransferStoreAbsolute Messages: listing wrong, want got KeyAbsolute (5), KeyAbsolute2 (5) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1417 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Should be true Test: TestGitAnnexFstestBackendCases/TransferStoreAbsolute Messages: Unexpected file "KeyAbsolute" fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1417 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Should be true Test: TestGitAnnexFstestBackendCases/TransferStoreAbsolute Messages: Unexpected file "KeyAbsolute2" === RUN TestGitAnnexFstestBackendCases/TransferStoreRelative run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:04:03 DEBUG : Creating backend with remote "TestDrime:rclone-test-kasudax9patu" 2026/02/05 04:04:04 DEBUG : Creating backend with remote "../../rclone4154492722" 2026/02/05 04:04:04 DEBUG : fs cache: renaming cache item "../../rclone4154492722" to be canonical "/tmp/rclone4154492722" 2026/02/05 04:04:04 DEBUG : file.txt: Need to transfer - File not found at Destination 2026/02/05 04:04:07 DEBUG : KeyRelative: size = 5 OK 2026/02/05 04:04:07 INFO : file.txt: Copied (new) to: KeyRelative fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1047 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Should be true Test: TestGitAnnexFstestBackendCases/TransferStoreRelative Messages: listing wrong, want KeyRelative (5) got fstest.go:203: Not found "KeyRelative" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1047 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 Error: Not equal: expected: 0 actual : 1 Test: TestGitAnnexFstestBackendCases/TransferStoreRelative Messages: 1 objects not found fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1417 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Should be true Test: TestGitAnnexFstestBackendCases/TransferStoreRelative Messages: listing wrong, want got KeyRelative (5) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1417 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Should be true Test: TestGitAnnexFstestBackendCases/TransferStoreRelative Messages: Unexpected file "KeyRelative" 2026/02/05 04:04:25 DEBUG : pacer: low level retry 1/10 (error Error "Server Error") 2026/02/05 04:04:25 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/02/05 04:04:26 DEBUG : pacer: low level retry 2/10 (error Error "Server Error") 2026/02/05 04:04:26 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2026/02/05 04:04:26 DEBUG : pacer: low level retry 3/10 (error Error "Server Error") 2026/02/05 04:04:26 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2026/02/05 04:04:26 DEBUG : pacer: low level retry 4/10 (error Error "Server Error") 2026/02/05 04:04:26 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2026/02/05 04:04:27 DEBUG : pacer: low level retry 5/10 (error Error "Server Error") 2026/02/05 04:04:27 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2026/02/05 04:04:27 DEBUG : pacer: low level retry 6/10 (error Error "Server Error") 2026/02/05 04:04:27 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2026/02/05 04:04:27 DEBUG : pacer: low level retry 7/10 (error Error "Server Error") 2026/02/05 04:04:27 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2026/02/05 04:04:28 DEBUG : pacer: low level retry 8/10 (error Error "Server Error") 2026/02/05 04:04:28 DEBUG : pacer: Rate limited, increasing sleep to 2.56s 2026/02/05 04:04:29 DEBUG : pacer: low level retry 9/10 (error Error "Server Error") 2026/02/05 04:04:29 DEBUG : pacer: Rate limited, increasing sleep to 5.12s 2026/02/05 04:04:32 DEBUG : pacer: low level retry 10/10 (error Error "Server Error") 2026/02/05 04:04:32 DEBUG : pacer: Rate limited, increasing sleep to 10.24s run.go:130: removing file "KeyRelative" failed - try 1/3: failed to delete item: Error "Server Error" 2026/02/05 04:04:37 DEBUG : pacer: low level retry 1/10 (error Error "Server Error") 2026/02/05 04:04:37 DEBUG : pacer: Rate limited, increasing sleep to 20s 2026/02/05 04:04:47 DEBUG : pacer: low level retry 2/10 (error Error "Server Error") 2026/02/05 04:05:07 DEBUG : pacer: low level retry 3/10 (error Error "Server Error") 2026/02/05 04:05:27 DEBUG : pacer: low level retry 4/10 (error Error "Server Error") 2026/02/05 04:05:48 DEBUG : pacer: low level retry 5/10 (error Error "Server Error") 2026/02/05 04:06:07 DEBUG : pacer: low level retry 6/10 (error Error "Server Error") 2026/02/05 04:06:27 DEBUG : pacer: low level retry 7/10 (error Error "Server Error") 2026/02/05 04:06:47 DEBUG : pacer: low level retry 8/10 (error Error "Server Error") 2026/02/05 04:07:07 DEBUG : pacer: low level retry 9/10 (error Error "Server Error") 2026/02/05 04:07:28 DEBUG : pacer: low level retry 10/10 (error Error "Server Error") run.go:130: removing file "KeyRelative" failed - try 2/3: failed to delete item: Error "Server Error" 2026/02/05 04:07:47 DEBUG : pacer: low level retry 1/10 (error Error "Server Error") 2026/02/05 04:08:07 DEBUG : pacer: low level retry 2/10 (error Error "Server Error") 2026/02/05 04:08:27 DEBUG : pacer: low level retry 3/10 (error Error "Server Error") 2026/02/05 04:08:47 DEBUG : pacer: low level retry 4/10 (error Error "Server Error") 2026/02/05 04:09:08 DEBUG : pacer: low level retry 5/10 (error Error "Server Error") 2026/02/05 04:09:27 DEBUG : pacer: low level retry 6/10 (error Error "Server Error") 2026/02/05 04:09:47 DEBUG : pacer: low level retry 7/10 (error Error "Server Error") 2026/02/05 04:13:33 DEBUG : pacer: low level retry 8/10 (error Error "Server Error") 2026/02/05 04:13:33 DEBUG : pacer: low level retry 9/10 (error Error "Server Error") 2026/02/05 04:13:53 DEBUG : pacer: low level retry 10/10 (error Error "Server Error") run.go:130: removing file "KeyRelative" failed - try 3/3: failed to delete item: Error "Server Error" run.go:133: removing file "KeyRelative" failed: failed to delete item: Error "Server Error" 2026/02/05 04:14:13 DEBUG : pacer: Reducing sleep to 10s === RUN TestGitAnnexFstestBackendCases/TransferStorePathWithInteriorWhitespace run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:14:13 DEBUG : Config file has changed externally - reloading 2026/02/05 04:14:13 DEBUG : Creating backend with remote "TestDrime:rclone-test-kasudax9patu" 2026/02/05 04:14:13 DEBUG : Creating backend with remote "../../rclone4154492722" 2026/02/05 04:14:13 DEBUG : fs cache: renaming cache item "../../rclone4154492722" to be canonical "/tmp/rclone4154492722" 2026/02/05 04:14:14 DEBUG : filename with spaces.txt: Need to transfer - File not found at Destination 2026/02/05 04:14:15 DEBUG : KeyRelative: size = 5 OK 2026/02/05 04:14:15 INFO : filename with spaces.txt: Copied (new) to: KeyRelative 2026/02/05 04:14:34 DEBUG : pacer: Reducing sleep to 5s 2026/02/05 04:14:43 DEBUG : pacer: Reducing sleep to 2.5s 2026/02/05 04:14:48 DEBUG : pacer: Reducing sleep to 1.25s 2026/02/05 04:14:50 DEBUG : pacer: Reducing sleep to 625ms 2026/02/05 04:14:52 DEBUG : pacer: Reducing sleep to 312.5ms 2026/02/05 04:14:52 DEBUG : pacer: Reducing sleep to 156.25ms === RUN TestGitAnnexFstestBackendCases/CheckPresentAndTransfer run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:14:52 DEBUG : Creating backend with remote "TestDrime:rclone-test-kasudax9patu" 2026/02/05 04:14:54 DEBUG : Creating backend with remote "/tmp/rclone4154492722" 2026/02/05 04:14:54 DEBUG : file.txt: Need to transfer - File not found at Destination 2026/02/05 04:18:26 DEBUG : KeyAbsolute: size = 5 OK gitannex_test.go:307: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:307 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1119 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 Error: Received unexpected error: attempt to read line timed out: context deadline exceeded Test: TestGitAnnexFstestBackendCases/CheckPresentAndTransfer 2026/02/05 04:18:26 INFO : file.txt: Copied (new) to: KeyAbsolute 2026/02/05 04:18:26 DEBUG : pacer: Reducing sleep to 78.125ms 2026/02/05 04:18:26 DEBUG : pacer: Reducing sleep to 39.0625ms 2026/02/05 04:18:26 DEBUG : pacer: Reducing sleep to 19.53125ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2026/02/05 04:18:28 DEBUG : pacer: Reducing sleep to 10ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1417 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:307 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1119 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 Error: Should be true Test: TestGitAnnexFstestBackendCases/CheckPresentAndTransfer Messages: listing wrong, want got KeyAbsolute (5) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1417 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 /usr/local/go/src/runtime/panic.go:636 /usr/local/go/src/testing/testing.go:1041 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:307 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1119 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 Error: Should be true Test: TestGitAnnexFstestBackendCases/CheckPresentAndTransfer Messages: Unexpected file "KeyAbsolute" 2026/02/05 04:18:35 DEBUG : pacer: low level retry 1/10 (error Error "Server Error") 2026/02/05 04:18:35 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/02/05 04:18:35 DEBUG : pacer: low level retry 2/10 (error Error "Server Error") 2026/02/05 04:18:35 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2026/02/05 04:18:35 DEBUG : pacer: low level retry 3/10 (error Error "Server Error") 2026/02/05 04:18:35 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2026/02/05 04:18:36 DEBUG : pacer: low level retry 4/10 (error Error "Server Error") 2026/02/05 04:18:36 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2026/02/05 04:18:36 DEBUG : pacer: low level retry 5/10 (error Error "Server Error") 2026/02/05 04:18:36 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2026/02/05 04:18:36 DEBUG : pacer: low level retry 6/10 (error Error "Server Error") 2026/02/05 04:18:36 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2026/02/05 04:18:36 DEBUG : pacer: low level retry 7/10 (error Error "Server Error") 2026/02/05 04:18:36 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2026/02/05 04:18:37 DEBUG : pacer: low level retry 8/10 (error Error "Server Error") 2026/02/05 04:18:37 DEBUG : pacer: Rate limited, increasing sleep to 2.56s 2026/02/05 04:18:38 DEBUG : pacer: low level retry 9/10 (error Error "Server Error") 2026/02/05 04:18:38 DEBUG : pacer: Rate limited, increasing sleep to 5.12s 2026/02/05 04:18:41 DEBUG : pacer: low level retry 10/10 (error Error "Server Error") 2026/02/05 04:18:41 DEBUG : pacer: Rate limited, increasing sleep to 10.24s run.go:130: removing file "KeyAbsolute" failed - try 1/3: failed to delete item: Error "Server Error" 2026/02/05 04:18:46 DEBUG : pacer: low level retry 1/10 (error Error "Server Error") 2026/02/05 04:18:46 DEBUG : pacer: Rate limited, increasing sleep to 20s 2026/02/05 04:18:56 DEBUG : pacer: low level retry 2/10 (error Error "Server Error") 2026/02/05 04:19:16 DEBUG : pacer: low level retry 3/10 (error Error "Server Error") 2026/02/05 04:19:36 DEBUG : pacer: low level retry 4/10 (error Error "Server Error") 2026/02/05 04:19:56 DEBUG : pacer: low level retry 5/10 (error Error "Server Error") 2026/02/05 04:20:16 DEBUG : pacer: low level retry 6/10 (error Error "Server Error") 2026/02/05 04:20:36 DEBUG : pacer: low level retry 7/10 (error Error "Server Error") 2026/02/05 04:21:20 DEBUG : pacer: low level retry 8/10 (error Error "Server Error") 2026/02/05 04:21:37 DEBUG : pacer: low level retry 9/10 (error Error "Server Error") 2026/02/05 04:21:57 DEBUG : pacer: low level retry 10/10 (error Error "Server Error") run.go:130: removing file "KeyAbsolute" failed - try 2/3: failed to delete item: Error "Server Error" 2026/02/05 04:24:45 DEBUG : pacer: low level retry 1/10 (error Error "Server Error") 2026/02/05 04:24:45 DEBUG : pacer: low level retry 2/10 (error Error "Server Error") 2026/02/05 04:25:05 DEBUG : pacer: low level retry 3/10 (error Error "Server Error") 2026/02/05 04:26:03 DEBUG : pacer: low level retry 4/10 (error Error "Server Error") 2026/02/05 04:26:08 DEBUG : pacer: low level retry 5/10 (error Error "Server Error") 2026/02/05 04:26:27 DEBUG : pacer: low level retry 6/10 (error Error "Server Error") 2026/02/05 04:26:47 DEBUG : pacer: low level retry 7/10 (error Error "Server Error") 2026/02/05 04:27:17 DEBUG : pacer: low level retry 8/10 (error Error "Server Error") 2026/02/05 04:27:36 DEBUG : pacer: low level retry 9/10 (error Error "Server Error") 2026/02/05 04:27:56 DEBUG : pacer: low level retry 10/10 (error Error "Server Error") run.go:130: removing file "KeyAbsolute" failed - try 3/3: failed to delete item: Error "Server Error" run.go:133: removing file "KeyAbsolute" failed: failed to delete item: Error "Server Error" 2026/02/05 04:28:16 DEBUG : pacer: Reducing sleep to 10s === RUN TestGitAnnexFstestBackendCases/CheckpresentTransferCheckpresent run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:28:16 DEBUG : Config file has changed externally - reloading 2026/02/05 04:28:16 DEBUG : Creating backend with remote "TestDrime:rclone-test-kasudax9patu" 2026/02/05 04:28:17 DEBUG : Creating backend with remote "/tmp/rclone4154492722" 2026/02/05 04:28:17 DEBUG : file.txt: Need to transfer - File not found at Destination 2026/02/05 04:28:21 DEBUG : foo: size = 5 OK 2026/02/05 04:28:21 INFO : file.txt: Copied (new) to: foo 2026/02/05 04:28:36 DEBUG : pacer: Reducing sleep to 5s 2026/02/05 04:28:46 DEBUG : pacer: Reducing sleep to 2.5s 2026/02/05 04:28:51 DEBUG : pacer: Reducing sleep to 1.25s 2026/02/05 04:28:54 DEBUG : pacer: Reducing sleep to 625ms 2026/02/05 04:28:55 DEBUG : pacer: Reducing sleep to 312.5ms 2026/02/05 04:28:56 DEBUG : pacer: Reducing sleep to 156.25ms === RUN TestGitAnnexFstestBackendCases/TransferAndCheckpresentWithRealisticKey run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:28:56 DEBUG : Creating backend with remote "TestDrime:rclone-test-kasudax9patu" 2026/02/05 04:28:56 DEBUG : Creating backend with remote "/tmp/rclone4154492722" 2026/02/05 04:28:57 DEBUG : file.txt: Need to transfer - File not found at Destination 2026/02/05 04:28:58 DEBUG : SHA256E-s1048576--7ba87e06b9b7903cfbaf4a38736766c161e3e7b42f06fe57f040aa410a8f0701.this-is-a-test-key: size = 5 OK 2026/02/05 04:28:58 INFO : file.txt: Copied (new) to: SHA256E-s1048576--7ba87e06b9b7903cfbaf4a38736766c161e3e7b42f06fe57f040aa410a8f0701.this-is-a-test-key 2026/02/05 04:28:59 DEBUG : pacer: Reducing sleep to 78.125ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2026/02/05 04:29:00 DEBUG : pacer: Reducing sleep to 39.0625ms 2026/02/05 04:29:00 DEBUG : pacer: Reducing sleep to 19.53125ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2026/02/05 04:29:02 DEBUG : pacer: Reducing sleep to 10ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1188 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Should be true Test: TestGitAnnexFstestBackendCases/TransferAndCheckpresentWithRealisticKey Messages: listing wrong, want SHA256E-s1048576--7ba87e06b9b7903cfbaf4a38736766c161e3e7b42f06fe57f040aa410a8f0701.this-is-a-test-key (5) got fstest.go:203: Not found "SHA256E-s1048576--7ba87e06b9b7903cfbaf4a38736766c161e3e7b42f06fe57f040aa410a8f0701.this-is-a-test-key" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1188 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 Error: Not equal: expected: 0 actual : 1 Test: TestGitAnnexFstestBackendCases/TransferAndCheckpresentWithRealisticKey Messages: 1 objects not found fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1417 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Should be true Test: TestGitAnnexFstestBackendCases/TransferAndCheckpresentWithRealisticKey Messages: listing wrong, want got SHA256E-s1048576--7ba87e06b9b7903cfbaf4a38736766c161e3e7b42f06fe57f040aa410a8f0701.this-is-a-test-key (5) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1417 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Should be true Test: TestGitAnnexFstestBackendCases/TransferAndCheckpresentWithRealisticKey Messages: Unexpected file "SHA256E-s1048576--7ba87e06b9b7903cfbaf4a38736766c161e3e7b42f06fe57f040aa410a8f0701.this-is-a-test-key" 2026/02/05 04:29:17 DEBUG : pacer: low level retry 1/10 (error Error "Server Error") 2026/02/05 04:29:17 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/02/05 04:29:17 DEBUG : pacer: low level retry 2/10 (error Error "Server Error") 2026/02/05 04:29:17 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2026/02/05 04:29:17 DEBUG : pacer: low level retry 3/10 (error Error "Server Error") 2026/02/05 04:29:17 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2026/02/05 04:29:17 DEBUG : pacer: low level retry 4/10 (error Error "Server Error") 2026/02/05 04:29:17 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2026/02/05 04:29:18 DEBUG : pacer: low level retry 5/10 (error Error "Server Error") 2026/02/05 04:29:18 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2026/02/05 04:29:18 DEBUG : pacer: low level retry 6/10 (error Error "Server Error") 2026/02/05 04:29:18 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2026/02/05 04:29:18 DEBUG : pacer: low level retry 7/10 (error Error "Server Error") 2026/02/05 04:29:18 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2026/02/05 04:29:19 DEBUG : pacer: low level retry 8/10 (error Error "Server Error") 2026/02/05 04:29:19 DEBUG : pacer: Rate limited, increasing sleep to 2.56s 2026/02/05 04:29:20 DEBUG : pacer: low level retry 9/10 (error Error "Server Error") 2026/02/05 04:29:20 DEBUG : pacer: Rate limited, increasing sleep to 5.12s 2026/02/05 04:29:23 DEBUG : pacer: low level retry 10/10 (error Error "Server Error") 2026/02/05 04:29:23 DEBUG : pacer: Rate limited, increasing sleep to 10.24s run.go:130: removing file "SHA256E-s1048576--7ba87e06b9b7903cfbaf4a38736766c161e3e7b42f06fe57f040aa410a8f0701.this-is-a-test-key" failed - try 1/3: failed to delete item: Error "Server Error" 2026/02/05 04:29:28 DEBUG : pacer: low level retry 1/10 (error Error "Server Error") 2026/02/05 04:29:28 DEBUG : pacer: Rate limited, increasing sleep to 20s 2026/02/05 04:29:38 DEBUG : pacer: low level retry 2/10 (error Error "Server Error") 2026/02/05 04:29:58 DEBUG : pacer: low level retry 3/10 (error Error "Server Error") 2026/02/05 04:30:18 DEBUG : pacer: low level retry 4/10 (error Error "Server Error") 2026/02/05 04:30:38 DEBUG : pacer: low level retry 5/10 (error Error "Server Error") 2026/02/05 04:30:58 DEBUG : pacer: low level retry 6/10 (error Error "Server Error") 2026/02/05 04:31:18 DEBUG : pacer: low level retry 7/10 (error Error "Server Error") 2026/02/05 04:31:38 DEBUG : pacer: low level retry 8/10 (error Error "Server Error") 2026/02/05 04:31:58 DEBUG : pacer: low level retry 9/10 (error Error "Server Error") 2026/02/05 04:32:18 DEBUG : pacer: low level retry 10/10 (error Error "Server Error") run.go:130: removing file "SHA256E-s1048576--7ba87e06b9b7903cfbaf4a38736766c161e3e7b42f06fe57f040aa410a8f0701.this-is-a-test-key" failed - try 2/3: failed to delete item: Error "Server Error" 2026/02/05 04:32:38 DEBUG : pacer: low level retry 1/10 (error Error "Server Error") 2026/02/05 04:32:58 DEBUG : pacer: low level retry 2/10 (error Error "Server Error") 2026/02/05 04:33:18 DEBUG : pacer: low level retry 3/10 (error Error "Server Error") 2026/02/05 04:33:38 DEBUG : pacer: low level retry 4/10 (error Error "Server Error") 2026/02/05 04:33:58 DEBUG : pacer: low level retry 5/10 (error Error "Server Error") 2026/02/05 04:34:18 DEBUG : pacer: low level retry 6/10 (error Error "Server Error") 2026/02/05 04:34:38 DEBUG : pacer: low level retry 7/10 (error Error "Server Error") 2026/02/05 04:34:58 DEBUG : pacer: low level retry 8/10 (error Error "Server Error") 2026/02/05 04:35:18 DEBUG : pacer: low level retry 9/10 (error Error "Server Error") 2026/02/05 04:35:39 DEBUG : pacer: low level retry 10/10 (error Error "Server Error") run.go:130: removing file "SHA256E-s1048576--7ba87e06b9b7903cfbaf4a38736766c161e3e7b42f06fe57f040aa410a8f0701.this-is-a-test-key" failed - try 3/3: failed to delete item: Error "Server Error" run.go:133: removing file "SHA256E-s1048576--7ba87e06b9b7903cfbaf4a38736766c161e3e7b42f06fe57f040aa410a8f0701.this-is-a-test-key" failed: failed to delete item: Error "Server Error" 2026/02/05 04:35:58 DEBUG : pacer: Reducing sleep to 10s === RUN TestGitAnnexFstestBackendCases/RetrieveNonexistentFile run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:35:58 DEBUG : Config file has changed externally - reloading 2026/02/05 04:35:58 DEBUG : Creating backend with remote "TestDrime:rclone-test-kasudax9patu" 2026/02/05 04:35:59 DEBUG : Creating backend with remote "." 2026/02/05 04:35:59 DEBUG : fs cache: renaming cache item "." to be canonical "/home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex" 2026/02/05 04:36:18 DEBUG : pacer: Reducing sleep to 5s 2026/02/05 04:36:28 DEBUG : pacer: Reducing sleep to 2.5s 2026/02/05 04:36:33 DEBUG : pacer: Reducing sleep to 1.25s 2026/02/05 04:36:36 DEBUG : pacer: Reducing sleep to 625ms === RUN TestGitAnnexFstestBackendCases/StoreCheckpresentRetrieve run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:36:36 DEBUG : Creating backend with remote "TestDrime:rclone-test-kasudax9patu" 2026/02/05 04:36:36 DEBUG : Creating backend with remote "/tmp/rclone4154492722" 2026/02/05 04:36:37 DEBUG : file.txt: Need to transfer - File not found at Destination 2026/02/05 04:36:40 DEBUG : SomeKey: size = 5 OK 2026/02/05 04:36:40 INFO : file.txt: Copied (new) to: SomeKey 2026/02/05 04:36:41 DEBUG : pacer: Reducing sleep to 312.5ms 2026/02/05 04:36:41 DEBUG : SomeKey: Need to transfer - File not found at Destination 2026/02/05 04:36:42 DEBUG : file.txt.retrieved.8db7b9b7.partial: size = 5 OK 2026/02/05 04:36:42 DEBUG : file.txt.retrieved.8db7b9b7.partial: renamed to: file.txt.retrieved 2026/02/05 04:36:42 INFO : SomeKey: Copied (new) to: file.txt.retrieved 2026/02/05 04:36:43 DEBUG : pacer: Reducing sleep to 156.25ms 2026/02/05 04:36:43 DEBUG : pacer: Reducing sleep to 78.125ms 2026/02/05 04:36:43 DEBUG : pacer: Reducing sleep to 39.0625ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2026/02/05 04:36:44 DEBUG : pacer: Reducing sleep to 19.53125ms 2026/02/05 04:36:45 DEBUG : pacer: Reducing sleep to 10ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1417 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Should be true Test: TestGitAnnexFstestBackendCases/StoreCheckpresentRetrieve Messages: listing wrong, want got SomeKey (5) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1417 /usr/local/go/src/testing/testing.go:1211 /usr/local/go/src/testing/testing.go:1445 /usr/local/go/src/testing/testing.go:1786 Error: Should be true Test: TestGitAnnexFstestBackendCases/StoreCheckpresentRetrieve Messages: Unexpected file "SomeKey" === RUN TestGitAnnexFstestBackendCases/RemovePreexistingFile run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1262 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Should be true Test: TestGitAnnexFstestBackendCases/RemovePreexistingFile Messages: listing wrong, want SomeKey (5) got fstest.go:203: Not found "SomeKey" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1262 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 Error: Not equal: expected: 0 actual : 1 Test: TestGitAnnexFstestBackendCases/RemovePreexistingFile Messages: 1 objects not found 2026/02/05 04:37:03 DEBUG : Config file has changed externally - reloading 2026/02/05 04:37:03 DEBUG : Creating backend with remote "TestDrime:rclone-test-kasudax9patu" 2026/02/05 04:37:05 INFO : SomeKey: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:272 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1276 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 Error: Should be true Test: TestGitAnnexFstestBackendCases/RemovePreexistingFile Messages: listing wrong, want got SomeKey (5) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:272 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1276 /home/rclone/go/src/github.com/rclone/rclone/cmd/gitannex/gitannex_test.go:1446 Error: Should be true Test: TestGitAnnexFstestBackendCases/RemovePreexistingFile Messages: Unexpected file "SomeKey" === RUN TestGitAnnexFstestBackendCases/Remove run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:37:17 DEBUG : Creating backend with remote "TestDrime:rclone-test-kasudax9patu" 2026/02/05 04:37:17 DEBUG : Creating backend with remote "/tmp/rclone4154492722" 2026/02/05 04:37:17 DEBUG : file.txt: Need to transfer - File not found at Destination 2026/02/05 04:37:20 DEBUG : SomeKey: size = 5 OK 2026/02/05 04:37:20 INFO : file.txt: Copied (new) to: SomeKey fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 7s just to make sure 2026/02/05 04:37:33 INFO : SomeKey: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure === RUN TestGitAnnexFstestBackendCases/RemoveNonexistentFile run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" 2026/02/05 04:37:42 DEBUG : Creating backend with remote "TestDrime:rclone-test-kasudax9patu" === RUN TestGitAnnexFstestBackendCases/ExportNotSupported run.go:185: Remote "drime root 'rclone-test-kasudax9patu'", Local "Local file system at /tmp/rclone4154492722", Modify Window "876000h0m0s" --- FAIL: TestGitAnnexFstestBackendCases (2076.64s) --- PASS: TestGitAnnexFstestBackendCases/HandlesInit (3.79s) --- PASS: TestGitAnnexFstestBackendCases/HandlesListConfigs (7.59s) --- PASS: TestGitAnnexFstestBackendCases/HandlesPrepare (1.34s) --- PASS: TestGitAnnexFstestBackendCases/HandlesPrepareWithUnknownLayout (0.37s) --- PASS: TestGitAnnexFstestBackendCases/HandlesPrepareWithNonexistentRemote (0.55s) --- PASS: TestGitAnnexFstestBackendCases/HandlesPrepareWithPathAsRemote (0.49s) --- PASS: TestGitAnnexFstestBackendCases/HandlesPrepareWithNonexistentBackendAsRemote (0.54s) --- PASS: TestGitAnnexFstestBackendCases/HandlesPrepareWithBackendAsRemote (0.39s) --- PASS: TestGitAnnexFstestBackendCases/HandlesPrepareWithBackendMissingTrailingColonAsRemote (0.37s) --- PASS: TestGitAnnexFstestBackendCases/HandlesPrepareWithBackendContainingOptionsAsRemote (0.45s) --- PASS: TestGitAnnexFstestBackendCases/HandlesPrepareWithBackendContainingOptionsAndIllegalPathAsRemote (0.46s) --- PASS: TestGitAnnexFstestBackendCases/HandlesPrepareWithRemoteContainingOptions (0.45s) --- PASS: TestGitAnnexFstestBackendCases/HandlesPrepareWithSynonyms (0.57s) --- PASS: TestGitAnnexFstestBackendCases/HandlesPrepareAndDoesNotTrimWhitespaceFromValue (0.38s) --- PASS: TestGitAnnexFstestBackendCases/HandlesEarlyError (0.44s) --- PASS: TestGitAnnexFstestBackendCases/ConfigFail (0.45s) --- PASS: TestGitAnnexFstestBackendCases/TransferStoreEmptyPath (0.35s) --- PASS: TestGitAnnexFstestBackendCases/ExtensionsCompound (0.37s) --- PASS: TestGitAnnexFstestBackendCases/ExtensionsIdempotent (0.33s) --- PASS: TestGitAnnexFstestBackendCases/ExtensionsSupportsMultiple (0.40s) --- FAIL: TestGitAnnexFstestBackendCases/TransferStoreAbsolute (34.22s) --- FAIL: TestGitAnnexFstestBackendCases/TransferStoreRelative (609.67s) --- PASS: TestGitAnnexFstestBackendCases/TransferStorePathWithInteriorWhitespace (39.52s) --- FAIL: TestGitAnnexFstestBackendCases/CheckPresentAndTransfer (803.99s) --- PASS: TestGitAnnexFstestBackendCases/CheckpresentTransferCheckpresent (39.32s) --- FAIL: TestGitAnnexFstestBackendCases/TransferAndCheckpresentWithRealisticKey (422.49s) --- PASS: TestGitAnnexFstestBackendCases/RetrieveNonexistentFile (37.52s) --- FAIL: TestGitAnnexFstestBackendCases/StoreCheckpresentRetrieve (16.50s) --- FAIL: TestGitAnnexFstestBackendCases/RemovePreexistingFile (24.56s) --- PASS: TestGitAnnexFstestBackendCases/Remove (25.52s) --- PASS: TestGitAnnexFstestBackendCases/RemoveNonexistentFile (2.45s) --- PASS: TestGitAnnexFstestBackendCases/ExportNotSupported (0.80s) FAIL 2026/02/05 04:37:46 DEBUG : drime root 'rclone-test-kasudax9patu': Purge remote "./gitannex.test -test.v -test.timeout 2h0m0s -remote TestDrime: -verbose" - Finished ERROR in 34m38.137186079s (try 1/5): exit status 1: Failed [TestGitAnnexFstestBackendCases/TransferStoreAbsolute TestGitAnnexFstestBackendCases/TransferStoreRelative TestGitAnnexFstestBackendCases/CheckPresentAndTransfer TestGitAnnexFstestBackendCases/TransferAndCheckpresentWithRealisticKey TestGitAnnexFstestBackendCases/StoreCheckpresentRetrieve TestGitAnnexFstestBackendCases/RemovePreexistingFile]