2 Commits

Author	SHA1	Message	Date
JianFeeeee	01113664b4	fix(obs): 抢占日志改在判决点打（修自伤）+ scheduler 事件接进 SSE ... ## 修我上一版的自伤 上一版把 preempt 日志打在 `executeNewTask`，但那时 `nextRef` 已经把 `s.running` 换成了抢占者自己，于是输出成了 preempt start: task#2 ... -> victim task#2 (cli) victim 打印的是入侵者本人。判据必须落在 `registerInterrupt`——那一刻 running 还是真正的受害者。改为在抢占判决点打： [agent] preempt: task#2 class=interrupt level=3 from cli (L3) preempts task#1 class=queued level=0 (qq) ## 补上「入队而非抢占」的日志 中断到了却没生效，此前完全不可解释。现在两种成因分开写： [agent] interrupt queued: ... vs ... (qq) — running in critical section; queue=N [agent] interrupt queued: ... vs ... (qq) — preempt cooldown; queue=N [agent] interrupt queued: ... vs ... (qq) — level insufficient; queue=N 没有这条，`interrupt from X` 打过之后任务为什么没让位就只能猜。 ## scheduler 事件接进 SSE `EventScheduler` 此前既不在 `handler_chat.go` 的 subTypes、也没有任何订阅者 （全仓 grep 零命中）——内核里 suspend/resume 只 publishEvent，于是事件发出来 就掉地上，对内对外都不可见。加进 subTypes 后前端/客户端能看到抢占链。 ## 验证 - preempt_logging_test.go 增一条：victim 与入侵者必须是不同来源（qq vs cli）， 且排队输入对排队任务 `canPreempt` 必为假。 - 实测输出含 `cli (L3) preempts task#1 class=queued level=0 (qq)`。 - 全量 `go test ./internal/... ./cmd/...` 与 `go vet ./internal/...` 全绿。	2026-09-19 11:57:50 +08:00
JianFeeeee	b1ec278136	feat(obs): 抢占日志说出「受害者是谁」——suspend/resume 此前完全不落日志 ... 排查「我的任务怎么被莫名打断了」时撞上的观测缺口。 ## 缺口 `executeNewTask` 里挂起、`resumeTask` 里恢复，两处都**只发事件、不写日志**： a.sched.suspend(t, f) a.publishEvent(events.EventScheduler, map[string]any{"action": "suspend", ...}) 于是生产日志里只有两行：`interrupt from X` 与 `LLM request cancelled by preemption` —— **看不到受害者是谁、被谁挤下去、后来有没有恢复**。后果是实测过的： 按时间先后猜凶手，把时间上相邻的输入误认成抢占者。 ## 改动 - `sourceOf(task, frame)`：取可辨识来源（`evt.Source` 优先，回退 OutputChannel， 自循环任务给 `self:<channel>`）。取 Source 而**不是** OutputChannel： 前者回答「谁送来的」（qq / homeagent-mail-bridge / timer / child/xxx）， 后者只回答投递到哪个通道；多数场景同名，但因果链上要的是前者。 - `describeTask(task)`：`task#N class=queued|interrupt level=L`。 - `suspendDepth()`：日志专用，走锁而不是让日志点直接摸 `suspendStack`。 - 三个日志点：抢占开始（含 victim）、挂起（含来源与栈深）、恢复。 输出形状： [agent] preempt start: task#2 class=interrupt level=4 from cli -> victim task#1 class=queued level=0 (qq) [agent] suspend: task#1 class=queued level=0 (qq) yields to an interrupt; suspendStack=0 [agent] resume: task#1 class=queued level=0 (qq) resumes after the interrupt finished ## 验证 - 新增 preempt_logging_test.go：抢占后栈深 0→1、sourceOf 取到 qq、self/nil 不 panic。 - 实测日志（TestPreempt_HigherPreemptsAndResumes）三条齐全，能一眼看出 是 `cli` 的 L4 挤掉了 `qq` 的排队任务、随后 qq 恢复。 - `go test ./internal/... ./cmd/...` 全绿。	2026-09-19 11:31:04 +08:00