Finished `test` profile [unoptimized + debuginfo] target(s) in 1.14s ──────────── Nextest run ID 3e531160-cb1e-455a-bf0f-9d3db63306a3 with nextest profile: ci-windows Starting 239 tests across 90 binaries (138 binaries skipped) PASS [ 13.793s] ( 1/239) spt::activity_link_push_e2e activity_frames_reach_a_linked_shell_through_the_real_daemon PASS [ 18.856s] ( 2/239) spt::attach_link_push_e2e attachment_frames_reach_a_linked_shell_through_the_real_daemon PASS [ 20.737s] ( 3/239) spt::attach_wedge_e2e attach_wedge_dead_child_plus_dropped_pump_does_not_wedge_the_broker PASS [ 5.786s] ( 4/239) spt::bind_cwd_project_e2e endpoint_run_records_cwd_and_appears_under_its_project PASS [ 3.257s] ( 5/239) spt::bind_honest_cross_perch_e2e cross_perch_dead_owner_repin_is_refused_no_contamination PASS [ 23.228s] ( 6/239) spt::brain_respawn_rename brain_respawns_onto_applied_bytes_after_in_place_rename PASS [ 9.912s] ( 7/239) spt::brain_split broker_survives_brain_kill_and_respawns_it PASS [ 13.096s] ( 8/239) spt::brain_split seed_anchor_survives_brain_cycle PASS [ 10.343s] ( 9/239) spt::brain_survive pty_and_quic_survive_brain_process_restart_onto_swapped_binary PASS [ 11.116s] ( 10/239) spt::commune_two_cwd_e2e a_commune_written_from_a_worktree_is_loud_and_stale_while_the_registered_one_is_not PASS [ 0.236s] ( 11/239) spt::coordinator_image_e2e the_running_coordinator_reports_its_compiled_image_and_no_impostor_can PASS [ 9.387s] ( 12/239) spt::daemon_refresh_e2e daemon_refresh_cycles_brain_while_hosted_endpoint_survives PASS [ 6.075s] ( 13/239) spt::daemon_status_pid_e2e status_uses_live_service_identity_despite_a_stale_pid_file PASS [ 15.115s] ( 14/239) spt::dummy_harness_e2e endpoint_run_attach_awaits_online_before_attaching PASS [ 11.042s] ( 15/239) spt::dummy_harness_e2e endpoint_run_brings_up_a_long_lived_dummy_harness_and_rc_attaches PASS [ 0.541s] ( 16/239) spt::endpoint_autostart_e2e poll_ignores_the_skip_and_fail_replay_outcomes PASS [ 0.664s] ( 17/239) spt::endpoint_autostart_e2e poll_rejects_a_line_torn_before_the_startup_default_tail PASS [ 11.477s] ( 18/239) spt::endpoint_autostart_e2e saved_endpoint_replays_on_daemon_restart PASS [ 0.025s] ( 19/239) spt::endpoint_autostart_e2e torn_read_yields_no_replay_line_rather_than_a_promoted_fragment PASS [ 10.600s] ( 20/239) spt::endpoint_teardown_authority_e2e shutdown_reaps_the_hosted_subtree_it_reports_suspending PASS [ 13.489s] ( 21/239) spt::endpoint_teardown_authority_e2e stop_reaps_the_hosted_subtree_and_run_recovers_the_endpoint PASS [ 6.680s] ( 22/239) spt::engine_room_bringup_e2e a_bringup_on_a_multi_subnet_node_leaves_the_room_a_perch PASS [ 46.048s] ( 23/239) spt::engine_room_bringup_e2e a_bringup_whose_attach_never_arrived_leaves_no_grant_anywhere PASS [ 4.021s] ( 24/239) spt::engine_room_bringup_e2e a_brought_up_engine_room_is_served_the_in_core_role_and_has_no_writer PASS [ 7.921s] ( 25/239) spt::engine_room_bringup_e2e a_brought_up_engine_room_registers_no_relay_address_for_tcp_to_reach PASS [ 10.292s] ( 26/239) spt::engine_room_bringup_e2e a_cleanly_offline_engine_room_is_still_brought_up_by_its_own_gate PASS [ 0.227s] ( 27/239) spt::engine_room_bringup_e2e a_complete_ladder_with_no_expiry_is_green PASS [ 0.023s] ( 28/239) spt::engine_room_bringup_e2e a_loud_launch_failure_is_candidate_a_from_either_witness PASS [ 0.015s] ( 29/239) spt::engine_room_bringup_e2e a_pty_create_that_never_completed_is_candidate_c PASS [ 0.016s] ( 30/239) spt::engine_room_bringup_e2e a_row_that_existed_and_then_did_not_is_candidate_d_not_late PASS [ 0.014s] ( 31/239) spt::engine_room_bringup_e2e an_expiry_with_no_stamps_behind_it_is_unreadable_never_candidate_b PASS [ 5.190s] ( 32/239) spt::engine_room_bringup_e2e er_bringup_from_the_operators_invocation_spawns_the_session PASS [ 8.190s] ( 33/239) spt::engine_room_bringup_e2e er_bringup_launch_phases_reach_the_sink PASS [ 0.242s] ( 34/239) spt::engine_room_bringup_e2e every_verdict_names_the_last_phase_each_side_reached PASS [ 6.679s] ( 35/239) spt::er_brief_once_per_session_e2e a_second_seat_on_a_running_engine_room_is_not_re_briefed PASS [ 0.290s] ( 36/239) spt::er_brief_once_per_session_e2e controller_release_barrier_rejects_a_latched_seat PASS [ 11.854s] ( 37/239) spt::er_briefing_presentation_e2e er_briefing_presentation_measurements SLOW [> 60.000s] (───────) spt::er_briefing_presented_e2e the_engine_room_briefing_is_presented_before_the_first_actionable_turn FAIL [ 79.834s] ( 38/239) spt::er_briefing_presented_e2e the_engine_room_briefing_is_presented_before_the_first_actionable_turn stdout ─── running 1 test test the_engine_room_briefing_is_presented_before_the_first_actionable_turn has been running for over 60 seconds test the_engine_room_briefing_is_presented_before_the_first_actionable_turn ... FAILED failures: failures: the_engine_room_briefing_is_presented_before_the_first_actionable_turn test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 79.82s stderr ─── === ER164 ACCEPTANCE === seated: rows=[SpoolAuditRow { id: 1, from: "spt-engine-room", delivered: true, taken_leg: Some("native-inject"), taken_sid: None, taken_pid: Some(51952), taken_at_ms: Some(1789398216069) }] idle_sentinel_present=false pending_after=0 controllable=Some(true) unseated: rows=[] ceremony2_ok=true === rc stdout === the engine room is up. DUMMY_HARNESS_READY:engine-roomDUMMY_HARNESS_TICK:engine-room:0 [taking its controls.] DUMMY_HARNESS_READY:engine-room DUMMY_HARNESS_TICK:engine-room:0 DUMMY_HARNESS_READY:engine-room DUMMY_HARNESS_TICK:engine-room:0 === brain stderr === --- broker stderr, pre-redirect window (C:\Users\decid\AppData\Local\Temp\.tmpzKRPOS\brain.stderr.log) --- --- daemon stderr sink (C:\Users\decid\AppData\Local\Temp\.tmpzKRPOS\logs\daemon.stderr.log) --- === spt broker stderr — generation 0 — pid 51952 === PERCH_CENSUS_SKIPPED: perch tree unreadable — nothing classified NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) DOCS_SERVER_UP: http://localhost:52783/hfenduleam/docs/ NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) === spt brain stderr — generation 0 — pid 46432 === BRAIN_UP: connected to broker spt-daemon-broker-1b23f713e7cbbf14.sock (pid 46432, generation 0, start-reason cold) BRAIN_PHASE:announce done in 0ms BRAIN_PHASE:resume done in 0ms PAIR_MEET_UP:erhome step=59646607 id=090c158cc8d2064f17c5c9c5290c109f2ccb3f85cbd9deca1ed1fae6b92df725 addr=EndpointAddr { id: PublicKey(090c158cc8d2064f17c5c9c5290c109f2ccb3f85cbd9deca1ed1fae6b92df725), addrs: {Ip(100.68.35.65:57518), Ip(192.168.1.81:57518)} } INBOUND_REACHABILITY: warning: the spt firewall rule admits a DIFFERENT binary than the running daemon, so inbound UDP is blocked despite the rule existing. rule admits: C:\Users\decid\AppData\Local\spt-core\bin\spt.exe daemon runs: C:\Users\decid\Documents\projects\spt-core\.worktrees\asm-304-v3\target\debug\spt.exe Fix: netsh advfirewall firewall delete rule name="spt-core inbound UDP" & netsh advfirewall firewall add rule name="spt-core inbound UDP" dir=in action=allow protocol=UDP program="C:\Users\decid\Documents\projects\spt-core\.worktrees\asm-304-v3\target\debug\spt.exe" (run elevated) BRAIN_PHASE:ready written in 1805ms (exe-hash 1804ms, computed=true) path C:\Users\decid\AppData\Local\Temp\.tmpzKRPOS\brain.ready BRAIN_CONN_OPEN: caller=livehost-session-query reason=initial-query policy=reuse-until-query-error wall_ms=1789398215208 mono_ms=1807 BRAIN_CONN_OPEN: caller=livehost-session-query reason=initial-query policy=reuse-until-query-error wall_ms=1789398215209 mono_ms=1808 ENGINE_ROOM_PERCH_ANCHORED:engine-room: skeleton created, home=erhome — the harness bind inherits this anchor ER_BRINGUP_WAIT_START:engine-room adapter=erhost ready_wait_s=30 ER_LAUNCH_PHASE:engine-room phase=enter t_ms=0 adapter=erhost ER_LAUNCH_PHASE:engine-room phase=prepared t_ms=0 ER_LAUNCH_PHASE:engine-room phase=connecting t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe ER_LAUNCH_PHASE:engine-room phase=connected t_ms=0 ER_LAUNCH_PHASE:engine-room phase=requested t_ms=0 SPAWN_PHASE:engine-room phase=received t_ms=0 fresh=false SPAWN_PHASE:engine-room phase=gate_claimed t_ms=0 SPAWN_PHASE:engine-room phase=pty_creating t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe SPAWN_PHASE:engine-room phase=pty_created t_ms=226 pid=Some(58208) SPAWN_PHASE:engine-room phase=input_writer t_ms=226 CONN_LIFECYCLE: conn=5 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398215687 mono_ms=2390 first_write=none event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] SPAWN_PHASE:engine-room phase=log_ready t_ms=244 SPAWN_PHASE:engine-room phase=drain_armed t_ms=244 SPAWN_PHASE:engine-room phase=waiter_armed t_ms=244 REGISTRY_SNAPSHOT_HYDRATE:207fddcc6f467bc31c1e18efea58dd5223af232fab53ecff0738699d3334a63c:subnets=0 rows=0 dir=C:\Users\decid\AppData\Local\Temp\.tmpzKRPOS\identity\registry wall_ms=1789398215708 BRAIN_NET_CONSUMERS_UP: net enabled (node 207fddcc6f467bc31c1e18efea58dd5223af232fab53ecff0738699d3334a63c) — dispatcher + peer pump started PUMP_IPC_READER: spawned PUMP_IPC_READER: spawned CONN_LIFECYCLE: conn=8 role=brain presence-subscriber wall_ms=1789398215709 mono_ms=2411 first_write=none event=presence-sub-attach from_seq=18446744073709551615 [REQ-CONN-POISON-ATTRIBUTION] EPOCH_FAST_FORWARD:0->1: our fleet-replicated roster row holds lease 0 — jumping past it so our own advertisements are admitted again (KNOWN-HAZARDS 7.60) [REQ-ROSTER-SELF-LEASE-HEAL] SELF_ADDR_REBIND:207fddcc6f467bc31c1e18efea58dd5223af232fab53ecff0738699d3334a63c: live endpoint address differs from our advertised roster row — re-authored at lease 1, advertise requested [REQ-SELF-ADDR-REBIND-READVERTISE] ACCESS_STORE_MINTED C:\Users\decid\AppData\Local\Temp\.tmpzKRPOS\identity\trust\access.json — no access store was present at first load in this process, so an EMPTY baseline was written (everything open that the chain leaves open). If this node had access rules, they are GONE: the store was removed while the daemon was down, and this mint replaced it. Re-apply them (`spt endpoint access ...`); a restart cannot tell a wipe from a first boot. SPAWN_PHASE:engine-room phase=translation_ready t_ms=467 SPAWN_PHASE:engine-room phase=row_inserted t_ms=467 session=1 ER_LAUNCH_PHASE:engine-room phase=spawned t_ms=468 session=1 pid=Some(58208) CONN_LIFECYCLE: conn=5 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398215928 mono_ms=2631 first_write_wall_ms=1789398215705 first_write_mono_ms=2407 event=writer-exit role=controller session=1 reason=channel-closed [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=5 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398215940 mono_ms=2642 first_write_wall_ms=1789398215705 first_write_mono_ms=2407 event=session-detach session=1 was_controller=true viewers_dropped=0 [REQ-CONN-POISON-ATTRIBUTION] ENGINE_ROOM_BROUGHT_UP:engine-room session=1 adapter=erhost (gate admitted; one admit ticket minted, good for 30s) CONN_LIFECYCLE: conn=4 role=brain stream-subscriber stream=2 wall_ms=1789398215974 mono_ms=2676 first_write_wall_ms=1789398215438 first_write_mono_ms=2140 event=stream-sub-attach stream=2 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=11 role=brain stream-subscriber stream=1 wall_ms=1789398216012 mono_ms=2714 first_write_wall_ms=1789398216011 first_write_mono_ms=2714 event=stream-sub-attach stream=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] ATTACH_INTENT_CHOSEN: site=serve_dispatch session=1 intent=control from_seq=0 gen=1789398215974 coded=true CONN_LIFECYCLE: conn=11 role=brain stream-subscriber stream=1 controller session=1 endpoint=engine-room by=207fddcc6f467bc31c1e18efea58dd5223af232fab53ecff0738699d3334a63c wall_ms=1789398216012 mono_ms=2715 first_write_wall_ms=1789398216011 first_write_mono_ms=2714 event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] ATTACH_INTENT_CHOSEN: site=serve_dispatch session=1 intent=control from_seq=0 gen=1789398215974 coded=true SUBSCRIBE_DECISION: session=1 endpoint=engine-room by=207fddcc6f467bc31c1e18efea58dd5223af232fab53ecff0738699d3334a63c conn=11 intent=control old_by=- old_gen=0 req_gen=1789398215974 decision=controller SUBSCRIBE_DECISION: session=1 endpoint=engine-room by=207fddcc6f467bc31c1e18efea58dd5223af232fab53ecff0738699d3334a63c conn=11 intent=control old_by=207fddcc6f467bc31c1e18efea58dd5223af232fab53ecff0738699d3334a63c old_gen=1789398215974 req_gen=1789398215974 decision=idempotent ENDPOINT_INJECT:engine-room (1073 bytes → translation binary, native mid-active) NATIVE_PARKED_DRAIN:engine-room: injected 1 parked message(s) via translation binary === ER164 MISS + RE-OFFER === unpresented_after=Some(12.9071048s) rc4_alive=true ceremony4_ok=true repoint=Ok(()) miss: rows=[SpoolAuditRow { id: 1, from: "spt-engine-room", delivered: false, taken_leg: None, taken_sid: None, taken_pid: None, taken_at_ms: None }] pending=1 controllable=None idle=false redrive: new_session_row=None rows=[SpoolAuditRow { id: 2, from: "spt-engine-room", delivered: false, taken_leg: None, taken_sid: None, taken_pid: None, taken_at_ms: None }] pending=1 controllable=Some(true) idle=false === brain stderr === --- miss broker (arm 4) --- --- broker stderr, pre-redirect window (C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\brain.stderr.log) --- --- daemon stderr sink (C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\logs\daemon.stderr.log) --- === spt broker stderr — generation 0 — pid 57632 === PERCH_CENSUS_SKIPPED: perch tree unreadable — nothing classified NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) DOCS_SERVER_UP: http://localhost:52864/hfenduleam/docs/ NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) === spt brain stderr — generation 0 — pid 44100 === BRAIN_UP: connected to broker spt-daemon-broker-7c191c74702e822b.sock (pid 44100, generation 0, start-reason cold) BRAIN_PHASE:announce done in 0ms BRAIN_PHASE:resume done in 0ms PAIR_MEET_UP:erhome step=59646607 id=090c158cc8d2064f17c5c9c5290c109f2ccb3f85cbd9deca1ed1fae6b92df725 addr=EndpointAddr { id: PublicKey(090c158cc8d2064f17c5c9c5290c109f2ccb3f85cbd9deca1ed1fae6b92df725), addrs: {Ip(100.68.35.65:50870), Ip(192.168.1.81:50870)} } INBOUND_REACHABILITY: warning: the spt firewall rule admits a DIFFERENT binary than the running daemon, so inbound UDP is blocked despite the rule existing. rule admits: C:\Users\decid\AppData\Local\spt-core\bin\spt.exe daemon runs: C:\Users\decid\Documents\projects\spt-core\.worktrees\asm-304-v3\target\debug\spt.exe Fix: netsh advfirewall firewall delete rule name="spt-core inbound UDP" & netsh advfirewall firewall add rule name="spt-core inbound UDP" dir=in action=allow protocol=UDP program="C:\Users\decid\Documents\projects\spt-core\.worktrees\asm-304-v3\target\debug\spt.exe" (run elevated) BRAIN_PHASE:ready written in 1724ms (exe-hash 1723ms, computed=true) path C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\brain.ready BRAIN_CONN_OPEN: caller=livehost-session-query reason=initial-query policy=reuse-until-query-error wall_ms=1789398230725 mono_ms=1726 BRAIN_CONN_OPEN: caller=livehost-session-query reason=initial-query policy=reuse-until-query-error wall_ms=1789398230726 mono_ms=1727 REGISTRY_SNAPSHOT_HYDRATE:0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b:subnets=0 rows=0 dir=C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\identity\registry wall_ms=1789398231225 BRAIN_NET_CONSUMERS_UP: net enabled (node 0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b) — dispatcher + peer pump started PUMP_IPC_READER: spawned PUMP_IPC_READER: spawned CONN_LIFECYCLE: conn=7 role=brain presence-subscriber wall_ms=1789398231225 mono_ms=2316 first_write=none event=presence-sub-attach from_seq=18446744073709551615 [REQ-CONN-POISON-ATTRIBUTION] EPOCH_FAST_FORWARD:0->1: our fleet-replicated roster row holds lease 0 — jumping past it so our own advertisements are admitted again (KNOWN-HAZARDS 7.60) [REQ-ROSTER-SELF-LEASE-HEAL] ENGINE_ROOM_PERCH_ANCHORED:engine-room: skeleton created, home=erhome — the harness bind inherits this anchor ER_BRINGUP_WAIT_START:engine-room adapter=erhost ready_wait_s=30 ER_LAUNCH_PHASE:engine-room phase=enter t_ms=0 adapter=erhost ER_LAUNCH_PHASE:engine-room phase=prepared t_ms=0 ER_LAUNCH_PHASE:engine-room phase=connecting t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe ER_LAUNCH_PHASE:engine-room phase=connected t_ms=0 ER_LAUNCH_PHASE:engine-room phase=requested t_ms=0 SPAWN_PHASE:engine-room phase=received t_ms=0 fresh=false SPAWN_PHASE:engine-room phase=gate_claimed t_ms=0 SPAWN_PHASE:engine-room phase=pty_creating t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe SELF_ADDR_REBIND:0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b: live endpoint address differs from our advertised roster row — re-authored at lease 1, advertise requested [REQ-SELF-ADDR-REBIND-READVERTISE] ACCESS_STORE_MINTED C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\identity\trust\access.json — no access store was present at first load in this process, so an EMPTY baseline was written (everything open that the chain leaves open). If this node had access rules, they are GONE: the store was removed while the daemon was down, and this mint replaced it. Re-apply them (`spt endpoint access ...`); a restart cannot tell a wipe from a first boot. SPAWN_PHASE:engine-room phase=pty_created t_ms=187 pid=Some(24700) SPAWN_PHASE:engine-room phase=input_writer t_ms=188 CONN_LIFECYCLE: conn=8 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398233265 mono_ms=4355 first_write=none event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] SPAWN_PHASE:engine-room phase=log_ready t_ms=206 SPAWN_PHASE:engine-room phase=drain_armed t_ms=206 SPAWN_PHASE:engine-room phase=waiter_armed t_ms=206 SPAWN_PHASE:engine-room phase=translation_ready t_ms=462 SPAWN_PHASE:engine-room phase=row_inserted t_ms=462 session=1 ER_LAUNCH_PHASE:engine-room phase=spawned t_ms=462 session=1 pid=Some(24700) CONN_LIFECYCLE: conn=8 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398233538 mono_ms=4629 first_write_wall_ms=1789398233285 first_write_mono_ms=4375 event=writer-exit role=controller session=1 reason=channel-closed [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=8 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398233549 mono_ms=4639 first_write_wall_ms=1789398233285 first_write_mono_ms=4375 event=session-detach session=1 was_controller=true viewers_dropped=0 [REQ-CONN-POISON-ATTRIBUTION] ENGINE_ROOM_BROUGHT_UP:engine-room session=1 adapter=erhost (gate admitted; one admit ticket minted, good for 30s) CONN_LIFECYCLE: conn=4 role=brain stream-subscriber stream=2 wall_ms=1789398233587 mono_ms=4677 first_write_wall_ms=1789398230917 first_write_mono_ms=2007 event=stream-sub-attach stream=2 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=10 role=brain stream-subscriber stream=1 wall_ms=1789398233636 mono_ms=4727 first_write_wall_ms=1789398233636 first_write_mono_ms=4726 event=stream-sub-attach stream=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] ATTACH_INTENT_CHOSEN: site=serve_dispatch session=1 intent=control from_seq=0 gen=1789398233587 coded=true CONN_LIFECYCLE: conn=10 role=brain stream-subscriber stream=1 controller session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b wall_ms=1789398233637 mono_ms=4728 first_write_wall_ms=1789398233636 first_write_mono_ms=4726 event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] ATTACH_INTENT_CHOSEN: site=serve_dispatch session=1 intent=control from_seq=0 gen=1789398233587 coded=true SUBSCRIBE_DECISION: session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b conn=10 intent=control old_by=- old_gen=0 req_gen=1789398233587 decision=controller SUBSCRIBE_DECISION: session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b conn=10 intent=control old_by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b old_gen=1789398233587 req_gen=1789398233587 decision=idempotent WAKE_RESUME_SKIP:engine-room: rest intent Active but no prior session to resume (no ledger row) — left as-is WAKE_RESUME_SKIP:engine-room: rest intent Active but no prior session to resume (no ledger row) — left as-is NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) PAIR_MEET_UP:erhome step=59646608 id=2828dad0fca72434d463216b8ab210316975f18ab46da652d317ffffbb2a5350 addr=EndpointAddr { id: PublicKey(2828dad0fca72434d463216b8ab210316975f18ab46da652d317ffffbb2a5350), addrs: {Ip(100.68.35.65:63983), Ip(192.168.1.81:63983)} } ENGINE_ROOM_BRIEFING_UNPRESENTED:engine-room: the engine room's perch did not become a deliverable inject target within the bring-up window — this session opens WITHOUT its posture briefing. The row is RETAINED and pending, so it is still delivered at the session's first idle; read the grid with `spt endpoint access` before changing anything --- re-offer broker (arm 5) --- --- broker stderr, pre-redirect window (C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\brain.stderr.log) --- --- daemon stderr sink (C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\logs\daemon.stderr.log) --- === spt broker stderr — generation 0 — pid 57632 === PERCH_CENSUS_SKIPPED: perch tree unreadable — nothing classified NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) DOCS_SERVER_UP: http://localhost:52864/hfenduleam/docs/ NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) === spt brain stderr — generation 0 — pid 44100 === BRAIN_UP: connected to broker spt-daemon-broker-7c191c74702e822b.sock (pid 44100, generation 0, start-reason cold) BRAIN_PHASE:announce done in 0ms BRAIN_PHASE:resume done in 0ms PAIR_MEET_UP:erhome step=59646607 id=090c158cc8d2064f17c5c9c5290c109f2ccb3f85cbd9deca1ed1fae6b92df725 addr=EndpointAddr { id: PublicKey(090c158cc8d2064f17c5c9c5290c109f2ccb3f85cbd9deca1ed1fae6b92df725), addrs: {Ip(100.68.35.65:50870), Ip(192.168.1.81:50870)} } INBOUND_REACHABILITY: warning: the spt firewall rule admits a DIFFERENT binary than the running daemon, so inbound UDP is blocked despite the rule existing. rule admits: C:\Users\decid\AppData\Local\spt-core\bin\spt.exe daemon runs: C:\Users\decid\Documents\projects\spt-core\.worktrees\asm-304-v3\target\debug\spt.exe Fix: netsh advfirewall firewall delete rule name="spt-core inbound UDP" & netsh advfirewall firewall add rule name="spt-core inbound UDP" dir=in action=allow protocol=UDP program="C:\Users\decid\Documents\projects\spt-core\.worktrees\asm-304-v3\target\debug\spt.exe" (run elevated) BRAIN_PHASE:ready written in 1724ms (exe-hash 1723ms, computed=true) path C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\brain.ready BRAIN_CONN_OPEN: caller=livehost-session-query reason=initial-query policy=reuse-until-query-error wall_ms=1789398230725 mono_ms=1726 BRAIN_CONN_OPEN: caller=livehost-session-query reason=initial-query policy=reuse-until-query-error wall_ms=1789398230726 mono_ms=1727 REGISTRY_SNAPSHOT_HYDRATE:0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b:subnets=0 rows=0 dir=C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\identity\registry wall_ms=1789398231225 BRAIN_NET_CONSUMERS_UP: net enabled (node 0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b) — dispatcher + peer pump started PUMP_IPC_READER: spawned PUMP_IPC_READER: spawned CONN_LIFECYCLE: conn=7 role=brain presence-subscriber wall_ms=1789398231225 mono_ms=2316 first_write=none event=presence-sub-attach from_seq=18446744073709551615 [REQ-CONN-POISON-ATTRIBUTION] EPOCH_FAST_FORWARD:0->1: our fleet-replicated roster row holds lease 0 — jumping past it so our own advertisements are admitted again (KNOWN-HAZARDS 7.60) [REQ-ROSTER-SELF-LEASE-HEAL] ENGINE_ROOM_PERCH_ANCHORED:engine-room: skeleton created, home=erhome — the harness bind inherits this anchor ER_BRINGUP_WAIT_START:engine-room adapter=erhost ready_wait_s=30 ER_LAUNCH_PHASE:engine-room phase=enter t_ms=0 adapter=erhost ER_LAUNCH_PHASE:engine-room phase=prepared t_ms=0 ER_LAUNCH_PHASE:engine-room phase=connecting t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe ER_LAUNCH_PHASE:engine-room phase=connected t_ms=0 ER_LAUNCH_PHASE:engine-room phase=requested t_ms=0 SPAWN_PHASE:engine-room phase=received t_ms=0 fresh=false SPAWN_PHASE:engine-room phase=gate_claimed t_ms=0 SPAWN_PHASE:engine-room phase=pty_creating t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe SELF_ADDR_REBIND:0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b: live endpoint address differs from our advertised roster row — re-authored at lease 1, advertise requested [REQ-SELF-ADDR-REBIND-READVERTISE] ACCESS_STORE_MINTED C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\identity\trust\access.json — no access store was present at first load in this process, so an EMPTY baseline was written (everything open that the chain leaves open). If this node had access rules, they are GONE: the store was removed while the daemon was down, and this mint replaced it. Re-apply them (`spt endpoint access ...`); a restart cannot tell a wipe from a first boot. SPAWN_PHASE:engine-room phase=pty_created t_ms=187 pid=Some(24700) SPAWN_PHASE:engine-room phase=input_writer t_ms=188 CONN_LIFECYCLE: conn=8 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398233265 mono_ms=4355 first_write=none event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] SPAWN_PHASE:engine-room phase=log_ready t_ms=206 SPAWN_PHASE:engine-room phase=drain_armed t_ms=206 SPAWN_PHASE:engine-room phase=waiter_armed t_ms=206 SPAWN_PHASE:engine-room phase=translation_ready t_ms=462 SPAWN_PHASE:engine-room phase=row_inserted t_ms=462 session=1 ER_LAUNCH_PHASE:engine-room phase=spawned t_ms=462 session=1 pid=Some(24700) CONN_LIFECYCLE: conn=8 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398233538 mono_ms=4629 first_write_wall_ms=1789398233285 first_write_mono_ms=4375 event=writer-exit role=controller session=1 reason=channel-closed [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=8 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398233549 mono_ms=4639 first_write_wall_ms=1789398233285 first_write_mono_ms=4375 event=session-detach session=1 was_controller=true viewers_dropped=0 [REQ-CONN-POISON-ATTRIBUTION] ENGINE_ROOM_BROUGHT_UP:engine-room session=1 adapter=erhost (gate admitted; one admit ticket minted, good for 30s) CONN_LIFECYCLE: conn=4 role=brain stream-subscriber stream=2 wall_ms=1789398233587 mono_ms=4677 first_write_wall_ms=1789398230917 first_write_mono_ms=2007 event=stream-sub-attach stream=2 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=10 role=brain stream-subscriber stream=1 wall_ms=1789398233636 mono_ms=4727 first_write_wall_ms=1789398233636 first_write_mono_ms=4726 event=stream-sub-attach stream=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] ATTACH_INTENT_CHOSEN: site=serve_dispatch session=1 intent=control from_seq=0 gen=1789398233587 coded=true CONN_LIFECYCLE: conn=10 role=brain stream-subscriber stream=1 controller session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b wall_ms=1789398233637 mono_ms=4728 first_write_wall_ms=1789398233636 first_write_mono_ms=4726 event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] ATTACH_INTENT_CHOSEN: site=serve_dispatch session=1 intent=control from_seq=0 gen=1789398233587 coded=true SUBSCRIBE_DECISION: session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b conn=10 intent=control old_by=- old_gen=0 req_gen=1789398233587 decision=controller SUBSCRIBE_DECISION: session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b conn=10 intent=control old_by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b old_gen=1789398233587 req_gen=1789398233587 decision=idempotent WAKE_RESUME_SKIP:engine-room: rest intent Active but no prior session to resume (no ledger row) — left as-is WAKE_RESUME_SKIP:engine-room: rest intent Active but no prior session to resume (no ledger row) — left as-is NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) PAIR_MEET_UP:erhome step=59646608 id=2828dad0fca72434d463216b8ab210316975f18ab46da652d317ffffbb2a5350 addr=EndpointAddr { id: PublicKey(2828dad0fca72434d463216b8ab210316975f18ab46da652d317ffffbb2a5350), addrs: {Ip(100.68.35.65:63983), Ip(192.168.1.81:63983)} } ENGINE_ROOM_BRIEFING_UNPRESENTED:engine-room: the engine room's perch did not become a deliverable inject target within the bring-up window — this session opens WITHOUT its posture briefing. The row is RETAINED and pending, so it is still delivered at the session's first idle; read the grid with `spt endpoint access` before changing anything STREAM_CONNBOUND_RETIRE:2: opener conn exited — FIN + terminal retire CONN_LIFECYCLE: conn=10 role=brain stream-subscriber stream=1 controller session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b wall_ms=1789398243802 mono_ms=14892 first_write_wall_ms=1789398233636 first_write_mono_ms=4726 event=writer-exit role=controller session=1 reason=channel-closed [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=10 role=brain stream-subscriber stream=1 controller session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b wall_ms=1789398243891 mono_ms=14981 first_write_wall_ms=1789398233636 first_write_mono_ms=4726 event=session-detach session=1 was_controller=true viewers_dropped=0 [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=10 role=brain stream-subscriber stream=1 controller session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b wall_ms=1789398243891 mono_ms=14981 first_write_wall_ms=1789398233636 first_write_mono_ms=4726 event=stream-sub-release stream=1 [REQ-CONN-POISON-ATTRIBUTION] === spt broker stderr — generation 0 — pid 24920 === PERCH_CENSUS: 1 perch dir(s) — 1 occupied, 0 reapable, 0 refused (spool), 0 refused (empty); report only, nothing removed (see: spt endpoint gc) NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) DOCS_SERVER_UP: http://localhost:54968/hfenduleam/docs/ NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) === spt brain stderr — generation 0 — pid 49188 === BRAIN_UP: connected to broker spt-daemon-broker-7c191c74702e822b.sock (pid 49188, generation 0, start-reason cold) BRAIN_PHASE:announce done in 0ms BRAIN_PHASE:resume done in 0ms PAIR_MEET_UP:erhome step=59646608 id=2828dad0fca72434d463216b8ab210316975f18ab46da652d317ffffbb2a5350 addr=EndpointAddr { id: PublicKey(2828dad0fca72434d463216b8ab210316975f18ab46da652d317ffffbb2a5350), addrs: {Ip(100.68.35.65:64006), Ip(192.168.1.81:64006)} } INBOUND_REACHABILITY: warning: the spt firewall rule admits a DIFFERENT binary than the running daemon, so inbound UDP is blocked despite the rule existing. rule admits: C:\Users\decid\AppData\Local\spt-core\bin\spt.exe daemon runs: C:\Users\decid\Documents\projects\spt-core\.worktrees\asm-304-v3\target\debug\spt.exe Fix: netsh advfirewall firewall delete rule name="spt-core inbound UDP" & netsh advfirewall firewall add rule name="spt-core inbound UDP" dir=in action=allow protocol=UDP program="C:\Users\decid\Documents\projects\spt-core\.worktrees\asm-304-v3\target\debug\spt.exe" (run elevated) BRAIN_PHASE:ready written in 1712ms (exe-hash 1711ms, computed=true) path C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\brain.ready BRAIN_CONN_OPEN: caller=livehost-session-query reason=initial-query policy=reuse-until-query-error wall_ms=1789398246382 mono_ms=1715 ER_BRINGUP_WAIT_START:engine-room adapter=erhost ready_wait_s=30 ER_LAUNCH_PHASE:engine-room phase=enter t_ms=0 adapter=erhost ER_LAUNCH_PHASE:engine-room phase=prepared t_ms=0 ER_LAUNCH_PHASE:engine-room phase=connecting t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe ER_LAUNCH_PHASE:engine-room phase=connected t_ms=0 ER_LAUNCH_PHASE:engine-room phase=requested t_ms=0 SPAWN_PHASE:engine-room phase=received t_ms=0 fresh=false SPAWN_PHASE:engine-room phase=gate_claimed t_ms=0 SPAWN_PHASE:engine-room phase=pty_creating t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe SPAWN_PHASE:engine-room phase=pty_created t_ms=229 pid=Some(55640) SPAWN_PHASE:engine-room phase=input_writer t_ms=229 CONN_LIFECYCLE: conn=4 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398246697 mono_ms=2125 first_write=none event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] REGISTRY_SNAPSHOT_HYDRATE:0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b:subnets=1 rows=0 dir=C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\identity\registry wall_ms=1789398246881 BRAIN_NET_CONSUMERS_UP: net enabled (node 0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b) — dispatcher + peer pump started PUMP_IPC_READER: spawned PUMP_IPC_READER: spawned CONN_LIFECYCLE: conn=8 role=brain presence-subscriber wall_ms=1789398246882 mono_ms=2310 first_write=none event=presence-sub-attach from_seq=18446744073709551615 [REQ-CONN-POISON-ATTRIBUTION] SELF_ADDR_REBIND:0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b: live endpoint address differs from our advertised roster row — re-authored at lease 4, advertise requested [REQ-SELF-ADDR-REBIND-READVERTISE] SELF_ADDR_REBIND:0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b: live endpoint address differs from our advertised roster row — re-authored at lease 5, advertise requested [REQ-SELF-ADDR-REBIND-READVERTISE] SPAWN_PHASE:engine-room phase=log_ready t_ms=3286 SPAWN_PHASE:engine-room phase=drain_armed t_ms=3286 SPAWN_PHASE:engine-room phase=waiter_armed t_ms=3286 BRAIN_CONN_OPEN: caller=livehost-session-query reason=initial-query policy=reuse-until-query-error wall_ms=1789398249761 mono_ms=5093 CONTROL_REAP_NO_SESSION:engine-room: cleared stale controlled/driven_by/viewer_count (no broker session) LIVENESS_RECONCILE_OFFLINE:engine-room: no live broker session (dead harness) SPAWN_PHASE:engine-room phase=translation_ready t_ms=3366 SPAWN_PHASE:engine-room phase=row_inserted t_ms=3366 session=1 ER_LAUNCH_PHASE:engine-room phase=spawned t_ms=3367 session=1 pid=Some(55640) CONN_LIFECYCLE: conn=4 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398249834 mono_ms=5262 first_write_wall_ms=1789398249753 first_write_mono_ms=5181 event=writer-exit role=controller session=1 reason=channel-closed [REQ-CONN-POISON-ATTRIBUTION] ENGINE_ROOM_BROUGHT_UP:engine-room session=1 adapter=erhost (gate admitted; one admit ticket minted, good for 30s) CONN_LIFECYCLE: conn=3 role=brain stream-subscriber stream=2 wall_ms=1789398249845 mono_ms=5273 first_write_wall_ms=1789398246461 first_write_mono_ms=1889 event=stream-sub-attach stream=2 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=4 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398249853 mono_ms=5281 first_write_wall_ms=1789398249753 first_write_mono_ms=5181 event=session-detach session=1 was_controller=true viewers_dropped=0 [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=11 role=brain stream-subscriber stream=1 wall_ms=1789398249898 mono_ms=5326 first_write_wall_ms=1789398249897 first_write_mono_ms=5325 event=stream-sub-attach stream=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] ATTACH_INTENT_CHOSEN: site=serve_dispatch session=1 intent=control from_seq=0 gen=1789398249845 coded=true CONN_LIFECYCLE: conn=11 role=brain stream-subscriber stream=1 controller session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b wall_ms=1789398249899 mono_ms=5327 first_write_wall_ms=1789398249897 first_write_mono_ms=5325 event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] ATTACH_INTENT_CHOSEN: site=serve_dispatch session=1 intent=control from_seq=0 gen=1789398249845 coded=true ENGINE_ROOM_BRIEFING_SWEPT:engine-room: dropped 1 undelivered briefing(s) written for sessions that are gone — a posture statement is true of its own session and of nothing else, and this session's own briefing follows SUBSCRIBE_DECISION: session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b conn=11 intent=control old_by=- old_gen=0 req_gen=1789398249845 decision=controller SUBSCRIBE_DECISION: session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b conn=11 intent=control old_by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b old_gen=1789398249845 req_gen=1789398249845 decision=idempotent ER_LAUNCH_PHASE:engine-room phase=enter t_ms=0 adapter=erhost ER_LAUNCH_PHASE:engine-room phase=prepared t_ms=0 ER_LAUNCH_PHASE:engine-room phase=connecting t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe ER_LAUNCH_PHASE:engine-room phase=connected t_ms=0 ER_LAUNCH_PHASE:engine-room phase=requested t_ms=0 SPAWN_PHASE:engine-room phase=received t_ms=0 fresh=false SPAWN_DEDUP:engine-room: endpoint already has a live session 1 — single-flight wake no-op ack [REQ-SPAWN-COLLISION-GUARD-LIVE-DUP] ER_LAUNCH_PHASE:engine-room phase=spawned t_ms=20 session=1 pid=Some(55640) WAKE_RESUME:engine-room: resuming session a91d840516a9d6ae under erhost (pid 55640) — online at bind ENGINE_ROOM_BRIEFING_UNPRESENTED:engine-room: the engine room's perch did not become a deliverable inject target within the bring-up window — this session opens WITHOUT its posture briefing. The row is RETAINED and pending, so it is still delivered at the session's first idle; read the grid with `spt endpoint access` before changing anything NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) PAIR_MEET_UP:erhome step=59646609 id=121028e55c1869856775cb067ac75776d12ca1c4369c0cdffc83403f5b6bad84 addr=EndpointAddr { id: PublicKey(121028e55c1869856775cb067ac75776d12ca1c4369c0cdffc83403f5b6bad84), addrs: {Ip(100.68.35.65:54598), Ip(192.168.1.81:54598)} } thread 'the_engine_room_briefing_is_presented_before_the_first_actionable_turn' (36128) panicked at crates\spt\tests\er_briefing_presented_e2e.rs:782:9: REQ-ER-BRIEFING-PRESENTED clause 4: the new session's own briefing must be delivered at the same attach that supersedes the retained row. The cross-session chain is miss -> release -> retained -> superseded-with-delivery, never merely disappearance. rows=[SpoolAuditRow { id: 2, from: "spt-engine-room", delivered: false, taken_leg: None, taken_sid: None, taken_pid: None, taken_at_ms: None }] --- miss broker (arm 4) --- --- broker stderr, pre-redirect window (C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\brain.stderr.log) --- --- daemon stderr sink (C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\logs\daemon.stderr.log) --- === spt broker stderr — generation 0 — pid 57632 === PERCH_CENSUS_SKIPPED: perch tree unreadable — nothing classified NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) DOCS_SERVER_UP: http://localhost:52864/hfenduleam/docs/ NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) === spt brain stderr — generation 0 — pid 44100 === BRAIN_UP: connected to broker spt-daemon-broker-7c191c74702e822b.sock (pid 44100, generation 0, start-reason cold) BRAIN_PHASE:announce done in 0ms BRAIN_PHASE:resume done in 0ms PAIR_MEET_UP:erhome step=59646607 id=090c158cc8d2064f17c5c9c5290c109f2ccb3f85cbd9deca1ed1fae6b92df725 addr=EndpointAddr { id: PublicKey(090c158cc8d2064f17c5c9c5290c109f2ccb3f85cbd9deca1ed1fae6b92df725), addrs: {Ip(100.68.35.65:50870), Ip(192.168.1.81:50870)} } INBOUND_REACHABILITY: warning: the spt firewall rule admits a DIFFERENT binary than the running daemon, so inbound UDP is blocked despite the rule existing. rule admits: C:\Users\decid\AppData\Local\spt-core\bin\spt.exe daemon runs: C:\Users\decid\Documents\projects\spt-core\.worktrees\asm-304-v3\target\debug\spt.exe Fix: netsh advfirewall firewall delete rule name="spt-core inbound UDP" & netsh advfirewall firewall add rule name="spt-core inbound UDP" dir=in action=allow protocol=UDP program="C:\Users\decid\Documents\projects\spt-core\.worktrees\asm-304-v3\target\debug\spt.exe" (run elevated) BRAIN_PHASE:ready written in 1724ms (exe-hash 1723ms, computed=true) path C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\brain.ready BRAIN_CONN_OPEN: caller=livehost-session-query reason=initial-query policy=reuse-until-query-error wall_ms=1789398230725 mono_ms=1726 BRAIN_CONN_OPEN: caller=livehost-session-query reason=initial-query policy=reuse-until-query-error wall_ms=1789398230726 mono_ms=1727 REGISTRY_SNAPSHOT_HYDRATE:0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b:subnets=0 rows=0 dir=C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\identity\registry wall_ms=1789398231225 BRAIN_NET_CONSUMERS_UP: net enabled (node 0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b) — dispatcher + peer pump started PUMP_IPC_READER: spawned PUMP_IPC_READER: spawned CONN_LIFECYCLE: conn=7 role=brain presence-subscriber wall_ms=1789398231225 mono_ms=2316 first_write=none event=presence-sub-attach from_seq=18446744073709551615 [REQ-CONN-POISON-ATTRIBUTION] EPOCH_FAST_FORWARD:0->1: our fleet-replicated roster row holds lease 0 — jumping past it so our own advertisements are admitted again (KNOWN-HAZARDS 7.60) [REQ-ROSTER-SELF-LEASE-HEAL] ENGINE_ROOM_PERCH_ANCHORED:engine-room: skeleton created, home=erhome — the harness bind inherits this anchor ER_BRINGUP_WAIT_START:engine-room adapter=erhost ready_wait_s=30 ER_LAUNCH_PHASE:engine-room phase=enter t_ms=0 adapter=erhost ER_LAUNCH_PHASE:engine-room phase=prepared t_ms=0 ER_LAUNCH_PHASE:engine-room phase=connecting t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe ER_LAUNCH_PHASE:engine-room phase=connected t_ms=0 ER_LAUNCH_PHASE:engine-room phase=requested t_ms=0 SPAWN_PHASE:engine-room phase=received t_ms=0 fresh=false SPAWN_PHASE:engine-room phase=gate_claimed t_ms=0 SPAWN_PHASE:engine-room phase=pty_creating t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe SELF_ADDR_REBIND:0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b: live endpoint address differs from our advertised roster row — re-authored at lease 1, advertise requested [REQ-SELF-ADDR-REBIND-READVERTISE] ACCESS_STORE_MINTED C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\identity\trust\access.json — no access store was present at first load in this process, so an EMPTY baseline was written (everything open that the chain leaves open). If this node had access rules, they are GONE: the store was removed while the daemon was down, and this mint replaced it. Re-apply them (`spt endpoint access ...`); a restart cannot tell a wipe from a first boot. SPAWN_PHASE:engine-room phase=pty_created t_ms=187 pid=Some(24700) SPAWN_PHASE:engine-room phase=input_writer t_ms=188 CONN_LIFECYCLE: conn=8 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398233265 mono_ms=4355 first_write=none event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] SPAWN_PHASE:engine-room phase=log_ready t_ms=206 SPAWN_PHASE:engine-room phase=drain_armed t_ms=206 SPAWN_PHASE:engine-room phase=waiter_armed t_ms=206 SPAWN_PHASE:engine-room phase=translation_ready t_ms=462 SPAWN_PHASE:engine-room phase=row_inserted t_ms=462 session=1 ER_LAUNCH_PHASE:engine-room phase=spawned t_ms=462 session=1 pid=Some(24700) CONN_LIFECYCLE: conn=8 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398233538 mono_ms=4629 first_write_wall_ms=1789398233285 first_write_mono_ms=4375 event=writer-exit role=controller session=1 reason=channel-closed [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=8 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398233549 mono_ms=4639 first_write_wall_ms=1789398233285 first_write_mono_ms=4375 event=session-detach session=1 was_controller=true viewers_dropped=0 [REQ-CONN-POISON-ATTRIBUTION] ENGINE_ROOM_BROUGHT_UP:engine-room session=1 adapter=erhost (gate admitted; one admit ticket minted, good for 30s) CONN_LIFECYCLE: conn=4 role=brain stream-subscriber stream=2 wall_ms=1789398233587 mono_ms=4677 first_write_wall_ms=1789398230917 first_write_mono_ms=2007 event=stream-sub-attach stream=2 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=10 role=brain stream-subscriber stream=1 wall_ms=1789398233636 mono_ms=4727 first_write_wall_ms=1789398233636 first_write_mono_ms=4726 event=stream-sub-attach stream=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] ATTACH_INTENT_CHOSEN: site=serve_dispatch session=1 intent=control from_seq=0 gen=1789398233587 coded=true CONN_LIFECYCLE: conn=10 role=brain stream-subscriber stream=1 controller session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b wall_ms=1789398233637 mono_ms=4728 first_write_wall_ms=1789398233636 first_write_mono_ms=4726 event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] ATTACH_INTENT_CHOSEN: site=serve_dispatch session=1 intent=control from_seq=0 gen=1789398233587 coded=true SUBSCRIBE_DECISION: session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b conn=10 intent=control old_by=- old_gen=0 req_gen=1789398233587 decision=controller SUBSCRIBE_DECISION: session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b conn=10 intent=control old_by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b old_gen=1789398233587 req_gen=1789398233587 decision=idempotent WAKE_RESUME_SKIP:engine-room: rest intent Active but no prior session to resume (no ledger row) — left as-is WAKE_RESUME_SKIP:engine-room: rest intent Active but no prior session to resume (no ledger row) — left as-is NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) PAIR_MEET_UP:erhome step=59646608 id=2828dad0fca72434d463216b8ab210316975f18ab46da652d317ffffbb2a5350 addr=EndpointAddr { id: PublicKey(2828dad0fca72434d463216b8ab210316975f18ab46da652d317ffffbb2a5350), addrs: {Ip(100.68.35.65:63983), Ip(192.168.1.81:63983)} } ENGINE_ROOM_BRIEFING_UNPRESENTED:engine-room: the engine room's perch did not become a deliverable inject target within the bring-up window — this session opens WITHOUT its posture briefing. The row is RETAINED and pending, so it is still delivered at the session's first idle; read the grid with `spt endpoint access` before changing anything --- re-offer broker (arm 5) --- --- broker stderr, pre-redirect window (C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\brain.stderr.log) --- --- daemon stderr sink (C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\logs\daemon.stderr.log) --- === spt broker stderr — generation 0 — pid 57632 === PERCH_CENSUS_SKIPPED: perch tree unreadable — nothing classified NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) DOCS_SERVER_UP: http://localhost:52864/hfenduleam/docs/ NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) === spt brain stderr — generation 0 — pid 44100 === BRAIN_UP: connected to broker spt-daemon-broker-7c191c74702e822b.sock (pid 44100, generation 0, start-reason cold) BRAIN_PHASE:announce done in 0ms BRAIN_PHASE:resume done in 0ms PAIR_MEET_UP:erhome step=59646607 id=090c158cc8d2064f17c5c9c5290c109f2ccb3f85cbd9deca1ed1fae6b92df725 addr=EndpointAddr { id: PublicKey(090c158cc8d2064f17c5c9c5290c109f2ccb3f85cbd9deca1ed1fae6b92df725), addrs: {Ip(100.68.35.65:50870), Ip(192.168.1.81:50870)} } INBOUND_REACHABILITY: warning: the spt firewall rule admits a DIFFERENT binary than the running daemon, so inbound UDP is blocked despite the rule existing. rule admits: C:\Users\decid\AppData\Local\spt-core\bin\spt.exe daemon runs: C:\Users\decid\Documents\projects\spt-core\.worktrees\asm-304-v3\target\debug\spt.exe Fix: netsh advfirewall firewall delete rule name="spt-core inbound UDP" & netsh advfirewall firewall add rule name="spt-core inbound UDP" dir=in action=allow protocol=UDP program="C:\Users\decid\Documents\projects\spt-core\.worktrees\asm-304-v3\target\debug\spt.exe" (run elevated) BRAIN_PHASE:ready written in 1724ms (exe-hash 1723ms, computed=true) path C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\brain.ready BRAIN_CONN_OPEN: caller=livehost-session-query reason=initial-query policy=reuse-until-query-error wall_ms=1789398230725 mono_ms=1726 BRAIN_CONN_OPEN: caller=livehost-session-query reason=initial-query policy=reuse-until-query-error wall_ms=1789398230726 mono_ms=1727 REGISTRY_SNAPSHOT_HYDRATE:0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b:subnets=0 rows=0 dir=C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\identity\registry wall_ms=1789398231225 BRAIN_NET_CONSUMERS_UP: net enabled (node 0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b) — dispatcher + peer pump started PUMP_IPC_READER: spawned PUMP_IPC_READER: spawned CONN_LIFECYCLE: conn=7 role=brain presence-subscriber wall_ms=1789398231225 mono_ms=2316 first_write=none event=presence-sub-attach from_seq=18446744073709551615 [REQ-CONN-POISON-ATTRIBUTION] EPOCH_FAST_FORWARD:0->1: our fleet-replicated roster row holds lease 0 — jumping past it so our own advertisements are admitted again (KNOWN-HAZARDS 7.60) [REQ-ROSTER-SELF-LEASE-HEAL] ENGINE_ROOM_PERCH_ANCHORED:engine-room: skeleton created, home=erhome — the harness bind inherits this anchor ER_BRINGUP_WAIT_START:engine-room adapter=erhost ready_wait_s=30 ER_LAUNCH_PHASE:engine-room phase=enter t_ms=0 adapter=erhost ER_LAUNCH_PHASE:engine-room phase=prepared t_ms=0 ER_LAUNCH_PHASE:engine-room phase=connecting t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe ER_LAUNCH_PHASE:engine-room phase=connected t_ms=0 ER_LAUNCH_PHASE:engine-room phase=requested t_ms=0 SPAWN_PHASE:engine-room phase=received t_ms=0 fresh=false SPAWN_PHASE:engine-room phase=gate_claimed t_ms=0 SPAWN_PHASE:engine-room phase=pty_creating t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe SELF_ADDR_REBIND:0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b: live endpoint address differs from our advertised roster row — re-authored at lease 1, advertise requested [REQ-SELF-ADDR-REBIND-READVERTISE] ACCESS_STORE_MINTED C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\identity\trust\access.json — no access store was present at first load in this process, so an EMPTY baseline was written (everything open that the chain leaves open). If this node had access rules, they are GONE: the store was removed while the daemon was down, and this mint replaced it. Re-apply them (`spt endpoint access ...`); a restart cannot tell a wipe from a first boot. SPAWN_PHASE:engine-room phase=pty_created t_ms=187 pid=Some(24700) SPAWN_PHASE:engine-room phase=input_writer t_ms=188 CONN_LIFECYCLE: conn=8 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398233265 mono_ms=4355 first_write=none event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] SPAWN_PHASE:engine-room phase=log_ready t_ms=206 SPAWN_PHASE:engine-room phase=drain_armed t_ms=206 SPAWN_PHASE:engine-room phase=waiter_armed t_ms=206 SPAWN_PHASE:engine-room phase=translation_ready t_ms=462 SPAWN_PHASE:engine-room phase=row_inserted t_ms=462 session=1 ER_LAUNCH_PHASE:engine-room phase=spawned t_ms=462 session=1 pid=Some(24700) CONN_LIFECYCLE: conn=8 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398233538 mono_ms=4629 first_write_wall_ms=1789398233285 first_write_mono_ms=4375 event=writer-exit role=controller session=1 reason=channel-closed [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=8 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398233549 mono_ms=4639 first_write_wall_ms=1789398233285 first_write_mono_ms=4375 event=session-detach session=1 was_controller=true viewers_dropped=0 [REQ-CONN-POISON-ATTRIBUTION] ENGINE_ROOM_BROUGHT_UP:engine-room session=1 adapter=erhost (gate admitted; one admit ticket minted, good for 30s) CONN_LIFECYCLE: conn=4 role=brain stream-subscriber stream=2 wall_ms=1789398233587 mono_ms=4677 first_write_wall_ms=1789398230917 first_write_mono_ms=2007 event=stream-sub-attach stream=2 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=10 role=brain stream-subscriber stream=1 wall_ms=1789398233636 mono_ms=4727 first_write_wall_ms=1789398233636 first_write_mono_ms=4726 event=stream-sub-attach stream=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] ATTACH_INTENT_CHOSEN: site=serve_dispatch session=1 intent=control from_seq=0 gen=1789398233587 coded=true CONN_LIFECYCLE: conn=10 role=brain stream-subscriber stream=1 controller session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b wall_ms=1789398233637 mono_ms=4728 first_write_wall_ms=1789398233636 first_write_mono_ms=4726 event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] ATTACH_INTENT_CHOSEN: site=serve_dispatch session=1 intent=control from_seq=0 gen=1789398233587 coded=true SUBSCRIBE_DECISION: session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b conn=10 intent=control old_by=- old_gen=0 req_gen=1789398233587 decision=controller SUBSCRIBE_DECISION: session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b conn=10 intent=control old_by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b old_gen=1789398233587 req_gen=1789398233587 decision=idempotent WAKE_RESUME_SKIP:engine-room: rest intent Active but no prior session to resume (no ledger row) — left as-is WAKE_RESUME_SKIP:engine-room: rest intent Active but no prior session to resume (no ledger row) — left as-is NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) PAIR_MEET_UP:erhome step=59646608 id=2828dad0fca72434d463216b8ab210316975f18ab46da652d317ffffbb2a5350 addr=EndpointAddr { id: PublicKey(2828dad0fca72434d463216b8ab210316975f18ab46da652d317ffffbb2a5350), addrs: {Ip(100.68.35.65:63983), Ip(192.168.1.81:63983)} } ENGINE_ROOM_BRIEFING_UNPRESENTED:engine-room: the engine room's perch did not become a deliverable inject target within the bring-up window — this session opens WITHOUT its posture briefing. The row is RETAINED and pending, so it is still delivered at the session's first idle; read the grid with `spt endpoint access` before changing anything STREAM_CONNBOUND_RETIRE:2: opener conn exited — FIN + terminal retire CONN_LIFECYCLE: conn=10 role=brain stream-subscriber stream=1 controller session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b wall_ms=1789398243802 mono_ms=14892 first_write_wall_ms=1789398233636 first_write_mono_ms=4726 event=writer-exit role=controller session=1 reason=channel-closed [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=10 role=brain stream-subscriber stream=1 controller session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b wall_ms=1789398243891 mono_ms=14981 first_write_wall_ms=1789398233636 first_write_mono_ms=4726 event=session-detach session=1 was_controller=true viewers_dropped=0 [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=10 role=brain stream-subscriber stream=1 controller session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b wall_ms=1789398243891 mono_ms=14981 first_write_wall_ms=1789398233636 first_write_mono_ms=4726 event=stream-sub-release stream=1 [REQ-CONN-POISON-ATTRIBUTION] === spt broker stderr — generation 0 — pid 24920 === PERCH_CENSUS: 1 perch dir(s) — 1 occupied, 0 reapable, 0 refused (spool), 0 refused (empty); report only, nothing removed (see: spt endpoint gc) NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) DOCS_SERVER_UP: http://localhost:54968/hfenduleam/docs/ NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) === spt brain stderr — generation 0 — pid 49188 === BRAIN_UP: connected to broker spt-daemon-broker-7c191c74702e822b.sock (pid 49188, generation 0, start-reason cold) BRAIN_PHASE:announce done in 0ms BRAIN_PHASE:resume done in 0ms PAIR_MEET_UP:erhome step=59646608 id=2828dad0fca72434d463216b8ab210316975f18ab46da652d317ffffbb2a5350 addr=EndpointAddr { id: PublicKey(2828dad0fca72434d463216b8ab210316975f18ab46da652d317ffffbb2a5350), addrs: {Ip(100.68.35.65:64006), Ip(192.168.1.81:64006)} } INBOUND_REACHABILITY: warning: the spt firewall rule admits a DIFFERENT binary than the running daemon, so inbound UDP is blocked despite the rule existing. rule admits: C:\Users\decid\AppData\Local\spt-core\bin\spt.exe daemon runs: C:\Users\decid\Documents\projects\spt-core\.worktrees\asm-304-v3\target\debug\spt.exe Fix: netsh advfirewall firewall delete rule name="spt-core inbound UDP" & netsh advfirewall firewall add rule name="spt-core inbound UDP" dir=in action=allow protocol=UDP program="C:\Users\decid\Documents\projects\spt-core\.worktrees\asm-304-v3\target\debug\spt.exe" (run elevated) BRAIN_PHASE:ready written in 1712ms (exe-hash 1711ms, computed=true) path C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\brain.ready BRAIN_CONN_OPEN: caller=livehost-session-query reason=initial-query policy=reuse-until-query-error wall_ms=1789398246382 mono_ms=1715 ER_BRINGUP_WAIT_START:engine-room adapter=erhost ready_wait_s=30 ER_LAUNCH_PHASE:engine-room phase=enter t_ms=0 adapter=erhost ER_LAUNCH_PHASE:engine-room phase=prepared t_ms=0 ER_LAUNCH_PHASE:engine-room phase=connecting t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe ER_LAUNCH_PHASE:engine-room phase=connected t_ms=0 ER_LAUNCH_PHASE:engine-room phase=requested t_ms=0 SPAWN_PHASE:engine-room phase=received t_ms=0 fresh=false SPAWN_PHASE:engine-room phase=gate_claimed t_ms=0 SPAWN_PHASE:engine-room phase=pty_creating t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe SPAWN_PHASE:engine-room phase=pty_created t_ms=229 pid=Some(55640) SPAWN_PHASE:engine-room phase=input_writer t_ms=229 CONN_LIFECYCLE: conn=4 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398246697 mono_ms=2125 first_write=none event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] REGISTRY_SNAPSHOT_HYDRATE:0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b:subnets=1 rows=0 dir=C:\Users\decid\AppData\Local\Temp\.tmpKvYKc3\identity\registry wall_ms=1789398246881 BRAIN_NET_CONSUMERS_UP: net enabled (node 0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b) — dispatcher + peer pump started PUMP_IPC_READER: spawned PUMP_IPC_READER: spawned CONN_LIFECYCLE: conn=8 role=brain presence-subscriber wall_ms=1789398246882 mono_ms=2310 first_write=none event=presence-sub-attach from_seq=18446744073709551615 [REQ-CONN-POISON-ATTRIBUTION] SELF_ADDR_REBIND:0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b: live endpoint address differs from our advertised roster row — re-authored at lease 4, advertise requested [REQ-SELF-ADDR-REBIND-READVERTISE] SELF_ADDR_REBIND:0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b: live endpoint address differs from our advertised roster row — re-authored at lease 5, advertise requested [REQ-SELF-ADDR-REBIND-READVERTISE] SPAWN_PHASE:engine-room phase=log_ready t_ms=3286 SPAWN_PHASE:engine-room phase=drain_armed t_ms=3286 SPAWN_PHASE:engine-room phase=waiter_armed t_ms=3286 BRAIN_CONN_OPEN: caller=livehost-session-query reason=initial-query policy=reuse-until-query-error wall_ms=1789398249761 mono_ms=5093 CONTROL_REAP_NO_SESSION:engine-room: cleared stale controlled/driven_by/viewer_count (no broker session) LIVENESS_RECONCILE_OFFLINE:engine-room: no live broker session (dead harness) SPAWN_PHASE:engine-room phase=translation_ready t_ms=3366 SPAWN_PHASE:engine-room phase=row_inserted t_ms=3366 session=1 ER_LAUNCH_PHASE:engine-room phase=spawned t_ms=3367 session=1 pid=Some(55640) CONN_LIFECYCLE: conn=4 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398249834 mono_ms=5262 first_write_wall_ms=1789398249753 first_write_mono_ms=5181 event=writer-exit role=controller session=1 reason=channel-closed [REQ-CONN-POISON-ATTRIBUTION] ENGINE_ROOM_BROUGHT_UP:engine-room session=1 adapter=erhost (gate admitted; one admit ticket minted, good for 30s) CONN_LIFECYCLE: conn=3 role=brain stream-subscriber stream=2 wall_ms=1789398249845 mono_ms=5273 first_write_wall_ms=1789398246461 first_write_mono_ms=1889 event=stream-sub-attach stream=2 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=4 role=brain controller session=1 endpoint=engine-room by=local wall_ms=1789398249853 mono_ms=5281 first_write_wall_ms=1789398249753 first_write_mono_ms=5181 event=session-detach session=1 was_controller=true viewers_dropped=0 [REQ-CONN-POISON-ATTRIBUTION] CONN_LIFECYCLE: conn=11 role=brain stream-subscriber stream=1 wall_ms=1789398249898 mono_ms=5326 first_write_wall_ms=1789398249897 first_write_mono_ms=5325 event=stream-sub-attach stream=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] ATTACH_INTENT_CHOSEN: site=serve_dispatch session=1 intent=control from_seq=0 gen=1789398249845 coded=true CONN_LIFECYCLE: conn=11 role=brain stream-subscriber stream=1 controller session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b wall_ms=1789398249899 mono_ms=5327 first_write_wall_ms=1789398249897 first_write_mono_ms=5325 event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] ATTACH_INTENT_CHOSEN: site=serve_dispatch session=1 intent=control from_seq=0 gen=1789398249845 coded=true ENGINE_ROOM_BRIEFING_SWEPT:engine-room: dropped 1 undelivered briefing(s) written for sessions that are gone — a posture statement is true of its own session and of nothing else, and this session's own briefing follows SUBSCRIBE_DECISION: session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b conn=11 intent=control old_by=- old_gen=0 req_gen=1789398249845 decision=controller SUBSCRIBE_DECISION: session=1 endpoint=engine-room by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b conn=11 intent=control old_by=0e1cda291eb9c2818da7baa96756ab015917af9f4935d5fa381fb511f789209b old_gen=1789398249845 req_gen=1789398249845 decision=idempotent ER_LAUNCH_PHASE:engine-room phase=enter t_ms=0 adapter=erhost ER_LAUNCH_PHASE:engine-room phase=prepared t_ms=0 ER_LAUNCH_PHASE:engine-room phase=connecting t_ms=0 program=C:/Users/decid/Documents/projects/spt-core/.worktrees/asm-304-v3/target/debug/mock-session.exe ER_LAUNCH_PHASE:engine-room phase=connected t_ms=0 ER_LAUNCH_PHASE:engine-room phase=requested t_ms=0 SPAWN_PHASE:engine-room phase=received t_ms=0 fresh=false SPAWN_DEDUP:engine-room: endpoint already has a live session 1 — single-flight wake no-op ack [REQ-SPAWN-COLLISION-GUARD-LIVE-DUP] ER_LAUNCH_PHASE:engine-room phase=spawned t_ms=20 session=1 pid=Some(55640) WAKE_RESUME:engine-room: resuming session a91d840516a9d6ae under erhost (pid 55640) — online at bind ENGINE_ROOM_BRIEFING_UNPRESENTED:engine-room: the engine room's perch did not become a deliverable inject target within the bring-up window — this session opens WITHOUT its posture briefing. The row is RETAINED and pending, so it is still delivered at the session's first idle; read the grid with `spt endpoint access` before changing anything NET_FAMILY_GATE: binding IPv4-only (IPv6 unreachable or disabled) PAIR_MEET_UP:erhome step=59646609 id=121028e55c1869856775cb067ac75776d12ca1c4369c0cdffc83403f5b6bad84 addr=EndpointAddr { id: PublicKey(121028e55c1869856775cb067ac75776d12ca1c4369c0cdffc83403f5b6bad84), addrs: {Ip(100.68.35.65:54598), Ip(192.168.1.81:54598)} } note: run with `RUST_BACKTRACE=1` environment variable to display a backtrace PASS [ 8.191s] ( 39/239) spt::er_briefing_session_scoped_e2e a_new_session_never_delivers_an_older_sessions_briefing PASS [ 9.211s] ( 40/239) spt::er_sequestered_cwd_e2e engine_room_launches_sequestered_and_nothing_is_written_into_it PASS [ 7.442s] ( 41/239) spt::gateway_owner_shell_e2e gateway_typed_owner_owns_a_shell_on_every_path_keyed_on_id PASS [ 10.017s] ( 42/239) spt::idle_edge_drain_e2e spool_while_active_then_idle_fires_injection PASS [ 8.983s] ( 43/239) spt::idle_edge_seal_e2e idle_seals_the_latest_turn_with_a_stable_seq_and_no_further_prompt PASS [ 6.861s] ( 44/239) spt::job_escape_e2e win::cold_start_daemon_escapes_kill_on_close_job_via_wmi PASS [ 4.025s] ( 45/239) spt::job_escape_e2e win::wmi_daemon_run_has_no_conhost_window PASS [ 12.816s] ( 46/239) spt::knock_approve_not_hostage_e2e an_approval_stands_and_exits_the_same_whether_or_not_its_wire_legs_arrive PASS [ 12.994s] ( 47/239) spt::knock_mutual_cross_node_e2e a_cross_node_redemption_opens_the_presenters_own_side_and_only_asks_for_the_minters PASS [ 11.263s] ( 48/239) spt::live_adapt_translation_swap_e2e adapter_apply_for_foreign_adapter_leaves_live_endpoint_untouched PASS [ 10.079s] ( 49/239) spt::live_adapt_translation_swap_e2e adapter_apply_swaps_composite_profile_endpoint_matched_on_parent PASS [ 9.231s] ( 50/239) spt::live_adapt_translation_swap_e2e adapter_apply_swaps_locked_translation_binary_without_restarting_endpoint PASS [ 6.669s] ( 51/239) spt::live_adapt_translation_swap_e2e adapter_apply_with_no_matching_session_still_swaps PASS [ 14.475s] ( 52/239) spt::livehost_bootgate_e2e cold_start_does_not_revive_a_sessionless_online_latched_perch PASS [ 7.637s] ( 53/239) spt::multi_subnet_bringup_e2e fresh_unbound_is_attachable_before_bind PASS [ 8.200s] ( 54/239) spt::multi_subnet_bringup_e2e multi_subnet_refuses_without_subnet_then_homes_and_binds PASS [ 8.126s] ( 55/239) spt::multi_subnet_bringup_e2e single_subnet_control_auto_homes PASS [ 2.861s] ( 56/239) spt::n1_compat brain_accepts_old_and_new_broker_argv PASS [ 0.076s] ( 57/239) spt::n1_pairing new_brain_serves_against_old_broker PASS [ 0.079s] ( 58/239) spt::oneliner_e2e at_logon_task_launches_daemon_in_background_not_foreground PASS [ 0.012s] ( 59/239) spt::oneliner_e2e install_script_against_staged_release PASS [ 1.852s] ( 60/239) spt::projindex_reader_e2e daemon_failure_panel_reads_pre_redirect_capture_and_persistent_sink PASS [ 30.700s] ( 61/239) spt::projindex_reader_e2e readers_answer_from_daemon_maintained_index_with_zero_git PASS [ 22.709s] ( 62/239) spt::projindex_writer_e2e writer_cold_warm_and_event_invalidation_against_live_daemon PASS [ 6.596s] ( 63/239) spt::psyche_download_e2e psyche_download_emits_brief_with_pending_then_self_clears PASS [ 4.330s] ( 64/239) spt::rc_attach_truth harness_only_refuses_truthfully_pre_stream PASS [ 7.590s] ( 65/239) spt::rc_attach_truth offline_row_over_live_session_attaches PASS [ 4.874s] ( 66/239) spt::rc_attach_truth offline_row_with_no_session_refuses PASS [ 6.085s] ( 67/239) spt::rc_attach_truth rc_owned_display_carries_no_pump_diagnostics PASS [ 15.246s] ( 68/239) spt::rc_attach_truth resume_never_bound_reads_unbound_and_attaches PASS [ 9.347s] ( 69/239) spt::rc_attach_truth zombie_claim_refuses_never_attaches PASS [ 7.088s] ( 70/239) spt::resident_service_e2e a_declared_service_rises_with_the_daemon_and_reaches_the_cli PASS [ 8.465s] ( 71/239) spt::resume_no_control_steal_e2e brain_respawn_keeps_every_session_controller_and_still_promotes PASS [ 8.117s] ( 72/239) spt::resume_template_e2e endpoint_run_resume_selects_resume_template_in_recorded_cwd PASS [ 4.886s] ( 73/239) spt::run_no_dup_session_e2e run_over_live_endpoint_never_mints_a_second_session PASS [ 3.543s] ( 74/239) spt::trial_drain_drive_e2e trial_candidate_self_drives_the_reap_of_a_black_holed_old_gen_controller PASS [ 0.206s] ( 75/239) spt::twohost_cli gated_cli_role_a PASS [ 0.030s] ( 76/239) spt::twohost_cli gated_cli_role_b PASS [ 33.675s] ( 77/239) spt::wake_resume_bind_e2e wake_on_a_suspended_agent_resumes_binds_online_and_rehosts PASS [ 13.928s] ( 78/239) spt::webserve_attachment_e2e an_attachment_is_snapshot_served_fetched_back_and_named_by_its_message PASS [ 21.218s] ( 79/239) spt::webserve_cross_node_e2e a_peers_url_is_served_by_its_owner_through_the_local_listener PASS [ 0.263s] ( 80/239) spt-daemon::attach admission_answers_the_clients_own_identity_with_applicable_policy PASS [ 0.197s] ( 81/239) spt-daemon::attach attach_registers_remote_drive_detection PASS [ 0.346s] ( 82/239) spt-daemon::attach attach_survives_target_brain_restart_exactly_once PASS [ 0.087s] ( 83/239) spt-daemon::attach broker_spawns_the_pty_child_in_the_requested_cwd PASS [ 0.317s] ( 84/239) spt-daemon::attach controller_restart_with_viewer_no_displace_and_viewer_survives PASS [ 0.088s] ( 85/239) spt-daemon::attach controller_viewer_matrix_and_loud_take PASS [ 0.046s] ( 86/239) spt-daemon::attach handoff_seeds_resume_cursor_and_resubscribes_for_resume PASS [ 0.323s] ( 87/239) spt-daemon::attach local_attach_via_loopback_conn_rides_the_same_pump PASS [ 1.131s] ( 88/239) spt-daemon::attach loopback_attach_to_a_prepopulated_ring_delivers_without_deadlock PASS [ 0.136s] ( 89/239) spt-daemon::attach loopback_self_dial_is_refused_local_uses_fallback_transport PASS [ 0.477s] ( 90/239) spt-daemon::attach re_serve_resets_resume_cursor_after_a_pre_attached_consume PASS [ 0.326s] ( 91/239) spt-daemon::attach remote_attach_drives_a_real_pty_cross_daemon PASS [ 0.737s] ( 92/239) spt-daemon::attach resize_is_controller_exclusive PASS [ 0.703s] ( 93/239) spt-daemon::attach same_origin_re_subscribe_does_not_displace PASS [ 5.606s] ( 94/239) spt-daemon::attach spt_hosted_bringup_then_cross_node_attach_drives_the_pty PASS [ 0.551s] ( 95/239) spt-daemon::attach wedged_viewer_does_not_stall_controller PASS [ 10.264s] ( 96/239) spt-daemon::brain_resume_conn_deadlock daemon_cursor_only_resume_keeps_heartbeat_live_respawn_interleave PASS [ 12.195s] ( 97/239) spt-daemon::brain_resume_conn_deadlock daemon_cursor_only_resume_keeps_heartbeat_live_steady_state PASS [ 3.051s] ( 98/239) spt-daemon::brain_resume_conn_deadlock daemon_resume_leaves_zero_brain_subscribers PASS [ 2.672s] ( 99/239) spt-daemon::brain_swap brain_only_update_swaps_logic_with_zero_endpoint_interruption PASS [ 1.577s] (100/239) spt-daemon::broker ack_false_input_suppresses_applied_frame PASS [ 2.524s] (101/239) spt-daemon::broker broker_hosts_pty_child_streams_output_and_accepts_input PASS [ 2.840s] (102/239) spt-daemon::broker controller_writer_reorder_consumer_view_stays_monotonic_and_session_live PASS [ 2.108s] (103/239) spt-daemon::broker dead_session_subscribe_does_not_hang PASS [ 1.537s] (104/239) spt-daemon::broker endpoint_keyed_inject_without_binary_spools_not_pty PASS [ 0.379s] (105/239) spt-daemon::broker exactly_once_preserved_on_no_ack_path PASS [ 1.899s] (106/239) spt-daemon::broker spawn_env_reaches_child PASS [ 1.535s] (107/239) spt-daemon::broker wall_b_endpoint_run_env_then_send_spools PASS [ 0.234s] (108/239) spt-daemon::budget measure_dormant_seat_budget PASS [ 2.642s] (109/239) spt-daemon::conn_blackhole_lifecycle blackholed_controller_lifecycle_five_invariants PASS [ 3.056s] (110/239) spt-daemon::controller_lease equal_lease_replay_stays_silent_and_never_self_displaces PASS [ 1.646s] (111/239) spt-daemon::controller_lease revoke_terminates_a_wedged_incumbent_plain_control PASS [ 1.606s] (112/239) spt-daemon::controller_lease revoke_terminates_a_wedged_incumbent_take PASS [ 0.630s] (113/239) spt-daemon::controller_lease same_node_distinct_lease_take_displaces_loudly_and_completes_the_stream PASS [ 0.641s] (114/239) spt-daemon::controller_lease same_node_newer_gen_plain_control_supersedes_loudly_and_completes_the_stream PASS [ 0.251s] (115/239) spt-daemon::controller_lease stale_lease_input_and_resize_mutate_nothing_and_shell_injection_lands PASS [ 33.605s] (116/239) spt-daemon::daemon_e2e daemon_hosts_lifecycle_and_survives_brain_restart PASS [ 5.194s] (117/239) spt-daemon::daemon_lifecycle_real_brain real_brain_process_hosts_the_psyche_for_an_online_live_endpoint PASS [ 0.516s] (118/239) spt-daemon::digest harness_hosted_digest_projects_and_pushes_deltas PASS [ 0.016s] (119/239) spt-daemon::dispatch classify_routes_a_node_label_feed_to_registry PASS [ 0.168s] (120/239) spt-daemon::dispatch dispatcher_applies_a_notif_feed_undriven PASS [ 0.398s] (121/239) spt-daemon::dispatch dispatcher_funnels_wan_messages_undriven PASS [ 0.176s] (122/239) spt-daemon::dispatch dispatcher_resolves_attach_by_endpoint_and_refuses_a_stale_endpoint PASS [ 0.430s] (123/239) spt-daemon::dispatch dispatcher_serves_a_cross_node_shell_link PASS [ 0.418s] (124/239) spt-daemon::dispatch dispatcher_serves_a_remote_drive_attach_undriven PASS [ 0.198s] (125/239) spt-daemon::dispatch dispatcher_serves_a_subnet_serve_probe PASS [ 10.043s] (126/239) spt-daemon::dispatch dispatcher_serves_a_sync_pull_undriven PASS [ 0.392s] (127/239) spt-daemon::dispatch dispatcher_serves_an_update_pull_undriven PASS [ 0.224s] (128/239) spt-daemon::dispatch dispatcher_surfaces_a_remote_won_notif_at_the_winning_node PASS [ 0.361s] (129/239) spt-daemon::dispatch dispatcher_survives_an_unknown_stream PASS [ 1.039s] (130/239) spt-daemon::driven_by_selfheal gap_a_live_session_controller_by_is_ambiguous_so_reconcile_must_not_clear PASS [ 0.218s] (131/239) spt-daemon::driven_by_selfheal gap_b_sessionless_perch_reconcile_offlines_and_clears_driven_by PASS [ 0.125s] (132/239) spt-daemon::endpoint_lifecycle an_inherited_stamp_from_a_dead_relay_converges_while_a_dead_binder_row_stays_online PASS [ 0.312s] (133/239) spt-daemon::endpoint_lifecycle dead_pid_hybrid_row_does_not_survive_reconcile PASS [ 2.491s] (134/239) spt-daemon::endpoint_lifecycle dead_relay_converges_while_its_live_sibling_still_delivers PASS [ 0.276s] (135/239) spt-daemon::endpoint_lifecycle definitive_death_normalizes_and_next_reconcile_emits_no_wake_resume PASS [ 1.135s] (136/239) spt-daemon::endpoint_lifecycle poll_vs_reap_interleave_converges_to_cleared_stamps PASS [ 0.263s] (137/239) spt-daemon::endpoint_lifecycle raw_viewport_close_frees_the_controller_full_chain_across_broker_restart PASS [ 0.290s] (138/239) spt-daemon::endpoint_survival daemon_restart_reruns_a_previously_online_orphaned_endpoint PASS [ 0.515s] (139/239) spt-daemon::endpoint_survival daemon_restart_resumes_a_ready_agent_controllable_orphan PASS [ 0.033s] (140/239) spt-daemon::endpoint_survival reconcile_leaves_a_legitimate_live_pid_ready_listener_online PASS [ 0.070s] (141/239) spt-daemon::endpoint_survival reconcile_terminally_offlines_a_sessionless_ready_agent_controllable_hybrid PASS [ 5.089s] (142/239) spt-daemon::exit_every_reap every_completed_reap_reaches_the_attached_terminal_as_an_exit PASS [ 2.344s] (143/239) spt-daemon::handoff brain_restart_survives_gaplessly_with_fresh_gen_start PASS [ 0.448s] (144/239) spt-daemon::idempotent pty_writes_are_exactly_once_across_brain_crashes PASS [ 6.556s] (145/239) spt-daemon::inject_control_wedge a_backed_up_controller_does_not_wedge_the_session PASS [ 3.414s] (146/239) spt-daemon::inject_control_wedge a_journaled_input_wedge_does_not_starve_a_concurrent_rc_attach PASS [ 2.193s] (147/239) spt-daemon::inject_control_wedge c1_miss_once_preserves_binary_and_next_inject_delivers FAIL [ 5.297s] (148/239) spt-daemon::inject_control_wedge c1_strike_fault_stamps_perch_and_bounded_respawns_then_gives_up stdout ─── running 1 test test c1_strike_fault_stamps_perch_and_bounded_respawns_then_gives_up ... FAILED failures: failures: c1_strike_fault_stamps_perch_and_bounded_respawns_then_gives_up test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 18 filtered out; finished in 5.28s stderr ─── NTP_TOTP_UNCORRECTED: all NTP servers unreachable — ceremony clock = raw system clock PUMP_IPC_READER: spawned SPAWN_PHASE:xlate-c1b-ep phase=received t_ms=0 fresh=false SPAWN_PHASE:xlate-c1b-ep phase=gate_claimed t_ms=0 SPAWN_PHASE:xlate-c1b-ep phase=pty_creating t_ms=0 program=findstr SPAWN_PHASE:xlate-c1b-ep phase=pty_created t_ms=19 pid=Some(51988) SPAWN_PHASE:xlate-c1b-ep phase=input_writer t_ms=19 CONN_LIFECYCLE: conn=1 role=brain controller session=1 endpoint=xlate-c1b-ep by=local wall_ms=1789398806160 mono_ms=0 first_write=none event=controller-attach session=1 from_seq=0 [REQ-CONN-POISON-ATTRIBUTION] SPAWN_PHASE:xlate-c1b-ep phase=log_ready t_ms=31 SPAWN_PHASE:xlate-c1b-ep phase=drain_armed t_ms=31 SPAWN_PHASE:xlate-c1b-ep phase=waiter_armed t_ms=31 SPAWN_PHASE:xlate-c1b-ep phase=translation_ready t_ms=40 SPAWN_PHASE:xlate-c1b-ep phase=row_inserted t_ms=40 session=1 ENDPOINT_INJECT:xlate-c1b-ep (52 bytes → translation binary) INJECT_SETTLE_TIMEOUT:xlate-c1b-ep: no PTY readiness echo within 80ms — proceeding (echo-verify guards head loss) ENDPOINT_INJECT:xlate-c1b-ep (52 bytes → translation binary) ENDPOINT_INJECT:xlate-c1b-ep (52 bytes → translation binary) ENDPOINT_INJECT:xlate-c1b-ep (52 bytes → translation binary) ENDPOINT_INJECT:xlate-c1b-ep (52 bytes → translation binary) ENDPOINT_INJECT:xlate-c1b-ep (52 bytes → translation binary) ENDPOINT_INJECT:xlate-c1b-ep (52 bytes → translation binary) TRANSLATION_COMMIT_MISS:xlate-c1b-ep: no {commit} within deadline (strike 1/1) — binary preserved, envelope respooled once TRANSLATION_FAULT: no {commit} within INJECT_COMMIT_DEADLINE for the strike budget — terminating binary; idle messages spool until a respawn or a working binary TRANSLATION_RESPAWN:xlate-c1b-ep: rebuilt faulted binary (attempt 1/2) ENDPOINT_INJECT:xlate-c1b-ep (52 bytes → translation binary) INJECT_SETTLE_TIMEOUT:xlate-c1b-ep: no PTY readiness echo within 80ms — proceeding (echo-verify guards head loss) TRANSLATION_COMMIT_MISS:xlate-c1b-ep: no {commit} within deadline (strike 1/1) — binary preserved, envelope respooled once TRANSLATION_FAULT: no {commit} within INJECT_COMMIT_DEADLINE for the strike budget — terminating binary; idle messages spool until a respawn or a working binary SPAWN_PHASE:xlate-c1b-ep phase=row_removed session=1 lived_ms=5195 === C-1 B FAULT/RESPAWN/GIVEUP GATE: stamped=Some("no {commit} within INJECT_COMMIT_DEADLINE for the strike budget") inits_logged=2 saw_spool=false attempts=8 (fixed = stamped Some, inits in 2..=3 (initial + bounded respawns), give-up spool; pre-C-1 = no stamp + never respawns + permanent death) === thread 'c1_strike_fault_stamps_perch_and_bounded_respawns_then_gives_up' (55840) panicked at crates\spt-daemon\tests\inject_control_wedge.rs:2104:5: once the respawn budget is exhausted the binary must stay dead and inbound must SPOOL (delivered=false), loudly — not respawn forever note: run with `RUST_BACKTRACE=1` environment variable to display a backtrace PASS [ 13.447s] (149/239) spt-daemon::inject_control_wedge g1_choreography_happy_path_payload_reaches_pty_and_controller_keeps_control PASS [ 1.769s] (150/239) spt-daemon::inject_control_wedge g2_no_commit_deadline_faults_binary_and_does_not_wedge_controller_input PASS [ 0.881s] (151/239) spt-daemon::inject_control_wedge g3_content_free_ping_never_duplicates_operator_keystrokes_into_binary PASS [ 1.499s] (152/239) spt-daemon::inject_control_wedge g4_translation_child_is_reaped_no_zombie_after_session_down PASS [ 2.500s] (153/239) spt-daemon::inject_control_wedge g5_active_endpoint_spools_deferred_and_is_not_injected PASS [ 2.653s] (154/239) spt-daemon::inject_control_wedge g6_faulted_inflight_envelope_is_respooled_not_lost PASS [ 15.619s] (155/239) spt-daemon::inject_control_wedge g7_native_injects_mid_active_bypassing_the_idle_gate PASS [ 2.702s] (156/239) spt-daemon::inject_control_wedge large_endpoint_inject_to_a_no_binary_session_spools_promptly_without_wedging PASS [ 12.314s] (157/239) spt-daemon::inject_control_wedge p0_paste_wedge_parked_write_does_not_starve_attach_or_wedge_broker PASS [ 1.232s] (158/239) spt-daemon::inject_control_wedge parked_message_to_already_idle_endpoint_is_delivered_without_a_poke PASS [ 1.416s] (159/239) spt-daemon::inject_control_wedge w5_a1_locally_driven_session_reports_controller_by_none PASS [ 5.236s] (160/239) spt-daemon::inject_control_wedge w5_a2_abandoned_remote_controller_conn_close_eviction_is_platform_divergent PASS [ 0.474s] (161/239) spt-daemon::inject_control_wedge w5a_bigmultiline_inject_arrives_byte_complete_across_a_loop PASS [ 3.096s] (162/239) spt-daemon::inject_control_wedge w5a_forced_echo_miss_redrives_once_then_loud_spools PASS [ 12.903s] (163/239) spt-daemon::inject_control_wedge wan_arrival_to_idle_spt_hosted_injects_with_no_hook_poll PASS [ 2.575s] (164/239) spt-daemon::input_ack_deadlock input_flood_through_serve_attach_does_not_deadlock_broker PASS [ 8.549s] (165/239) spt-daemon::mesh_recovery a_dead_roster_address_does_not_strand_the_peer_from_discovery PASS [ 0.373s] (166/239) spt-daemon::mesh_recovery a_frozen_self_row_heals_at_boot_and_readvertises_the_live_address PASS [ 1.661s] (167/239) spt-daemon::mesh_recovery health_degrades_during_all_peer_failure_and_recovers_on_real_progress PASS [ 8.053s] (168/239) spt-daemon::mesh_recovery poison_cache_row_is_repaired_from_the_roster_at_startup PASS [ 9.606s] (169/239) spt-daemon::mesh_recovery roster_route_survives_a_transient_dial_failure_with_discovery_disabled PASS [ 2.663s] (170/239) spt-daemon::net_worker_starve dead_peer_dial_burst_vs_net_runtime_canary PASS [ 2.643s] (171/239) spt-daemon::net_worker_starve unreachable_peer_dial_burst_vs_net_runtime_canary PASS [ 0.710s] (172/239) spt-daemon::redispatch finished_historical_attach_neither_takes_nor_clears_current_controller PASS [ 1.975s] (173/239) spt-daemon::redispatch finished_pending_sync_request_still_serves_across_generation_start PASS [ 4.222s] (174/239) spt-daemon::redispatch finished_unretired_attach_is_skipped_and_drained_not_replayed PASS [ 1.258s] (175/239) spt-daemon::redispatch opener_evicted_active_stream_resumes_after_dispatcher_restart PASS [ 2.351s] (176/239) spt-daemon::redispatch transient_worker_start_failure_recovers_via_claim_retry PASS [ 0.188s] (177/239) spt-daemon::redispatch_stall old_broker_unknown_verb_answer_falls_back_to_the_peek_and_serves_real_traffic PASS [ 5.180s] (178/239) spt-daemon::redispatch_stall opener_transient_is_bounded_requeue_never_a_peek_subscriber PASS [ 1.997s] (179/239) spt-daemon::redispatch_stall poisoned_subscriber_cancels_the_paired_forwarding_leg_then_recovery_serves PASS [ 10.955s] (180/239) spt-daemon::redispatch_stall seat_blocked_failure_trips_the_breaker_and_the_stream_recovers PASS [ 2.664s] (181/239) spt-daemon::redispatch_stall stale_unfinished_attach_replay_neither_takes_nor_clears_the_replacement_controller PASS [ 2.520s] (182/239) spt-daemon::redispatch_stall wedged_subscriber_never_stalls_the_producer_and_recovery_replays_gapless PASS [ 1.530s] (183/239) spt-daemon::registry_lifecycle multichunk_feed_applies_with_exactly_one_snapshot_write PASS [ 15.232s] (184/239) spt-daemon::registry_lifecycle oneway_rounds_plateau_rows_seats_and_a_refresh_replays_nothing PASS [ 15.188s] (185/239) spt-daemon::registry_lifecycle poisoned_registry_replay_strikes_out_terminal_while_fresh_feeds_serve PASS [ 0.651s] (186/239) spt-daemon::render_lifecycle final_output_frame_precedes_exit_through_the_production_path PASS [ 4.842s] (187/239) spt-daemon::resize_geometry_epoch a_real_conpty_grow_repaints_cell_for_cell_like_an_independent_authority PASS [ 4.288s] (188/239) spt-daemon::resize_geometry_epoch a_real_conpty_shrink_repaints_cell_for_cell_like_an_independent_authority PASS [ 10.287s] (189/239) spt-daemon::resize_presentation_barrier a_controller_resuming_across_the_transition_gets_the_repaint_never_raw PASS [ 7.429s] (190/239) spt-daemon::resize_presentation_barrier a_live_controller_and_viewer_across_a_shrink_see_one_sync_frame_never_mixed_geometry PASS [ 10.427s] (191/239) spt-daemon::restart_replay_lifetime a_raw_dead_connection_bound_opener_is_not_re_served_by_the_next_generation PASS [ 2.643s] (192/239) spt-daemon::resume cold_start_resumes_all_sessions_from_the_broker_cursor PASS [ 5.088s] (193/239) spt-daemon::resume resume_below_ring_floor_clamps_forward_without_gap_error PASS [ 3.250s] (194/239) spt-daemon::resume resume_mode_brain_spawning_new_sessions_delivers_each PASS [ 3.747s] (195/239) spt-daemon::shellchan failed_brokered_publication_retires_only_the_new_session PASS [ 0.996s] (196/239) spt-daemon::shellchan hung_shell_stalls_no_other_owner PASS [ 0.361s] (197/239) spt-daemon::shellchan stdin_receipt_delivers_spooled_frames_exactly_once PASS [ 0.111s] (198/239) spt-daemon::spawn_truth concurrent_fresh_race_yields_one_created_one_conflict PASS [ 0.304s] (199/239) spt-daemon::spawn_truth fresh_create_over_offline_raw_active_stale_ledger_creates PASS [ 0.102s] (200/239) spt-daemon::spawn_truth fresh_over_live_is_a_typed_conflict_and_touches_nothing PASS [ 0.108s] (201/239) spt-daemon::spawn_truth mixed_fresh_resume_race_never_two_children PASS [ 0.195s] (202/239) spt-daemon::spawn_truth n1_broker_unknown_kind_fails_loud_never_created PASS [ 6.706s] (203/239) spt-daemon::spawn_truth windows_run_never_refuses_over_a_dead_root_the_broker_holds_a_handle_to PASS [ 0.699s] (204/239) spt-daemon::spawn_truth zombie_client_tree_is_reaped_and_run_succeeds_honestly SLOW [> 60.000s] (───────) spt-daemon::transport_death_eof transport_death_without_a_fin_surfaces_eof_to_the_serving_worker PASS [ 68.364s] (205/239) spt-daemon::transport_death_eof transport_death_without_a_fin_surfaces_eof_to_the_serving_worker PASS [ 0.382s] (206/239) spt-daemon::two_origin_spanning digest_span_supersedes_a_replayed_generation PASS [ 0.181s] (207/239) spt-daemon::two_origin_spanning one_source_two_consumers_spans_and_merges PASS [ 0.016s] (208/239) spt-daemon::twohost b2_attacher_child PASS [ 0.015s] (209/239) spt-daemon::twohost two_host_ladder_role_a PASS [ 0.028s] (210/239) spt-daemon::twohost two_host_ladder_role_b PASS [ 0.035s] (211/239) spt-daemon::twohost_web two_host_inbound_probe_role_a PASS [ 0.022s] (212/239) spt-daemon::twohost_web two_host_inbound_probe_role_b PASS [ 0.228s] (213/239) spt-daemon::twohost_web two_host_web_deny_role_a PASS [ 0.018s] (214/239) spt-daemon::twohost_web two_host_web_fetch_role_a PASS [ 0.018s] (215/239) spt-daemon::twohost_web two_host_web_helper_role_a PASS [ 0.017s] (216/239) spt-daemon::twohost_web two_host_web_range_role_a PASS [ 0.015s] (217/239) spt-daemon::twohost_web two_host_web_role_b PASS [ 5.040s] (218/239) spt-term::capture_vehicle_fidelity the_replay_vehicle_is_cell_transparent_with_dnar PASS [ 5.036s] (219/239) spt-term::capture_vehicle_fidelity the_stock_console_vehicle_manufactures_the_field_string PASS [ 1.416s] (220/239) spt-term::dsr conpty_output_not_withheld_under_the_drain PASS [ 0.109s] (221/239) spt-term::dsr drain_forwards_child_output PASS [ 0.069s] (222/239) spt-term::inject ctrl_c_interrupts_the_child PASS [ 0.278s] (223/239) spt-term::inject send_line_reaches_child_and_preserves_order PASS [ 0.022s] (224/239) spt-term::rc_console_newline_presentation a_bare_lf_is_an_index_in_a_spec_vt PASS [ 4.220s] (225/239) spt-term::rc_console_newline_presentation rc_console_mode_today_column_resets_a_bare_lf PASS [ 3.035s] (226/239) spt-term::rc_console_newline_presentation rc_console_mode_with_dnar_presents_what_the_emitter_addressed PASS [ 0.462s] (227/239) spt-term::resize_console_mode_integrity a_surface_resize_does_not_alter_the_hosted_console_input_mode PASS [ 0.209s] (228/239) spt-term::resize_console_mode_integrity the_probe_report_parses_out_of_a_re_rendered_stream PASS [ 0.198s] (229/239) spt-term::resize_console_mode_integrity the_rig_detects_a_seeded_console_input_mode_change PASS [ 0.529s] (230/239) spt-term::resize_console_mode_integrity typed_bytes_do_not_echo_back_as_output_after_a_resize PASS [ 0.101s] (231/239) spt-term::screengrid_width_oracle combining_mark_zero_cell_survives_the_repaint PASS [ 0.036s] (232/239) spt-term::screengrid_width_oracle cup_overwrite_after_wide_glyphs_lands_on_the_same_cells PASS [ 0.238s] (233/239) spt-term::screengrid_width_oracle el_cleared_overflow_row_stays_blank_after_repaint PASS [ 0.011s] (234/239) spt-term::screengrid_width_oracle ich_dch_erase_across_a_wide_half_leave_no_orphans PASS [ 0.010s] (235/239) spt-term::screengrid_width_oracle wide_glyph_at_the_margin_fits_exactly_or_wraps_whole PASS [ 1.048s] (236/239) spt-term::stream bounded_backpressure_stalls_an_unconsumed_reader PASS [ 0.343s] (237/239) spt-term::stream delivers_every_value_under_resize PASS [ 0.470s] (238/239) spt-term::surface resize_under_load_does_not_hang_or_panic PASS [ 0.492s] (239/239) spt-term::winspawn pty_spawns_a_cmd_script_via_cmd_wrap ──────────── Summary [1249.828s] 239 tests run: 237 passed (1 slow), 2 failed, 0 skipped FAIL [ 79.834s] ( 38/239) spt::er_briefing_presented_e2e the_engine_room_briefing_is_presented_before_the_first_actionable_turn FAIL [ 5.297s] (148/239) spt-daemon::inject_control_wedge c1_strike_fault_stamps_perch_and_bounded_respawns_then_gives_up error: test run failed