ktx/packages/cli/test/context/ingest
Andrey Avtomonov 21744fc520
feat(cli): profile ingest runs and split model vs tool time (#249)
* feat(cli): profile ingest runs to find where wall-clock time goes

Add opt-in profiling for `ktx ingest`. Each timed phase, work unit, and
agent loop now records durationMs / step count / token usage in the
trace, and a post-run aggregator rolls them up into a "where did the
time go" report printed to stderr.

Enable per run with KTX_PROFILE_INGEST (1/true -> human table, json ->
raw structured profile) or persistently via `ingest.profile` in
ktx.yaml. The json form emits raw milliseconds, token counts, and a
summary.headline one-line diagnosis so coding agents can parse it
directly; json wins when both env and config request profiling.

- runtime-port: RunLoopMetrics (totalMs, usage, stepCount,
  stepBoundariesMs) plus onMetrics callbacks on text/object generation
- ai-sdk + claude-code runtimes: capture per-loop timing and token usage
- work-unit-executor and stages 3/4: thread metrics into trace events
- ingest-bundle.runner: time worktree / triage / clustering / index /
  reconcile / squash phases and emit the profile in a finally block
  (best-effort; never affects the run outcome)
- ingest-profile: new trace+transcript aggregator with table/json formatters
- config: ingest.profile flag; docs: profiling section in ktx-ingest.mdx

* fix(cli): flush tool-call logs before reading ingest profile

Tool transcripts are appended fire-and-forget so the agent hot path never
blocks on logging. The ingest profiler read them before the writes settled,
so per-work-unit toolMs (and the model-vs-tool split derived from it) could
be incomplete. Track in-flight appends and expose flushToolCallLogs() —
bounded by a timeout so it can never hang — and flush before the profiler
reads the transcript.
2026-06-01 15:49:17 +02:00
..
adapters fix(ingest): attribute historic-sql evidence writes in bundle report (#220) 2026-05-26 12:21:53 +02:00
clustering test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
context-candidates test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
context-evidence test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
dbt-shared test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
historic-sql-probes test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
isolated-diff test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
memory-flow fix(cli): treat artifact-producing ingests with failures as partial (#238) 2026-05-30 00:42:59 +02:00
page-triage test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
stages test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
tools feat(cli): profile ingest runs and split model vs tool time (#249) 2026-06-01 15:49:17 +02:00
action-identity.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
artifact-gates.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
canonical-pins.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
diff-set.service.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
final-gate-repair.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
finalization-scope.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
historic-sql-probes.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
ingest-bundle.runner.isolated-diff.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
ingest-bundle.runner.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
ingest-profile.test.ts feat(cli): profile ingest runs and split model vs tool time (#249) 2026-06-01 15:49:17 +02:00
ingest-prompts.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
ingest-runtime-assets.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
ingest-trace.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
local-adapters.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
local-bundle-ingest.test.ts fix(ingest): attribute historic-sql evidence writes in bundle report (#220) 2026-05-26 12:21:53 +02:00
local-bundle-runtime.test.ts feat(cli): profile ingest runs and split model vs tool time (#249) 2026-06-01 15:49:17 +02:00
local-embedding-provider.integration.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
local-mapping-reconcile.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
local-metabase-ingest.test.ts fix(cli): treat artifact-producing ingests with failures as partial (#238) 2026-05-30 00:42:59 +02:00
local-stage-ingest.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
raw-sources-paths.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
repo-fetch.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
report-snapshot.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
reports.test.ts fix(cli): treat artifact-producing ingests with failures as partial (#238) 2026-05-30 00:42:59 +02:00
semantic-layer-target-policy.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
source-adapter-registry.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
sqlite-bundle-ingest-store.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
sqlite-local-ingest-store.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
wiki-body-refs.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00
wiki-sl-ref-repair.test.ts test: split cli tests from source tree (#216) 2026-05-26 08:49:05 +02:00