request "version" timed out after 25000ms

[TreedsSlop]

Short description

Every once in a while I get "[aft-plugin] request "version" timed out after 25000ms (bridge busy/under load); bridge kept warm — retry."

What happened?

See below

Diagnostics

## Description
Every once in a while I get "[aft-plugin] request "version" timed out after 25000ms (bridge busy/under load); bridge kept warm — retry." When it happens it happens multiple times in a row, prompting the model to use a different path. In the most recent case it was together with a significant slowdown of opencode desktop. I'm not sure if that is cause or symptom of the issue. 

## Environment
- AFT CLI: v0.55.1
- AFT binary: 0.55.1
- OS: win32 x64
- Node: v26.3.0
- Session: ses_019dfb862ffe2grXAlsioTz995 (opencode: custom desktop with modified server)

## Diagnostics
- Timestamp: 2026-09-14T16:21:42.126Z
- AFT CLI: v0.55.1
- AFT binary: 0.55.1
- OS: win32 x64
- Node: v26.3.0

### OpenCode
- Host installed: true
- Host version: unknown
- Plugin registered: true
- Plugin version: 0.55.1
- AFT enabled: true
- AFT config parse error: none

#### Config paths

{
  "configDir": "C:\\Users\\<USER>\\.config\\opencode",
  "harnessConfig": "C:\\Users\\<USER>\\.config\\opencode/opencode.jsonc",
  "harnessConfigFormat": "jsonc",
  "aftConfig": "C:\\Users\\<USER>\\.config\\cortexkit\\aft.jsonc",
  "aftConfigFormat": "jsonc",
  "tuiConfig": "C:\\Users\\<USER>\\.config\\opencode/tui.json",
  "tuiConfigFormat": "json"
}


#### AFT flags

{
  "$schema": "https://raw.githubusercontent.com/cortexkit/aft/main/assets/aft.schema.json",
  "tool_surface": "all",
  "semantic_search": true
}


#### Plugin cache

{
  "path": "C:\\Users\\<USER>\\.cache\\opencode\\packages\\@cortexkit\\aft-opencode@latest",
  "cached": "0.55.1",
  "latest": "0.55.1",
  "exists": true
}


#### Storage

{
  "path": "C:\\Users\\<USER>\\AppData\\Local\\cortexkit\\aft",
  "exists": true,
  "accessible": true,
  "sizesByKey": {
    "index": 0,
    "semantic": 505855437,
    "backups": 0,
    "url_cache": 0,
    "onnxruntime": 396739266,
    "logs": 27414293
  },
  "legacyDuplication": {
    "totalPartitions": 40,
    "totalBytes": 2088136322,
    "byHarness": [
      {
        "harness": "opencode",
        "partitions": 40,
        "bytes": 2088136322
      }
    ]
  }
}


#### ONNX Runtime

{
  "required": true,
  "systemPath": null,
  "systemVersion": null,
  "systemCompatible": null,
  "ignoredSystemPath": "C:\\Windows\\System32",
  "ignoredSystemReason": "version unreadable (Windows system copy) — ignored",
  "cachedPath": "C:\\Users\\<USER>\\AppData\\Local\\cortexkit\\aft\\onnxruntime\\1.24.4",
  "cachedVersion": "1.24.4",
  "cachedCompatible": true,
  "platform": "win32-x64",
  "installHint": "AFT auto-downloads ONNX Runtime on Windows",
  "requirement": ">=1.20"
}


#### Log file
`~\AppData\Local\cortexkit\aft\logs\aft-plugin.log` (26240 KB)

### Binary cache

{
  "versions": [
    "v0.43.1",
    "v0.45.1",
    "v0.55.1"
  ],
  "activeVersion": "v0.55.1",
  "totalSize": 237452288,
  "path": "C:\\Users\\<USER>\\AppData\\Local\\aft\\bin"
}


### LSP cache

{
  "npm": {
    "path": "C:\\Users\\<USER>\\AppData\\Local\\aft\\lsp-packages",
    "entries": [
      {
        "name": "intelephense",
        "path": "C:\\Users\\<USER>\\AppData\\Local\\aft\\lsp-packages\\intelephense",
        "size": 125953779
      },
      {
        "name": "@biomejs/biome",
        "path": "C:\\Users\\<USER>\\AppData\\Local\\aft\\lsp-packages\\%40biomejs%2Fbiome",
        "size": 75650602
      },
      {
        "name": "pyright",
        "path": "C:\\Users\\<USER>\\AppData\\Local\\aft\\lsp-packages\\pyright",
        "size": 19348904
      },
      {
        "name": "yaml-language-server",
        "path": "C:\\Users\\<USER>\\AppData\\Local\\aft\\lsp-packages\\yaml-language-server",
        "size": 19155713
      },
      {
        "name": "bash-language-server",
        "path": "C:\\Users\\<USER>\\AppData\\Local\\aft\\lsp-packages\\bash-language-server",
        "size": 14514761
      },
      {
        "name": "typescript-language-server",
        "path": "C:\\Users\\<USER>\\AppData\\Local\\aft\\lsp-packages\\typescript-language-server",
        "size": 2427402
      },
      {
        "name": "latex-lsp/texlab",
        "path": "C:\\Users\\<USER>\\AppData\\Local\\aft\\lsp-packages\\latex-lsp%2Ftexlab",
        "size": 80
      },
      {
        "name": "clangd/clangd",
        "path": "C:\\Users\\<USER>\\AppData\\Local\\aft\\lsp-packages\\clangd%2Fclangd",
        "size": 79
      }
    ],
    "totalSize": 257051320
  },
  "github": {
    "path": "C:\\Users\\<USER>\\AppData\\Local\\aft\\lsp-binaries",
    "entries": [
      {
        "name": "clangd",
        "path": "C:\\Users\\<USER>\\AppData\\Local\\aft\\lsp-binaries\\clangd",
        "size": 0
      },
      {
        "name": "texlab",
        "path": "C:\\Users\\<USER>\\AppData\\Local\\aft\\lsp-binaries\\texlab",
        "size": 0
      }
    ],
    "totalSize": 0
  },
  "totalSize": 257051320
}


## Recent errors (last 20, sanitized)

[2026-09-14T14:16:26.220Z] ERROR [aft-plugin] [lsp] extract texlab failed: Error: spawnSync unzip ENOENT
[2026-09-14T14:16:38.822Z] ERROR [aft-plugin] [lsp] extract clangd failed: Error: spawnSync unzip ENOENT
[2026-09-14T15:37:18.311Z] ERROR [aft-plugin] [lsp] extract texlab failed: Error: spawnSync unzip ENOENT
[2026-09-14T15:37:30.981Z] ERROR [aft-plugin] [lsp] extract clangd failed: Error: spawnSync unzip ENOENT
[2026-09-14T15:40:23.867Z] ERROR [aft-plugin] [lsp] extract texlab failed: Error: spawnSync unzip ENOENT
[2026-09-14T15:40:34.714Z] ERROR [aft-plugin] [lsp] extract clangd failed: Error: spawnSync unzip ENOENT
[2026-09-14T15:41:03.459Z] ERROR [aft-plugin] [lsp] extract texlab failed: Error: spawnSync unzip ENOENT
[2026-09-14T15:41:09.057Z] ERROR [aft-plugin] [lsp] extract clangd failed: Error: spawnSync unzip ENOENT
[2026-09-14T15:41:24.846Z] ERROR [aft-plugin] [lsp] extract texlab failed: Error: spawnSync unzip ENOENT
[2026-09-14T15:41:26.905Z] ERROR [aft-plugin] [lsp] extract clangd failed: Error: spawnSync unzip ENOENT
[2026-09-14T15:41:36.566Z] ERROR [aft-plugin] [lsp] extract clangd failed: Error: spawnSync unzip ENOENT
[2026-09-14T15:42:13.984Z] ERROR [aft-plugin] [lsp] extract clangd failed: Error: spawnSync unzip ENOENT
[2026-09-14T15:42:14.509Z] ERROR [aft-plugin] [lsp] extract texlab failed: Error: spawnSync unzip ENOENT
[2026-09-14T15:42:28.689Z] ERROR [aft-plugin] [lsp] extract clangd failed: Error: spawnSync unzip ENOENT
[2026-09-14T16:08:37.894Z] WARN [aft-plugin] Version check failed: [aft-plugin] request "version" timed out after 25000ms (bridge busy/under load); bridge kept warm — retry
[2026-09-14T16:19:05.384Z] ERROR [aft-plugin] [lsp] extract texlab failed: Error: spawnSync unzip ENOENT
[2026-09-14T16:19:10.970Z] ERROR [aft-plugin] [lsp] extract clangd failed: Error: spawnSync unzip ENOENT


### Recent AFT tool failures
- error: ERROR log line ×18
- version: timed out after 25000ms ×2

## Logs (last 200 lines per harness)
#### OpenCode log (~\AppData\Local\cortexkit\aft\logs\aft-plugin.log)


[2026-09-14T16:19:03.368Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:03.369Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:03.398Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:03.399Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:03.399Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:03.415Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:03.424Z] INFO [aft-plugin] [lsp] auto-install: 1 npm + 0 github install(s) running in background
[2026-09-14T16:19:03.431Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:03.431Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:03.431Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:03.433Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58359
[2026-09-14T16:19:03.458Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges
[2026-09-14T16:19:04.499Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:04.761Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:05.381Z] INFO [aft-plugin] [lsp] texlab v5.26.0 sha256=cb028d44c3d2b85d36a2ed52d41a0ff43a341b1f04c500c56c4524c4eb72b316
[2026-09-14T16:19:05.384Z] ERROR [aft-plugin] [lsp] extract texlab failed: Error: spawnSync unzip ENOENT
[2026-09-14T16:19:06.432Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:06.433Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:06.462Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:06.462Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:06.463Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:06.480Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:06.496Z] INFO [aft-plugin] [lsp] auto-install: 1 npm + 0 github install(s) running in background
[2026-09-14T16:19:06.502Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:06.503Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:06.503Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:06.505Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58365
[2026-09-14T16:19:06.529Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:06.530Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:06.561Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:06.561Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:06.562Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:06.578Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:06.594Z] INFO [aft-plugin] [lsp] auto-install: 0 npm + 1 github install(s) running in background
[2026-09-14T16:19:06.602Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:06.602Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:06.602Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:06.609Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges
[2026-09-14T16:19:06.611Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58366
[2026-09-14T16:19:06.627Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges
[2026-09-14T16:19:07.025Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:07.026Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:07.056Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:07.056Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:07.057Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:07.074Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:07.142Z] INFO [aft-plugin] [lsp] auto-install: 1 npm + 0 github install(s) running in background
[2026-09-14T16:19:07.150Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:07.150Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:07.150Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:07.153Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58370
[2026-09-14T16:19:07.217Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:07.218Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:07.247Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:07.247Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:07.248Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:07.265Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:07.319Z] INFO [aft-plugin] [lsp] auto-install: 2 npm + 0 github install(s) running in background
[2026-09-14T16:19:07.329Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:07.329Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:07.329Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:07.332Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58371
[2026-09-14T16:19:07.761Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:07.762Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:07.791Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:07.791Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:07.792Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:07.809Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:07.851Z] INFO [aft-plugin] [lsp] auto-install: 3 npm + 1 github install(s) running in background
[2026-09-14T16:19:07.860Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:07.860Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:07.860Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:07.863Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58372
[2026-09-14T16:19:07.881Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:07.894Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges
[2026-09-14T16:19:07.899Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges
[2026-09-14T16:19:07.912Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges
[2026-09-14T16:19:08.971Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:08.971Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:10.966Z] INFO [aft-plugin] [lsp] clangd 22.1.6 sha256=ce54f16e0b4fd76d450eeda9664420b195360b73febcfe40e661108fa57f2ce1
[2026-09-14T16:19:10.970Z] ERROR [aft-plugin] [lsp] extract clangd failed: Error: spawnSync unzip ENOENT
[2026-09-14T16:19:10.981Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges
[2026-09-14T16:19:11.504Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:11.603Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:11.894Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:11.895Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:11.925Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:11.925Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:11.926Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:11.942Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:11.961Z] INFO [aft-plugin] [lsp] auto-install: 5 npm + 0 github install(s) running in background
[2026-09-14T16:19:11.972Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:11.972Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:11.972Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:11.976Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58380
[2026-09-14T16:19:12.069Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:12.070Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:12.098Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:12.098Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:12.099Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:12.121Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:12.137Z] INFO [aft-plugin] [lsp] auto-install: 3 npm + 0 github install(s) running in background
[2026-09-14T16:19:12.144Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:12.144Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:12.144Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:12.149Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges
[2026-09-14T16:19:12.152Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58381
[2026-09-14T16:19:12.237Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:12.238Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:12.268Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:12.268Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:12.269Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:12.285Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:12.297Z] INFO [aft-plugin] [lsp] auto-install: 2 npm + 0 github install(s) running in background
[2026-09-14T16:19:12.304Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:12.304Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:12.304Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:12.309Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges
[2026-09-14T16:19:12.312Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58382
[2026-09-14T16:19:12.378Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:12.379Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:12.409Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:12.409Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:12.410Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:12.427Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:12.435Z] INFO [aft-plugin] [lsp] auto-install: 2 npm + 0 github install(s) running in background
[2026-09-14T16:19:12.442Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:12.442Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:12.442Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:12.448Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges
[2026-09-14T16:19:12.450Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58383
[2026-09-14T16:19:12.509Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:12.510Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:12.538Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:12.538Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:12.539Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:12.554Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:12.569Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:12.569Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:12.569Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:12.572Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58384
[2026-09-14T16:19:12.573Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:12.586Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges
[2026-09-14T16:19:12.588Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:13.273Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:16.977Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:17.165Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:17.364Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:17.434Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:17.435Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:17.464Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:17.464Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:17.465Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:17.481Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:17.498Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:17.498Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:17.498Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:17.501Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58395
[2026-09-14T16:19:17.512Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:17.575Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:17.575Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:17.605Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:17.606Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:17.606Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:17.621Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:17.631Z] INFO [aft-plugin] [lsp] auto-install: 1 npm + 0 github install(s) running in background
[2026-09-14T16:19:17.637Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:17.637Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:17.637Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:17.639Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58396
[2026-09-14T16:19:17.652Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:17.666Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges
[2026-09-14T16:19:18.247Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:18.248Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:18.275Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:18.275Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:18.276Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:18.291Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:18.301Z] INFO [aft-plugin] [lsp] auto-install: 1 npm + 0 github install(s) running in background
[2026-09-14T16:19:18.309Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:18.309Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:18.309Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:18.313Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58400
[2026-09-14T16:19:18.386Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:18.387Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:18.417Z] INFO [aft-plugin] Resolved binary from versioned cache: ~\AppData\Local\aft\bin\v0.55.1\aft.exe
[2026-09-14T16:19:18.417Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~\AppData\Local\opencode\storage\plugin\aft; using ~\AppData\Local\cortexkit\aft for fresh install
[2026-09-14T16:19:18.418Z] INFO [aft-plugin] Config loaded from ~\.config\cortexkit\aft.jsonc
[2026-09-14T16:19:18.436Z] INFO [aft-plugin] ONNX Runtime found at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4 (TOFU verified)
[2026-09-14T16:19:18.467Z] INFO [aft-plugin] [lsp] auto-install: 5 npm + 0 github install(s) running in background
[2026-09-14T16:19:18.478Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-14T16:19:18.478Z] INFO [aft-plugin] Workflow hints injected (5048 chars)
[2026-09-14T16:19:18.478Z] INFO [aft-plugin] ONNX Runtime ready at ~\AppData\Local\cortexkit\aft\onnxruntime\1.24.4; new bridges will load semantic backend.
[2026-09-14T16:19:18.481Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:58401
[2026-09-14T16:19:18.885Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges
[2026-09-14T16:19:18.896Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges
[2026-09-14T16:19:23.079Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:23.080Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:23.310Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)
[2026-09-14T16:19:23.478Z] INFO [aft-plugin] [auto-update-checker] Skipping check (another instance ran one recently)


_Usernames and home paths have been stripped from this report._

Plugin version

No response

AFT binary version

No response

Platform

No response

Log output (optional)

[aft-alfonso]

Thanks — the diagnostics bundle is exactly what was needed, and the mechanism is in it. Two AFT defects, both multiplied by your host: the plugin log shows the plugin instantiated 16 times in 15 seconds (RPC ports 58359 → 58401), which is normal for a multi-workspace desktop host, and each instance does startup work that is not shared across instances.

1. GitHub-installed LSPs can never install on Windows. The archive precheck runs unzip -l on every platform, while the extractor itself already uses tar.exe on Windows — so texlab and clangd fail at the precheck (spawnSync unzip ENOENT), the install lock is released, and the next plugin instance re-downloads both archives and fails again. That is the 18 ERROR lines, and 16 instances × 2 downloads on every launch is real load.
2. No cross-instance dedup for the auto-install pass. The auto-update checker has one ("Skipping check (another instance ran one recently)"); the LSP auto-installer only has a per-package lock, so 16 instances each kick off their own background npm installs.

The version timeout is the symptom: 16 bridges spawning at once, each loading a 505 MB semantic index and the ONNX runtime, plus the download/install storm above — the 25 s ping crosses the line while the box is saturated, and the desktop slowdown is the same cause, not a separate one. Fix in progress: precheck via tar.exe -tvf on Windows, a durable "failed at this release, do not retry for N hours" marker so a broken extract is not re-downloaded per instance, and one auto-install pass per machine per launch window shared across instances. I will also look at why the version ping is issued per instance at all. Landing sha here.

[TreedsSlop]

Are you suggesting this happened right after startup? It did not. The machine also wasn't maxed out in general. It might have used the maximum capacity of one thread though.

[aft-alfonso]

You're right, and I overstated the startup framing — the 16:08 timeout in your bundle is 11 minutes before the 16:19 instances, so startup load is not the cause of that one. "One thread at capacity" is the better clue, and it matches a mechanism we fixed after 0.55.1 but have not released yet.

The version request is an ordinary request on the bridge's single request thread, queued behind whatever that thread is doing. On 0.55.1 several maintenance units still run synchronously on that same thread after a bind and on watcher activity: session replay, the orphan-directory sweep over the whole storage root (yours has 40 legacy partitions / 2 GB to scan), the deferred artifact load, and callgraph refresh commits. Any of them can hold the thread past 25 s on a large tree, and the ping times out while the process is busy on one core — exactly what you observed. Trains after 0.55.1 detached the sweeps and task GC to their own threads and sliced the rest around queued requests (measured first-request latency 3 s → 135 ms on a busy storage root); that will be in 0.56.0.

To name the specific unit on your machine rather than guess: the bridge writes its own log at %LOCALAPPDATA%\cortexkit\aft\logs\aft-<pid>.log. The lines in the two minutes before 16:08:37Z (the timeout) will say what the request thread was doing — if you can paste that window (paths sanitised), I'll confirm it's the same class or find a different one.

The install-storm finding is separate and stands (the unzip precheck can never succeed on Windows, and each instance retries it); that's a real cost, just not the cause of this timeout.

[TreedsSlop]

So I got this on one thread (which was not working on the project that got the error):

2026-09-14T16:03:02Z [aft] [ses_06105e931ffeIqtFwdwRpovzQU] perf tick: watcher={ingested:0,paths:0,dropped:0} drains=7 tier2=[none] semantic={collects:0,files:0,chunks:0,ms:0} callgraph_invalidations=0 executor_completed={interactive:0,maintenance:0} oldest_queued_ms={interactive:none,maintenance:none} toolcall={new:0,window:0,p50_total_ms:0,max_total_ms:0,p50_queue_ms:0,max_queue_ms:0} file_log_dropped=0
2026-09-14T16:08:47Z [aft] [ses_06105e931ffeIqtFwdwRpovzQU] invalidated 1 files
2026-09-14T16:08:47Z [aft] callgraph store root repair requires rebuild; open-only reader reports unavailable
2026-09-14T16:09:02Z [aft] [ses_06105e931ffeIqtFwdwRpovzQU] perf tick: watcher={ingested:1,paths:1,dropped:0} drains=3 tier2=[none] semantic={collects:0,files:0,chunks:0,ms:0} callgraph_invalidations=0 executor_completed={interactive:0,maintenance:0} oldest_queued_ms={interactive:none,maintenance:none} toolcall={new:0,window:0,p50_total_ms:0,max_total_ms:0,p50_queue_ms:0,max_queue_ms:0} file_log_dropped=0
2026-09-14T16:16:03Z [aft] [ses_06105e931ffeIqtFwdwRpovzQU] perf tick: watcher={ingested:0,paths:0,dropped:0} drains=3 tier2=[none] semantic={collects:0,files:0,chunks:0,ms:0} callgraph_invalidations=0 executor_completed={interactive:0,maintenance:0} oldest_queued_ms={interactive:none,maintenance:none} toolcall={new:0,window:0,p50_total_ms:0,max_total_ms:0,p50_queue_ms:0,max_queue_ms:0} file_log_dropped=0

And this on the one that was serving the project that got the error:

2026-09-14T16:08:38Z [aft] [ses_f5f52862cffeUkrwKehGh8LMWO] project root set: C:\Users\[username]\PycharmProjects\opencode_mod
2026-09-14T16:08:39Z [aft] [ses_f5f52862cffeUkrwKehGh8LMWO] gitignore matcher built: 421 pattern(s)
2026-09-14T16:08:39Z [aft] [ses_f5f52862cffeUkrwKehGh8LMWO] search index orphan sweep root=C:\Users\[username]\AppData\Local\cortexkit\aft\index scanned=0 removed=0 skipped_derived=0 skipped_memo=0 skipped_fresh=0 skipped_live=0 skipped_locked=0 skipped_unreadable=0 budget_exhausted=false
2026-09-14T16:08:39Z [aft] [ses_f5f52862cffeUkrwKehGh8LMWO] transient search cache sweep root=C:\Users\[username]\AppData\Local\Temp\ scanned=0 removed=0 bytes=0 skipped_fresh=0 skipped_unreadable=0 budget_exhausted=false
2026-09-14T16:08:39Z [aft] watcher started: \\?\C:\Users\[username]\PycharmProjects\opencode_mod
2026-09-14T16:08:39Z [aft] watcher stopped: \\?\C:\Users\[username]\PycharmProjects\opencode_mod
2026-09-14T16:08:39Z [aft] [ses_f5f52862cffeUkrwKehGh8LMWO] bash_wait_detach: session=ses_f5f52862cffeUkrwKehGh8LMWO detached=false active_wait_sessions=0
2026-09-14T16:08:39Z [aft] [ses_f5f52862cffeUkrwKehGh8LMWO] bash_wait_detach: session=ses_f5f52862cffeUkrwKehGh8LMWO detached=false active_wait_sessions=0
2026-09-14T16:08:50Z [aft] [ses_f5f52862cffeUkrwKehGh8LMWO] perf tick: watcher={ingested:0,paths:0,dropped:0} drains=4 tier2=[none] semantic={collects:0,files:0,chunks:0,ms:0} callgraph_invalidations=0 executor_completed={interactive:0,maintenance:0} oldest_queued_ms={interactive:none,maintenance:none} toolcall={new:0,window:0,p50_total_ms:0,max_total_ms:0,p50_queue_ms:0,max_queue_ms:0} file_log_dropped=0

[aft-alfonso]

That second excerpt names it. Two facts in it:

1. watcher started followed one second later by watcher stopped for the same root is not the watcher dying — in this code watcher stopped is logged only when a replaced watcher is torn down, i.e. the bridge received a second configure for the same project and restarted everything. The plugin sends that reconfigure to every live bridge when its LSP auto-install pass finishes (lsp_paths_extra updated after auto-install: 6 dirs pushed to live bridges in your first log, 16 times). So each bridge re-runs the full configure — git probes, cache-key resolution, watcher restart with a full rescan — once per instance that finishes a pass.
2. project root set is logged at the end of configure's synchronous prefix, and it appears at 16:08:38 — one second after your version timeout fired at 16:08:37, which means the ping was sent around 16:08:12 and sat 25 s behind a configure that was still in its pre-root phase (path canonicalization, worktree probe, config resolve, cache-key resolution via git rev-list --max-parents=0, artifact lease). On 0.55.1 that prefix runs on the bridge's single request thread, so nothing else is answered until it finishes. That is your "one thread at capacity", and it lines up with the instance storm without needing the box to be saturated overall.

Two fixes, both on main now or in flight: the auto-install pass is now claimed once per machine per launch window (so 16 instances produce one push, not 16), and I'm making an lsp_paths_extra-only change apply in place instead of re-running configure — no git probes, no watcher restart when the root is unchanged.

To confirm which pre-root phase takes ~26 s on your machine (my guess is the git probes: Windows Defender makes each git spawn slow, and a fork of opencode has a deep history), two cheap reads would settle it: the lines before project root set in that same bridge log (from the start of that session's entries), and, in the opencode_mod checkout, the wall time of git rev-list --max-parents=0 HEAD and of git rev-parse --git-common-dir.

[TreedsSlop]

opencode_mod is not a git repo, it only contains git repos.
Here's the rest of the log:

2026-09-14T16:02:49Z [aft] log retention sweep: removed_files=0 bytes_freed=0
2026-09-14T16:02:49Z [aft] started, pid 16528
2026-09-14T16:02:49Z [aft] [ses_019dfb862ffe2grXAlsioTz995] project root set: C:\Users\[username]\PycharmProjects\opencode_mod
2026-09-14T16:02:50Z [aft] [ses_019dfb862ffe2grXAlsioTz995] local embedder ready: model=all-MiniLM-L6-v2 intra_threads=8 token_type_ids=true
2026-09-14T16:02:50Z [aft] [ses_019dfb862ffe2grXAlsioTz995] gitignore matcher built: 421 pattern(s)
2026-09-14T16:02:50Z [aft] [ses_019dfb862ffe2grXAlsioTz995] search index orphan sweep root=C:\Users\[username]\AppData\Local\cortexkit\aft\index scanned=0 removed=0 skipped_derived=0 skipped_memo=0 skipped_fresh=0 skipped_live=0 skipped_locked=0 skipped_unreadable=0 budget_exhausted=false
2026-09-14T16:02:50Z [aft] [ses_019dfb862ffe2grXAlsioTz995] transient search cache sweep root=C:\Users\[username]\AppData\Local\Temp\ scanned=0 removed=0 bytes=0 skipped_fresh=0 skipped_unreadable=0 budget_exhausted=false
2026-09-14T16:02:50Z [aft] watcher started: \\?\C:\Users\[username]\PycharmProjects\opencode_mod
2026-09-14T16:03:00Z [aft] [ses_019dfb862ffe2grXAlsioTz995] loaded semantic index from disk: 70548 entries
2026-09-14T16:03:02Z [aft] [ses_019dfb862ffe2grXAlsioTz995] semantic index: cached index is current (70548 entries)
2026-09-14T16:03:49Z [aft] [ses_019dfb862ffe2grXAlsioTz995] perf tick: watcher={ingested:0,paths:0,dropped:0} drains=2 tier2=[none] semantic={collects:0,files:0,chunks:0,ms:0} callgraph_invalidations=0 executor_completed={interactive:0,maintenance:0} oldest_queued_ms={interactive:none,maintenance:none} toolcall={new:0,window:0,p50_total_ms:0,max_total_ms:0,p50_queue_ms:0,max_queue_ms:0} file_log_dropped=0
2026-09-14T16:08:38Z [aft] [ses_f5f52862cffeUkrwKehGh8LMWO] project root set: C:\Users\[username]\PycharmProjects\opencode_mod
2026-09-14T16:08:39Z [aft] [ses_f5f52862cffeUkrwKehGh8LMWO] gitignore matcher built: 421 pattern(s)
2026-09-14T16:08:39Z [aft] [ses_f5f52862cffeUkrwKehGh8LMWO] search index orphan sweep root=C:\Users\[username]\AppData\Local\cortexkit\aft\index scanned=0 removed=0 skipped_derived=0 skipped_memo=0 skipped_fresh=0 skipped_live=0 skipped_locked=0 skipped_unreadable=0 budget_exhausted=false
2026-09-14T16:08:39Z [aft] [ses_f5f52862cffeUkrwKehGh8LMWO] transient search cache sweep root=C:\Users\[username]\AppData\Local\Temp\ scanned=0 removed=0 bytes=0 skipped_fresh=0 skipped_unreadable=0 budget_exhausted=false
2026-09-14T16:08:39Z [aft] watcher started: \\?\C:\Users\[username]\PycharmProjects\opencode_mod
2026-09-14T16:08:39Z [aft] watcher stopped: \\?\C:\Users\[username]\PycharmProjects\opencode_mod
2026-09-14T16:08:39Z [aft] [ses_f5f52862cffeUkrwKehGh8LMWO] bash_wait_detach: session=ses_f5f52862cffeUkrwKehGh8LMWO detached=false active_wait_sessions=0
2026-09-14T16:08:39Z [aft] [ses_f5f52862cffeUkrwKehGh8LMWO] bash_wait_detach: session=ses_f5f52862cffeUkrwKehGh8LMWO detached=false active_wait_sessions=0
2026-09-14T16:08:50Z [aft] [ses_f5f52862cffeUkrwKehGh8LMWO] perf tick: watcher={ingested:0,paths:0,dropped:0} drains=4 tier2=[none] semantic={collects:0,files:0,chunks:0,ms:0} callgraph_invalidations=0 executor_completed={interactive:0,maintenance:0} oldest_queued_ms={interactive:none,maintenance:none} toolcall={new:0,window:0,p50_total_ms:0,max_total_ms:0,p50_queue_ms:0,max_queue_ms:0} file_log_dropped=0
2026-09-14T16:15:05Z [aft] [ses_019dfb862ffe2grXAlsioTz995] bash candidate: $SHELL = C:\Program Files\Git\bin\bash.exe (POSIX, invoked as -c)
2026-09-14T16:15:05Z [aft] [ses_019dfb862ffe2grXAlsioTz995] bash candidate: powershell.exe (Windows PowerShell 5.1; && in pipelines unsupported, will surface as parse error)
2026-09-14T16:15:51Z [aft] [ses_019dfb862ffe2grXAlsioTz995] perf tick: watcher={ingested:0,paths:0,dropped:0} drains=10 tier2=[none] semantic={collects:0,files:0,chunks:0,ms:0} callgraph_invalidations=0 executor_completed={interactive:0,maintenance:0} oldest_queued_ms={interactive:none,maintenance:none} toolcall={new:0,window:0,p50_total_ms:0,max_total_ms:0,p50_queue_ms:0,max_queue_ms:0} file_log_dropped=0

[aft-alfonso]

Thanks — that full window corrects my reading, and it's better evidence than the auto-install story.

Pid 16528 is one bridge process serving two sessions: ses_019d… bound it at 16:02, and ses_f5f5… bound the same process at 16:08:38. One bridge serves every session on a project root, and the second session's configure re-ran the whole setup instead of attaching — that's the watcher started / watcher stopped pair (the existing watcher replaced, with a rescan) and the sweeps repeated. That should be an attach, not a rebuild; it's being fixed as such.

The 26 s is the part I can't name from this log: between 16:03:49 and 16:08:38 the process wrote nothing, so whatever the second configure spent that time on is a phase with no log line, on a root that isn't itself a git repository, with the semantic index already resident. Rather than guess, the next build logs a phase breakdown whenever that prefix exceeds a second (configure prefix slow: total=… canonicalize=… cache_key=… owner_lease=… …), and I'm measuring the two candidates that plausibly scale with your machine's state in the meantime — one of them being the legacy-layout inventory, which walks the 40 partitions / 2 GB your doctor bundle lists. If you still have the old ~/.cache/aft layout on disk and can spare it, npx @cortexkit/aft@latest doctor --clear after the next release will tell us cheaply whether that was the cost; no need to act on it now.

[aft-alfonso]

Shipped in v0.56.0: LSP auto-install is coordinated across plugin instances, the Windows precheck no longer depends on unzip, and a second session binding to a running bridge takes an attach fast path instead of re-running setup. If the version timeout still appears on your setup, please open a new issue with the log window before it.

[TreedsSlop]

For completeness: I found what caused the issue. Opencode makes a complete snapshot of all files in a project folder and for every turn creates a full diff. I hadn't git ignored my build folder and thus it spent forever in the sidecar's single thread diffing the same files. It seems that also slowed aft down to the point where it would sometimes time out. For now I just set "snapshot": false in my opencode.jsonc.