Chars-per-token budget estimate (7/2) is density-blind: dense/non-ASCII rows exceed backend context and abort the whole build

[OlegAndreych]

Short description

Dense/non-ASCII rows exceed the backend's token limit despite passing the 7/2 chars-per-token budget estimate, and the resulting 400 aborts the whole multi-hour semantic build.

What happened?

Follow-up to #79. On 0.56.x with semantic.max_input_tokens=448 against llama.cpp (MiniLM, n_ctx_train=512), the budget is applied via the 7/2 chars-per-token estimate — verified working for typical rows (server-side row max 454 tokens). But the estimator under-counts dense content: a 1173-char XML row estimates 335 tokens, actually tokenizes to 518, returns exceed_context_size_error 400, and aborts the entire 375k-chunk build at that batch — 2h+ of embedding lost to one row (five such failures across two repos; rows at 514–533 tokens from XML attribute soup ~0.44, base64 literals up to 2850 tokens).

The local fastembed path never fails this way: local_embed.rs forces tokenizer truncation to 512. The remote path sends rows verbatim and llama.cpp deliberately errors instead of truncating — switching backend silently drops the protection. Budget-shrinking can't fix it: sub-clamp dense rows (~1000 chars at 0.51 tok/char) pass any budget estimate untouched.

Request: make remote-backend budget enforcement token-aware (round-trip the backend tokenizer, or per-script conservative ratios); when a row exceeds it, split into multiple in-budget chunks at the chunker level (keeping row↔chunk 1:1), truncating only undelimited blobs; and treat a per-row exceed-context 400 as skip-and-warn instead of aborting the build.

Diagnostics

## Description

Chars-per-token budget estimate (7/2) is density-blind: dense/non-ASCII rows exceed backend context and abort the whole build


## Environment
- AFT CLI: v0.56.1
- AFT binary: 0.56.1
- OS: linux x64
- Node: v22.23.2

## Diagnostics
- Timestamp: 2026-09-16T12:28:37.991Z
- AFT CLI: v0.56.1
- AFT binary: 0.56.1
- OS: linux x64
- Node: v22.23.2

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

#### Config paths

{
  "configDir": "~/.config/opencode",
  "harnessConfig": "~/.config/opencode/opencode.json",
  "harnessConfigFormat": "json",
  "aftConfig": "~/.config/cortexkit/aft.jsonc",
  "aftConfigFormat": "jsonc",
  "tuiConfig": "~/.config/opencode/tui.jsonc",
  "tuiConfigFormat": "jsonc"
}


#### AFT flags

{
  "search_index": true,
  "semantic_search": true,
  "semantic": {
    "max_files": 50000
  },
  "bash": {
    "compress": true,
    "background": true,
    "subagent_background": true
  },
  "bridge": {
    "request_timeout_ms": 600000,
    "hang_threshold": 5
  }
}


#### Plugin cache

{
  "path": "~/.cache/opencode/packages/@cortexkit/aft-opencode",
  "cached": "0.56.1",
  "latest": "0.56.1",
  "exists": true
}


#### Storage

{
  "path": "~/.local/share/cortexkit/aft",
  "exists": true,
  "accessible": true,
  "sizesByKey": {
    "index": 184861733,
    "semantic": 182198622,
    "backups": 0,
    "url_cache": 0,
    "onnxruntime": 66492548,
    "logs": 28029861
  }
}


#### ONNX Runtime

{
  "required": true,
  "systemPath": null,
  "systemVersion": null,
  "systemCompatible": null,
  "ignoredSystemPath": null,
  "ignoredSystemReason": null,
  "cachedPath": "~/.local/share/cortexkit/aft/onnxruntime/1.24.4",
  "cachedVersion": "1.24.4",
  "cachedCompatible": true,
  "platform": "linux-x64",
  "installHint": "AFT auto-downloads ONNX Runtime on supported Linux (glibc)",
  "requirement": ">=1.20"
}


#### Log file
`~/.local/share/cortexkit/aft/logs/aft-plugin.log` (16784 KB)

### Binary cache

{
  "versions": [
    "v0.56.0",
    "v0.56.1"
  ],
  "activeVersion": "v0.56.1",
  "totalSize": 184655088,
  "path": "~/.cache/aft/bin"
}


### LSP cache

{
  "npm": {
    "path": "~/.cache/aft/lsp-packages",
    "entries": [
      {
        "name": "@biomejs/biome",
        "path": "~/.cache/aft/lsp-packages/%40biomejs%2Fbiome",
        "size": 64421731
      },
      {
        "name": "yaml-language-server",
        "path": "~/.cache/aft/lsp-packages/yaml-language-server",
        "size": 19214827
      },
      {
        "name": "bash-language-server",
        "path": "~/.cache/aft/lsp-packages/bash-language-server",
        "size": 14524338
      },
      {
        "name": "typescript-language-server",
        "path": "~/.cache/aft/lsp-packages/typescript-language-server",
        "size": 3342821
      }
    ],
    "totalSize": 101503717
  },
  "github": {
    "path": "~/.cache/aft/lsp-binaries",
    "entries": [],
    "totalSize": 0
  },
  "totalSize": 101503717
}


## Recent errors (last 20, sanitized)

[2026-09-16T09:56:06.468Z] WARN [aft-plugin] Version check failed: Bridge binary replaced during version check: ~/.cache/aft/bin/v0.56.1/aft
[2026-09-16T09:56:12.281Z] INFO [aft-plugin] RPC error: status => BridgeTransportTimeoutError: [aft-plugin] Request "status" (id=9) timed out after 5000ms
[2026-09-16T09:56:12.281Z] INFO [aft-plugin] RPC error: status => BridgeTransportTimeoutError: [aft-plugin] Request "status" (id=10) timed out after 5000ms
[2026-09-16T09:56:12.281Z] INFO [aft-plugin] RPC error: status => BridgeTransportTimeoutError: [aft-plugin] Request "status" (id=11) timed out after 5000ms
[2026-09-16T09:56:12.281Z] INFO [aft-plugin] RPC error: status => BridgeTransportTimeoutError: [aft-plugin] Request "status" (id=12) timed out after 5000ms
[2026-09-16T09:56:12.282Z] INFO [aft-plugin] RPC error: status => BridgeTransportTimeoutError: [aft-plugin] Request "status" (id=13) timed out after 5000ms


### Recent AFT tool failures
- status: timed out after 5000ms ×10
- bash_drain_completions: timed out after 15000ms ×3

## Logs (last 200 lines per harness)
#### OpenCode log (~/.local/share/cortexkit/aft/logs/aft-plugin.log)


[2026-09-16T09:59:37.036Z] INFO [aft-plugin] [aft] 2026-09-16T09:59:37Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=14 total_batches=5869 chunks_done=896 completed=896 total=375577 elapsed_ms=54720
[2026-09-16T09:59:38.664Z] INFO [aft-plugin] [aft] 2026-09-16T09:59:38Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=15 total_batches=5869 chunks_done=960 completed=960 total=375577 elapsed_ms=56349
[2026-09-16T09:59:40.534Z] INFO [aft-plugin] [aft] 2026-09-16T09:59:40Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=16 total_batches=5869 chunks_done=1024 completed=1024 total=375577 elapsed_ms=58219
[2026-09-16T09:59:43.094Z] INFO [aft-plugin] [aft] 2026-09-16T09:59:43Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=17 total_batches=5869 chunks_done=1088 completed=1088 total=375577 elapsed_ms=60779
[2026-09-16T09:59:45.903Z] INFO [aft-plugin] [aft] 2026-09-16T09:59:45Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=18 total_batches=5869 chunks_done=1152 completed=1152 total=375577 elapsed_ms=63588
[2026-09-16T09:59:48.279Z] INFO [aft-plugin] [aft] 2026-09-16T09:59:48Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=19 total_batches=5869 chunks_done=1216 completed=1216 total=375577 elapsed_ms=65963
[2026-09-16T09:59:51.115Z] INFO [aft-plugin] [aft] 2026-09-16T09:59:51Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=20 total_batches=5869 chunks_done=1280 completed=1280 total=375577 elapsed_ms=68800
[2026-09-16T09:59:54.266Z] INFO [aft-plugin] [aft] 2026-09-16T09:59:54Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=21 total_batches=5869 chunks_done=1344 completed=1344 total=375577 elapsed_ms=71951
[2026-09-16T09:59:57.682Z] INFO [aft-plugin] [aft] 2026-09-16T09:59:57Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=22 total_batches=5869 chunks_done=1408 completed=1408 total=375577 elapsed_ms=75367
[2026-09-16T10:00:00.828Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:00Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=23 total_batches=5869 chunks_done=1472 completed=1472 total=375577 elapsed_ms=78513
[2026-09-16T10:00:05.131Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:05Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=24 total_batches=5869 chunks_done=1536 completed=1536 total=375577 elapsed_ms=82815
[2026-09-16T10:00:08.750Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:08Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=25 total_batches=5869 chunks_done=1600 completed=1600 total=375577 elapsed_ms=86424
[2026-09-16T10:00:08.750Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:08Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] semantic embed progress: batch 25/5869 (1600 / 375577 chunks)
[2026-09-16T10:00:10.605Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:10Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] perf tick: watcher={ingested:0,paths:0,dropped:0} drains=24 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-16T10:00:11.971Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:11Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=26 total_batches=5869 chunks_done=1664 completed=1664 total=375577 elapsed_ms=89655
[2026-09-16T10:00:16.935Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:16Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=27 total_batches=5869 chunks_done=1728 completed=1728 total=375577 elapsed_ms=94619
[2026-09-16T10:00:19.819Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:19Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=28 total_batches=5869 chunks_done=1792 completed=1792 total=375577 elapsed_ms=97504
[2026-09-16T10:00:22.784Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:22Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=29 total_batches=5869 chunks_done=1856 completed=1856 total=375577 elapsed_ms=100468
[2026-09-16T10:00:26.196Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:26Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=30 total_batches=5869 chunks_done=1920 completed=1920 total=375577 elapsed_ms=103881
[2026-09-16T10:00:30.194Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:30Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=31 total_batches=5869 chunks_done=1984 completed=1984 total=375577 elapsed_ms=107879
[2026-09-16T10:00:33.747Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:33Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=32 total_batches=5869 chunks_done=2048 completed=2048 total=375577 elapsed_ms=111429
[2026-09-16T10:00:37.102Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:37Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=33 total_batches=5869 chunks_done=2112 completed=2112 total=375577 elapsed_ms=114787
[2026-09-16T10:00:40.686Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:40Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=34 total_batches=5869 chunks_done=2176 completed=2176 total=375577 elapsed_ms=118371
[2026-09-16T10:00:43.785Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:43Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=35 total_batches=5869 chunks_done=2240 completed=2240 total=375577 elapsed_ms=121469
[2026-09-16T10:00:46.609Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:46Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=36 total_batches=5869 chunks_done=2304 completed=2304 total=375577 elapsed_ms=124293
[2026-09-16T10:00:49.568Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:49Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=37 total_batches=5869 chunks_done=2368 completed=2368 total=375577 elapsed_ms=127252
[2026-09-16T10:00:53.012Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:53Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=38 total_batches=5869 chunks_done=2432 completed=2432 total=375577 elapsed_ms=130696
[2026-09-16T10:00:56.525Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:56Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=39 total_batches=5869 chunks_done=2496 completed=2496 total=375577 elapsed_ms=134210
[2026-09-16T10:00:59.610Z] INFO [aft-plugin] [aft] 2026-09-16T10:00:59Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=40 total_batches=5869 chunks_done=2560 completed=2560 total=375577 elapsed_ms=137294
[2026-09-16T10:01:02.992Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:02Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=41 total_batches=5869 chunks_done=2624 completed=2624 total=375577 elapsed_ms=140676
[2026-09-16T10:01:06.310Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:06Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=42 total_batches=5869 chunks_done=2688 completed=2688 total=375577 elapsed_ms=143994
[2026-09-16T10:01:09.899Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:09Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=43 total_batches=5869 chunks_done=2752 completed=2752 total=375577 elapsed_ms=147583
[2026-09-16T10:01:10.815Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:10Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] perf tick: watcher={ingested:0,paths:0,dropped:0} drains=17 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-16T10:01:13.355Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:13Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=44 total_batches=5869 chunks_done=2816 completed=2816 total=375577 elapsed_ms=151039
[2026-09-16T10:01:17.095Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:17Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=45 total_batches=5869 chunks_done=2880 completed=2880 total=375577 elapsed_ms=154779
[2026-09-16T10:01:20.216Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:20Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=46 total_batches=5869 chunks_done=2944 completed=2944 total=375577 elapsed_ms=157900
[2026-09-16T10:01:23.280Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:23Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=47 total_batches=5869 chunks_done=3008 completed=3008 total=375577 elapsed_ms=160965
[2026-09-16T10:01:26.082Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:26Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=48 total_batches=5869 chunks_done=3072 completed=3072 total=375577 elapsed_ms=163767
[2026-09-16T10:01:29.100Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:29Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=49 total_batches=5869 chunks_done=3136 completed=3136 total=375577 elapsed_ms=166784
[2026-09-16T10:01:32.108Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:32Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=50 total_batches=5869 chunks_done=3200 completed=3200 total=375577 elapsed_ms=169792
[2026-09-16T10:01:32.108Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:32Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] semantic embed progress: batch 50/5869 (3200 / 375577 chunks)
[2026-09-16T10:01:35.226Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:35Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=51 total_batches=5869 chunks_done=3264 completed=3264 total=375577 elapsed_ms=172910
[2026-09-16T10:01:37.963Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:37Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=52 total_batches=5869 chunks_done=3328 completed=3328 total=375577 elapsed_ms=175648
[2026-09-16T10:01:40.584Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:40Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=53 total_batches=5869 chunks_done=3392 completed=3392 total=375577 elapsed_ms=178269
[2026-09-16T10:01:43.917Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:43Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=54 total_batches=5869 chunks_done=3456 completed=3456 total=375577 elapsed_ms=181601
[2026-09-16T10:01:47.091Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:47Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=55 total_batches=5869 chunks_done=3520 completed=3520 total=375577 elapsed_ms=184776
[2026-09-16T10:01:49.980Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:49Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=56 total_batches=5869 chunks_done=3584 completed=3584 total=375577 elapsed_ms=187665
[2026-09-16T10:01:52.709Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:52Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=57 total_batches=5869 chunks_done=3648 completed=3648 total=375577 elapsed_ms=190394
[2026-09-16T10:01:55.502Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:55Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=58 total_batches=5869 chunks_done=3712 completed=3712 total=375577 elapsed_ms=193186
[2026-09-16T10:01:57.714Z] INFO [aft-plugin] [aft] 2026-09-16T10:01:57Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=59 total_batches=5869 chunks_done=3776 completed=3776 total=375577 elapsed_ms=195399
[2026-09-16T10:02:00.285Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:00Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=60 total_batches=5869 chunks_done=3840 completed=3840 total=375577 elapsed_ms=197969
[2026-09-16T10:02:02.948Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:02Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=61 total_batches=5869 chunks_done=3904 completed=3904 total=375577 elapsed_ms=200633
[2026-09-16T10:02:06.085Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:06Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=62 total_batches=5869 chunks_done=3968 completed=3968 total=375577 elapsed_ms=203770
[2026-09-16T10:02:08.950Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:08Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=63 total_batches=5869 chunks_done=4032 completed=4032 total=375577 elapsed_ms=206635
[2026-09-16T10:02:11.022Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:11Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] perf tick: watcher={ingested:0,paths:0,dropped:0} drains=21 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-16T10:02:12.177Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:12Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=64 total_batches=5869 chunks_done=4096 completed=4096 total=375577 elapsed_ms=209861
[2026-09-16T10:02:15.544Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:15Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=65 total_batches=5869 chunks_done=4160 completed=4160 total=375577 elapsed_ms=213229
[2026-09-16T10:02:18.028Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:18Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=66 total_batches=5869 chunks_done=4224 completed=4224 total=375577 elapsed_ms=215713
[2026-09-16T10:02:20.465Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:20Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=67 total_batches=5869 chunks_done=4288 completed=4288 total=375577 elapsed_ms=218150
[2026-09-16T10:02:23.522Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:23Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=68 total_batches=5869 chunks_done=4352 completed=4352 total=375577 elapsed_ms=221206
[2026-09-16T10:02:26.317Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:26Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=69 total_batches=5869 chunks_done=4416 completed=4416 total=375577 elapsed_ms=224001
[2026-09-16T10:02:29.004Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:29Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=70 total_batches=5869 chunks_done=4480 completed=4480 total=375577 elapsed_ms=226689
[2026-09-16T10:02:31.103Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:31Z [aft] removing filesystem lock at ~/.local/share/cortexkit/aft/inspect/c52ddf65534b7b46/writer.lease from dead or recycled PID 765
[2026-09-16T10:02:32.491Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:32Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=71 total_batches=5869 chunks_done=4544 completed=4544 total=375577 elapsed_ms=230176
[2026-09-16T10:02:35.604Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:35Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=72 total_batches=5869 chunks_done=4608 completed=4608 total=375577 elapsed_ms=233288
[2026-09-16T10:02:38.494Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:38Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=73 total_batches=5869 chunks_done=4672 completed=4672 total=375577 elapsed_ms=236179
[2026-09-16T10:02:41.676Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:41Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=74 total_batches=5869 chunks_done=4736 completed=4736 total=375577 elapsed_ms=239360
[2026-09-16T10:02:43.862Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:43Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=75 total_batches=5869 chunks_done=4800 completed=4800 total=375577 elapsed_ms=241546
[2026-09-16T10:02:43.862Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:43Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] semantic embed progress: batch 75/5869 (4800 / 375577 chunks)
[2026-09-16T10:02:46.724Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:46Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=76 total_batches=5869 chunks_done=4864 completed=4864 total=375577 elapsed_ms=244408
[2026-09-16T10:02:50.159Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:50Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=77 total_batches=5869 chunks_done=4928 completed=4928 total=375577 elapsed_ms=247844
[2026-09-16T10:02:53.384Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:53Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=78 total_batches=5869 chunks_done=4992 completed=4992 total=375577 elapsed_ms=251069
[2026-09-16T10:02:55.022Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:55Z [aft] perf tier2_callgraph_snapshot: source=callgraph_store files=37258 exports=331105 edges=2539482 entry_points=44 ms=23805
[2026-09-16T10:02:57.170Z] INFO [aft-plugin] [aft] 2026-09-16T10:02:57Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=79 total_batches=5869 chunks_done=5056 completed=5056 total=375577 elapsed_ms=254854
[2026-09-16T10:03:01.517Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:01Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=80 total_batches=5869 chunks_done=5120 completed=5120 total=375577 elapsed_ms=259202
[2026-09-16T10:03:05.604Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:05Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=81 total_batches=5869 chunks_done=5184 completed=5184 total=375577 elapsed_ms=263289
[2026-09-16T10:03:08.825Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:08Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=82 total_batches=5869 chunks_done=5248 completed=5248 total=375577 elapsed_ms=266509
[2026-09-16T10:03:11.201Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:11Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] perf tick: watcher={ingested:0,paths:0,dropped:0} drains=20 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-16T10:03:12.371Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:12Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=83 total_batches=5869 chunks_done=5312 completed=5312 total=375577 elapsed_ms=270056
[2026-09-16T10:03:14.892Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:14Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=84 total_batches=5869 chunks_done=5376 completed=5376 total=375577 elapsed_ms=272576
[2026-09-16T10:03:16.622Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:16Z [aft] allocator slack relief: released=122880 allocator_slack_bytes_before=Some(1378449696) allocator_slack_bytes_after=Some(1377706864) rss_bytes_before=Some(3456999424) rss_bytes_after=Some(2560733184)
[2026-09-16T10:03:17.172Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:17Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=85 total_batches=5869 chunks_done=5440 completed=5440 total=375577 elapsed_ms=274856
[2026-09-16T10:03:19.608Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:19Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=86 total_batches=5869 chunks_done=5504 completed=5504 total=375577 elapsed_ms=277293
[2026-09-16T10:03:21.900Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:21Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=87 total_batches=5869 chunks_done=5568 completed=5568 total=375577 elapsed_ms=279585
[2026-09-16T10:03:24.790Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:24Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=88 total_batches=5869 chunks_done=5632 completed=5632 total=375577 elapsed_ms=282474
[2026-09-16T10:03:27.538Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:27Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=89 total_batches=5869 chunks_done=5696 completed=5696 total=375577 elapsed_ms=285223
[2026-09-16T10:03:30.318Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:30Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=90 total_batches=5869 chunks_done=5760 completed=5760 total=375577 elapsed_ms=288003
[2026-09-16T10:03:33.727Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:33Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=91 total_batches=5869 chunks_done=5824 completed=5824 total=375577 elapsed_ms=291411
[2026-09-16T10:03:36.360Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:36Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=92 total_batches=5869 chunks_done=5888 completed=5888 total=375577 elapsed_ms=294044
[2026-09-16T10:03:38.466Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:38Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=93 total_batches=5869 chunks_done=5952 completed=5952 total=375577 elapsed_ms=296150
[2026-09-16T10:03:41.357Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:41Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=94 total_batches=5869 chunks_done=6016 completed=6016 total=375577 elapsed_ms=299042
[2026-09-16T10:03:43.798Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:43Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=95 total_batches=5869 chunks_done=6080 completed=6080 total=375577 elapsed_ms=301482
[2026-09-16T10:03:46.500Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:46Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=96 total_batches=5869 chunks_done=6144 completed=6144 total=375577 elapsed_ms=304185
[2026-09-16T10:03:48.580Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:48Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=97 total_batches=5869 chunks_done=6208 completed=6208 total=375577 elapsed_ms=306265
[2026-09-16T10:03:51.295Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:51Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=98 total_batches=5869 chunks_done=6272 completed=6272 total=375577 elapsed_ms=308980
[2026-09-16T10:03:54.583Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:54Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=99 total_batches=5869 chunks_done=6336 completed=6336 total=375577 elapsed_ms=312268
[2026-09-16T10:03:57.620Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:57Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=100 total_batches=5869 chunks_done=6400 completed=6400 total=375577 elapsed_ms=315305
[2026-09-16T10:03:57.620Z] INFO [aft-plugin] [aft] 2026-09-16T10:03:57Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] semantic embed progress: batch 100/5869 (6400 / 375577 chunks)
[2026-09-16T10:04:00.381Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:00Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=101 total_batches=5869 chunks_done=6464 completed=6464 total=375577 elapsed_ms=318065
[2026-09-16T10:04:03.331Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:03Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=102 total_batches=5869 chunks_done=6528 completed=6528 total=375577 elapsed_ms=321015
[2026-09-16T10:04:06.380Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:06Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=103 total_batches=5869 chunks_done=6592 completed=6592 total=375577 elapsed_ms=324064
[2026-09-16T10:04:09.349Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:09Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=104 total_batches=5869 chunks_done=6656 completed=6656 total=375577 elapsed_ms=327033
[2026-09-16T10:04:11.232Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:11Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] perf tick: watcher={ingested:0,paths:0,dropped:0} drains=22 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-16T10:04:12.068Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:12Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=105 total_batches=5869 chunks_done=6720 completed=6720 total=375577 elapsed_ms=329753
[2026-09-16T10:04:15.065Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:15Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=106 total_batches=5869 chunks_done=6784 completed=6784 total=375577 elapsed_ms=332749
[2026-09-16T10:04:18.047Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:18Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=107 total_batches=5869 chunks_done=6848 completed=6848 total=375577 elapsed_ms=335731
[2026-09-16T10:04:21.049Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:21Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=108 total_batches=5869 chunks_done=6912 completed=6912 total=375577 elapsed_ms=338734
[2026-09-16T10:04:23.403Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:23Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=109 total_batches=5869 chunks_done=6976 completed=6976 total=375577 elapsed_ms=341087
[2026-09-16T10:04:26.492Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:26Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=110 total_batches=5869 chunks_done=7040 completed=7040 total=375577 elapsed_ms=344177
[2026-09-16T10:04:29.029Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:29Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=111 total_batches=5869 chunks_done=7104 completed=7104 total=375577 elapsed_ms=346714
[2026-09-16T10:04:31.668Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:31Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=112 total_batches=5869 chunks_done=7168 completed=7168 total=375577 elapsed_ms=349352
[2026-09-16T10:04:33.710Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:33Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=113 total_batches=5869 chunks_done=7232 completed=7232 total=375577 elapsed_ms=351395
[2026-09-16T10:04:35.537Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:35Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=114 total_batches=5869 chunks_done=7296 completed=7296 total=375577 elapsed_ms=353222
[2026-09-16T10:04:37.697Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:37Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=115 total_batches=5869 chunks_done=7360 completed=7360 total=375577 elapsed_ms=355382
[2026-09-16T10:04:40.011Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:40Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=116 total_batches=5869 chunks_done=7424 completed=7424 total=375577 elapsed_ms=357696
[2026-09-16T10:04:42.760Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:42Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=117 total_batches=5869 chunks_done=7488 completed=7488 total=375577 elapsed_ms=360444
[2026-09-16T10:04:45.289Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:45Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=118 total_batches=5869 chunks_done=7552 completed=7552 total=375577 elapsed_ms=362973
[2026-09-16T10:04:47.343Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:47Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=119 total_batches=5869 chunks_done=7616 completed=7616 total=375577 elapsed_ms=365027
[2026-09-16T10:04:49.370Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:49Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=120 total_batches=5869 chunks_done=7680 completed=7680 total=375577 elapsed_ms=367054
[2026-09-16T10:04:52.092Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:52Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=121 total_batches=5869 chunks_done=7744 completed=7744 total=375577 elapsed_ms=369777
[2026-09-16T10:04:55.083Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:55Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=122 total_batches=5869 chunks_done=7808 completed=7808 total=375577 elapsed_ms=372767
[2026-09-16T10:04:57.827Z] INFO [aft-plugin] [aft] 2026-09-16T10:04:57Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=123 total_batches=5869 chunks_done=7872 completed=7872 total=375577 elapsed_ms=375511
[2026-09-16T10:05:00.547Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:00Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=124 total_batches=5869 chunks_done=7936 completed=7936 total=375577 elapsed_ms=378232
[2026-09-16T10:05:02.540Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:02Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=125 total_batches=5869 chunks_done=8000 completed=8000 total=375577 elapsed_ms=380224
[2026-09-16T10:05:02.540Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:02Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] semantic embed progress: batch 125/5869 (8000 / 375577 chunks)
[2026-09-16T10:05:04.594Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:04Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=126 total_batches=5869 chunks_done=8064 completed=8064 total=375577 elapsed_ms=382278
[2026-09-16T10:05:06.383Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:06Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=127 total_batches=5869 chunks_done=8128 completed=8128 total=375577 elapsed_ms=384067
[2026-09-16T10:05:08.548Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:08Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=128 total_batches=5869 chunks_done=8192 completed=8192 total=375577 elapsed_ms=386233
[2026-09-16T10:05:11.025Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:11Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=129 total_batches=5869 chunks_done=8256 completed=8256 total=375577 elapsed_ms=388710
[2026-09-16T10:05:11.336Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:11Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] perf tick: watcher={ingested:0,paths:0,dropped:0} drains=24 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-16T10:05:13.402Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:13Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=130 total_batches=5869 chunks_done=8320 completed=8320 total=375577 elapsed_ms=391086
[2026-09-16T10:05:16.694Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:16Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=131 total_batches=5869 chunks_done=8384 completed=8384 total=375577 elapsed_ms=394378
[2026-09-16T10:05:19.676Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:19Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=132 total_batches=5869 chunks_done=8448 completed=8448 total=375577 elapsed_ms=397361
[2026-09-16T10:05:22.038Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:22Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=133 total_batches=5869 chunks_done=8512 completed=8512 total=375577 elapsed_ms=399723
[2026-09-16T10:05:24.300Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:24Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=134 total_batches=5869 chunks_done=8576 completed=8576 total=375577 elapsed_ms=401984
[2026-09-16T10:05:26.643Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:26Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=135 total_batches=5869 chunks_done=8640 completed=8640 total=375577 elapsed_ms=404327
[2026-09-16T10:05:28.870Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:28Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=136 total_batches=5869 chunks_done=8704 completed=8704 total=375577 elapsed_ms=406554
[2026-09-16T10:05:31.158Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:31Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=137 total_batches=5869 chunks_done=8768 completed=8768 total=375577 elapsed_ms=408843
[2026-09-16T10:05:33.682Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:33Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=138 total_batches=5869 chunks_done=8832 completed=8832 total=375577 elapsed_ms=411366
[2026-09-16T10:05:36.045Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:36Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=139 total_batches=5869 chunks_done=8896 completed=8896 total=375577 elapsed_ms=413730
[2026-09-16T10:05:38.381Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:38Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=140 total_batches=5869 chunks_done=8960 completed=8960 total=375577 elapsed_ms=416065
[2026-09-16T10:05:40.997Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:40Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=141 total_batches=5869 chunks_done=9024 completed=9024 total=375577 elapsed_ms=418682
[2026-09-16T10:05:43.337Z] INFO [aft-plugin] [aft] 2026-09-16T10:05:43Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] index_event kind=build_progress plane=semantic build_id=b-1362-1 root=<PROJECT> key=<REDACTED_SECRET> stage=embed batch=142 total_batches=5869 chunks_done=9088 completed=9088 total=375577 elapsed_ms=421022
[2026-09-16T12:10:27.098Z] INFO [aft-plugin] Config loaded from ~/.config/cortexkit/aft.jsonc
[2026-09-16T12:10:27.099Z] INFO [aft-plugin] Config loaded from ~/.config/cortexkit/aft.jsonc
[2026-09-16T12:10:27.105Z] INFO [aft-plugin] Resolved binary from versioned cache: ~/.cache/aft/bin/v0.56.1/aft
[2026-09-16T12:10:27.106Z] INFO [aft-plugin] AFT storage migration skipped for opencode: no legacy data at ~/.local/share/opencode/storage/plugin/aft; using ~/.local/share/cortexkit/aft for fresh install
[2026-09-16T12:10:27.107Z] INFO [aft-plugin] Config loaded from ~/.config/cortexkit/aft.jsonc
[2026-09-16T12:10:27.142Z] INFO [aft-plugin] ONNX Runtime found at ~/.local/share/cortexkit/aft/onnxruntime/1.24.4 (TOFU verified)
[2026-09-16T12:10:27.152Z] INFO [aft-plugin] [lsp] auto-install: 4 npm + 0 github install(s) running in background
[2026-09-16T12:10:27.157Z] INFO [aft-plugin] RPC server listening on 127.0.0.1:46467
[2026-09-16T12:10:27.182Z] INFO [aft-plugin] hashline activation decision requested=false edit_slot_survives=false effective=false
[2026-09-16T12:10:27.182Z] INFO [aft-plugin] Workflow hints injected (4786 chars)
[2026-09-16T12:10:27.182Z] INFO [aft-plugin] ONNX Runtime ready at ~/.local/share/cortexkit/aft/onnxruntime/1.24.4; new bridges will load semantic backend.
[2026-09-16T12:10:27.215Z] INFO [aft-plugin] [lsp] lsp_paths_extra updated after auto-install: 4 dirs pushed to live bridges
[2026-09-16T12:10:33.065Z] INFO [aft-plugin] [auto-update-checker] Already on latest version for channel: latest
[2026-09-16T12:10:42.623Z] WARN [aft-plugin] [ses_f5b75cebcffex80mpoO2SiEv21] [aft-plugin] bg-notifications: drain failed {"event":"bash_completion_drain_error","cause":"active bridge unavailable for <PROJECT>","canonical_root":"<PROJECT>","suppressed":0}
[2026-09-16T12:10:45.041Z] INFO [aft-plugin] Config loaded from ~/.config/cortexkit/aft.jsonc
[2026-09-16T12:10:45.043Z] WARN [aft-plugin] [bash_wait_detach] no live bridge for session ses_f5b75cebcffex80mpoO2SiEv21 (root <PROJECT>)
[2026-09-16T12:11:09.431Z] INFO [aft-plugin] [ses_f5b75cebcffex80mpoO2SiEv21] [subagent-detect] cache miss, calling client.session.get(id=ses_f5b75cebcffex80mpoO2SiEv21)
[2026-09-16T12:11:09.434Z] INFO [aft-plugin] [ses_f5b75cebcffex80mpoO2SiEv21] [subagent-detect] SDK returned session=present, parentID=undefined → isSubagent=false
[2026-09-16T12:11:09.888Z] INFO [aft-plugin] [ses_f5b75cebcffex80mpoO2SiEv21] perf tool=bash total=458ms pre=4ms bridge=453ms post=1ms
[2026-09-16T12:11:09.436Z] INFO [aft-plugin] [ses_f5b75cebcffex80mpoO2SiEv21] Spawning binary: ~/.cache/aft/bin/v0.56.1/aft (cwd: <PROJECT>)
[2026-09-16T12:11:09.437Z] INFO [aft-plugin] bridge.spawnProcess: useFastembedBackend=true, parentORT=(unset), ortLibraryPath=~/.local/share/cortexkit/aft/onnxruntime/1.24.4/libonnxruntime.so
[2026-09-16T12:11:09.437Z] INFO [aft-plugin] ORT_DYLIB_PATH set from managed ONNX Runtime: ~/.local/share/cortexkit/aft/onnxruntime/1.24.4/libonnxruntime.so
[2026-09-16T12:11:09.538Z] INFO [aft-plugin] [ses_f5b75cebcffex80mpoO2SiEv21] hashline registration carrier transport=ndjson phase=configure edit_slot_survives=false
[2026-09-16T12:11:09.538Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:09Z [aft] log retention sweep: removed_files=0 bytes_freed=0 recycled_pids=0
[2026-09-16T12:11:09.538Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:09Z [aft] login-shell PATH probe: source=cache shell=/bin/zsh elapsed_ms=6
[2026-09-16T12:11:09.538Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:09Z [aft] started, pid 606
[2026-09-16T12:11:09.568Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:09Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] project root set: <PROJECT>
[2026-09-16T12:11:09.739Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:09Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] gitignore matcher built: 192 pattern(s)
[2026-09-16T12:11:09.739Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:09Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] configure maintenance yielded to 1 queued request(s)
[2026-09-16T12:11:09.739Z] INFO [aft-plugin] Binary version: 0.56.1
[2026-09-16T12:11:09.743Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:09Z [aft] search index orphan sweep root=~/.local/share/cortexkit/aft/index scanned=1 removed=0 skipped_derived=1 skipped_memo=0 skipped_fresh=0 skipped_live=0 skipped_locked=0 skipped_unreadable=0 budget_exhausted=false
[2026-09-16T12:11:09.743Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:09Z [aft] transient search cache sweep root=/tmp scanned=0 removed=0 bytes=0 skipped_fresh=0 skipped_unreadable=0 budget_exhausted=false
[2026-09-16T12:11:09.819Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:09Z [aft] watcher exclusions for <PROJECT> (8): [<PROJECT>/.git, <PROJECT>/admin-lite/target, <PROJECT>/authorization-spec/target, <PROJECT>/bpmn/bpmn-impl/target, <PROJECT>/bpmn/bpmn-spec/target, <PROJECT>/bpmn/target, <PROJECT>/cache-modules/target, <PROJECT>/cmdb/target]
[2026-09-16T12:11:09.982Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:09Z [aft] watcher started: <PROJECT>
[2026-09-16T12:11:10.634Z] INFO [aft-plugin] Config loaded from ~/.config/cortexkit/aft.jsonc
[2026-09-16T12:11:10.634Z] INFO [aft-plugin] [ses_f5b75cebcffex80mpoO2SiEv21] [aft-plugin] bg-notifications: drain ok {"event":"bash_completion_drain_ok","count":0,"task_ids":[],"canonical_root":"<PROJECT>","suppressed":0}
[2026-09-16T12:11:10.734Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:10Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] cannot establish filesystem boundary for checkpoint sweep ~/.local/share/cortexkit/aft/opencode/checkpoints
[2026-09-16T12:11:10.951Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:10Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] local embedder ready: model=all-MiniLM-L6-v2 intra_threads=6 token_type_ids=<REDACTED_SECRET>
[2026-09-16T12:11:10.974Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:10Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] removing filesystem lock at ~/.local/share/cortexkit/aft/semantic/27664415cabc3ecf/cache.lock from dead or recycled PID 765
[2026-09-16T12:11:12.523Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:12Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] search index: refreshed 72 stale file(s) from disk cache
[2026-09-16T12:11:15.891Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:15Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] loaded symbol cache from disk: 39666 files
[2026-09-16T12:11:15.964Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:15Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] pre-warmed symbol cache: 0 new, 37416 cached, 39666 files total
[2026-09-16T12:11:17.582Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:17Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] loaded semantic index from disk: 386641 entries (0 delta segments)
[2026-09-16T12:11:34.385Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:34Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] semantic collect: 247 chunks from 19 files in 11 ms
[2026-09-16T12:11:35.686Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:35Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] semantic embedder refresh: root="<PROJECT>" reason="bind catch-up" files=19 chunks=45 batches=1 backend=fastembed
[2026-09-16T12:11:35.686Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:35Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] semantic index: refreshed incrementally — 18 changed, 1 new, 1982 deleted, 39194 total processed (kept 375756 cached)
[2026-09-16T12:11:35.692Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:35Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] semantic delta metadata unavailable (semantic artifact fingerprint changed); using structural fallback
[2026-09-16T12:11:42.192Z] INFO [aft-plugin] [aft] 2026-09-16T12:11:42Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] semantic index delta persisted: 2007 files, 927.3 KB, artifact_read_bytes=872757279
[2026-09-16T12:12:09.638Z] INFO [aft-plugin] [aft] 2026-09-16T12:12:09Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] perf tick: watcher={ingested:0,paths:0,dropped:0} drains=13 tier2=[none] semantic={collects:1,files:19,chunks:247,ms:11} 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-16T12:14:50.979Z] INFO [aft-plugin] [aft] 2026-09-16T12:14:50Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] invalidated 1 files
[2026-09-16T12:14:50.979Z] INFO [aft-plugin] [aft] 2026-09-16T12:14:50Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] tier2 refresh scheduled: reason=pull, categories=["dead_code", "unused_exports", "duplicates", "cycles", "complexity"]
[2026-09-16T12:14:51.402Z] INFO [aft-plugin] [aft] 2026-09-16T12:14:51Z [aft] removing filesystem lock at ~/.local/share/cortexkit/aft/inspect/c52ddf65534b7b46/writer.lease from dead or recycled PID 1362
[2026-09-16T12:15:09.742Z] INFO [aft-plugin] [aft] 2026-09-16T12:15:09Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] perf tick: watcher={ingested:1,paths:1,dropped:0} drains=0 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-16T12:15:29.741Z] INFO [aft-plugin] [aft] 2026-09-16T12:15:29Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] invalidated 1 files
[2026-09-16T12:15:40.900Z] INFO [aft-plugin] [aft] 2026-09-16T12:15:40Z [aft] perf tier2_callgraph_snapshot: source=callgraph_store files=37258 exports=331105 edges=2539482 entry_points=44 ms=49444
[2026-09-16T12:16:09.756Z] INFO [aft-plugin] [aft] 2026-09-16T12:16:09Z [aft] [ses_f5b75cebcffex80mpoO2SiEv21] perf tick: watcher={ingested:1,paths:1,dropped:0} drains=1 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-16T12:19:57.638Z] INFO [aft-plugin] Process exited: code=null, signal=SIGKILL


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

Plugin version

0.56.1

AFT binary version

0.56.1

Platform

linux x64

Log output (optional)

[aft-alfonso]

Confirmed from source, and your diagnosis is complete — nothing to add to the mechanism.

embed_build_http_adaptive returns any non-timeout error straight up, so one rejected row fails its 64-row batch and the build treats a failed batch as a failed build. The #310 change gave timeouts a shrink ladder; a permanent per-row 4xx has none. You are also right that no static ratio can close this: the local path is safe only because local_embed.rs forces tokenizer truncation, and the remote path sends rows verbatim to a backend that (correctly) refuses rather than truncates.

The fix in progress treats the backend as the tokenizer oracle rather than guessing per script: a 4xx whose body names context overflow (llama.cpp's exceed_context_size_error, OpenAI's maximum context length, Ollama's input length exceeds) becomes a row-too-long class; the batch is bisected to find the offending rows; each is shrunk by the reported ratio (or halved) and retried down to a header+signature floor; a row still rejected at the floor is skipped with a warn line naming the file, and the build's completion line carries skipped_rows=N so the skip can never read as a complete index. Unknown 4xx bodies still abort — a wrong model name must not become 375k silent skips. Row↔chunk stays 1:1; the chunk-level split you suggested is a larger change and is not needed to stop the abort.

Will post here when it lands with the exact behaviour on your XML and base64 rows.

[aft-alfonso]

Landed on main (commits 2bf86bb01 and 692fbf528), for the next release. The workaround (max_batch_size / larger timeout_ms) is no longer needed once it ships.

What the build does now when the backend refuses a row:

• The HTTP 400 is classified narrowly as a context overflow — llama.cpp's "input is too large to process" and the OpenAI-compatible "maximum context length" bodies, with or without a token count. Any other 4xx stays fatal exactly as before, so a misconfigured endpoint still fails loudly (there is a negative-control test for that).
• On overflow the batch is bisected recursively until the rejected row is isolated — 64 rows with 3 too long costs 37 requests, not 64.
• The offending row is shrunk toward its header and signature (the body goes first). If the backend still refuses it, the row is skipped and a warning names the file, symbol, size, and the backend's reason.
• The build completes. The build_ready log line carries skipped_rows=N (including =0) so a skip is never silent, and the stored embed text matches what was actually embedded.

The fixed 7/2 ratio remains only a first guess for batching; the backend's own refusal is the authority on what fits.

Thanks for the exact reproduction — the XML row size and the 400 body were what made the mechanism unambiguous.

[aft-alfonso]

Released in v0.56.2. The embedding backend is the tokenization authority now: an overflow reply bisects the batch, shrinks the offending row toward its signature, and skips it with a count if it still does not fit, while other 4xx replies stay fatal. The max_batch_size / larger timeout_ms workaround is no longer needed.