[INFO] fetching crate deliberate-mcp 0.3.0...
[INFO] testing deliberate-mcp-0.3.0 against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate deliberate-mcp 0.3.0 into /workspace/builds/worker-5-tc2/source
[INFO] started tweaking crates.io crate deliberate-mcp 0.3.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate deliberate-mcp 0.3.0
[INFO] tweaked toml for crates.io crate deliberate-mcp 0.3.0 written to /workspace/builds/worker-5-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate deliberate-mcp 0.3.0 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate deliberate-mcp 0.3.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:68:12
[INFO] [stderr]    |
[INFO] [stderr] 68 | homepage = "https://github.com/AlrikOlson/think-and-ship"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 73 | repository = "https://github.com/AlrikOlson/think-and-ship"
[INFO] [stderr]    |              ----------------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `deliberate-mcp` (manifest) generated 1 warning
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 6255899c35f33eadae6b91e6f34ad9b51b118a5eeb2471f64253efe8bf154459
[INFO] running `Command { std: "docker" "start" "6255899c35f33eadae6b91e6f34ad9b51b118a5eeb2471f64253efe8bf154459", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "6255899c35f33eadae6b91e6f34ad9b51b118a5eeb2471f64253efe8bf154459", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "6255899c35f33eadae6b91e6f34ad9b51b118a5eeb2471f64253efe8bf154459" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "6255899c35f33eadae6b91e6f34ad9b51b118a5eeb2471f64253efe8bf154459", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "6255899c35f33eadae6b91e6f34ad9b51b118a5eeb2471f64253efe8bf154459" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:68:12
[INFO] [stderr]    |
[INFO] [stderr] 68 | homepage = "https://github.com/AlrikOlson/think-and-ship"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 73 | repository = "https://github.com/AlrikOlson/think-and-ship"
[INFO] [stderr]    |              ----------------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `deliberate-mcp` (manifest) generated 1 warning
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling quote v1.0.45
[INFO] [stderr]    Compiling unicode-ident v1.0.24
[INFO] [stderr]    Compiling libc v0.2.186
[INFO] [stderr]    Compiling zmij v1.0.21
[INFO] [stderr]    Compiling pin-project-lite v0.2.17
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling autocfg v1.5.1
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling futures-sink v0.3.32
[INFO] [stderr]    Compiling futures-core v0.3.32
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling ident_case v1.0.1
[INFO] [stderr]    Compiling serde_json v1.0.150
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling futures-channel v0.3.32
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling futures-io v0.3.32
[INFO] [stderr]    Compiling futures-task v0.3.32
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling ref-cast v1.0.25
[INFO] [stderr]    Compiling itoa v1.0.18
[INFO] [stderr]    Compiling iana-time-zone v0.1.65
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling bytes v1.11.1
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling dyn-clone v1.0.20
[INFO] [stderr]    Compiling rmcp v1.7.0
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling owo-colors v4.3.0
[INFO] [stderr]    Compiling anyhow v1.0.102
[INFO] [stderr]    Compiling log v0.4.30
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling pastey v0.2.3
[INFO] [stderr]    Compiling nu-ansi-term v0.50.3
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling mio v1.2.0
[INFO] [stderr]    Compiling uuid v1.23.1
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling darling_core v0.23.0
[INFO] [stderr]    Compiling serde_derive_internals v0.29.1
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling tokio-macros v2.7.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling ref-cast-impl v1.0.25
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling schemars_derive v1.2.1
[INFO] [stderr]    Compiling tokio v1.52.3
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling tracing-subscriber v0.3.23
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling think-and-ship-core v0.1.0
[INFO] [stderr]    Compiling darling_macro v0.23.0
[INFO] [stderr]    Compiling darling v0.23.0
[INFO] [stderr]    Compiling rmcp-macros v1.7.0
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling schemars v1.2.1
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling deliberate-mcp v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr] warning: unused dependency `uuid`
[INFO] [stderr]   --> Cargo.toml:44:15
[INFO] [stderr]    |
[INFO] [stderr] 44 | [dependencies.uuid]
[INFO] [stderr]    |               ^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::unused_dependencies` is set to `warn` by default
[INFO] [stderr] help: consider removing the dependency on `uuid`
[INFO] [stderr] warning: `deliberate-mcp` (manifest) generated 1 warning
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1m 50s
[INFO] running `Command { std: "docker" "inspect" "6255899c35f33eadae6b91e6f34ad9b51b118a5eeb2471f64253efe8bf154459", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "6255899c35f33eadae6b91e6f34ad9b51b118a5eeb2471f64253efe8bf154459" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:68:12
[INFO] [stderr]    |
[INFO] [stderr] 68 | homepage = "https://github.com/AlrikOlson/think-and-ship"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 73 | repository = "https://github.com/AlrikOlson/think-and-ship"
[INFO] [stderr]    |              ----------------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `deliberate-mcp` (manifest) generated 1 warning
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling bitflags v2.11.1
[INFO] [stderr]    Compiling diff v0.1.13
[INFO] [stderr]    Compiling fastrand v2.4.1
[INFO] [stderr]    Compiling yansi v1.0.1
[INFO] [stderr]    Compiling pretty_assertions v1.4.1
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling deliberate-mcp v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr] warning: unused dependency `uuid`
[INFO] [stderr]   --> Cargo.toml:44:15
[INFO] [stderr]    |
[INFO] [stderr] 44 | [dependencies.uuid]
[INFO] [stderr]    |               ^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::unused_dependencies` is set to `warn` by default
[INFO] [stderr] help: consider removing the dependency on `uuid`
[INFO] [stderr] warning: `deliberate-mcp` (manifest) generated 1 warning
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1m 04s
[INFO] running `Command { std: "docker" "inspect" "6255899c35f33eadae6b91e6f34ad9b51b118a5eeb2471f64253efe8bf154459", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "6255899c35f33eadae6b91e6f34ad9b51b118a5eeb2471f64253efe8bf154459" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:68:12
[INFO] [stderr]    |
[INFO] [stderr] 68 | homepage = "https://github.com/AlrikOlson/think-and-ship"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 73 | repository = "https://github.com/AlrikOlson/think-and-ship"
[INFO] [stderr]    |              ----------------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `deliberate-mcp` (manifest) generated 1 warning
[INFO] [stderr] warning: unused dependency `uuid`
[INFO] [stderr]   --> Cargo.toml:44:15
[INFO] [stderr]    |
[INFO] [stderr] 44 | [dependencies.uuid]
[INFO] [stderr]    |               ^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::unused_dependencies` is set to `warn` by default
[INFO] [stderr] help: consider removing the dependency on `uuid`
[INFO] [stderr] warning: `deliberate-mcp` (manifest) generated 1 warning
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.28s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/build/deliberate-mcp/2177a66d023995c4/out/deliberate_mcp-2177a66d023995c4)
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/release/build/deliberate-mcp/73671e1dfa305cce/out/deliberate_mcp-73671e1dfa305cce)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running tests/broadcast.rs (/opt/rustwide/target/release/build/deliberate-mcp/2152e03fa4140766/out/broadcast-2152e03fa4140766)
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test broadcast_bind_failure_does_not_block_step ... ok
[INFO] [stdout] test broadcast_emits_step_appended_and_revised ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/config.rs (/opt/rustwide/target/release/build/deliberate-mcp/640b2d0e976c27d6/out/config-640b2d0e976c27d6)
[INFO] [stdout] 
[INFO] [stdout] running 36 tests
[INFO] [stdout] test auto_session_id_is_identical_across_load_config_calls ... ok
[INFO] [stdout] test auto_session_id_falls_back_when_project_name_is_empty ... ok
[INFO] [stdout] test default_system_values ... ok
[INFO] [stdout] test enable_sessions_alone_now_produces_default_session_id ... ok
[INFO] [stdout] test load_config_with_no_env_matches_default ... ok
[INFO] [stdout] test colors_enabled_by_default ... ok
[INFO] [stdout] test max_branch_depth_from_env ... ok
[INFO] [stdout] test max_history_size_large_value ... ok
[INFO] [stdout] test max_history_size_nan_falls_back_to_default ... ok
[INFO] [stdout] test max_history_size_negative_falls_back_to_default ... ok
[INFO] [stdout] test default_sessions_disabled ... ok
[INFO] [stdout] test namespace_session_id_clamps_to_128 ... ok
[INFO] [stdout] test namespace_session_id_empty_returns_bare_project ... ok
[INFO] [stdout] test namespace_session_id_prefixes_bare_custom_name ... ok
[INFO] [stdout] test output_format_invalid_falls_back_to_console ... ok
[INFO] [stdout] test no_color_disables_colors ... ok
[INFO] [stdout] test output_format_case_insensitive ... ok
[INFO] [stdout] test namespace_session_id_passes_legacy_rotation_through ... ok
[INFO] [stdout] test output_format_json ... ok
[INFO] [stdout] test sessions_disabled_when_unset ... ok
[INFO] [stdout] test max_history_size_from_env ... ok
[INFO] [stdout] test sessions_enabled_via_env ... ok
[INFO] [stdout] test strict_mode_false_keeps_flexible ... ok
[INFO] [stdout] test output_format_console ... ok
[INFO] [stdout] test sessions_false_keeps_disabled ... ok
[INFO] [stdout] test strict_mode_enables_all_strict_validations ... ok
[INFO] [stdout] test output_format_markdown ... ok
[INFO] [stdout] test session_timeout_from_env ... ok
[INFO] [stdout] test multiple_env_vars_compose ... ok
[INFO] [stdout] test default_config_is_flexible ... ok
[INFO] [stdout] test namespace_session_id_leaves_bare_project_alone ... ok
[INFO] [stdout] test namespace_session_id_is_idempotent_on_namespaced_input ... ok
[INFO] [stdout] test default_features_enabled ... ok
[INFO] [stdout] test auto_session_id_is_stable_basename_plus_path_hash ... ok
[INFO] [stdout] test max_history_size_zero_falls_back_to_default ... ok
[INFO] [stdout] test auto_session_id_honors_explicit_project_name_env ... ok
[INFO] [stderr]      Running tests/formatter.rs (/opt/rustwide/target/release/build/deliberate-mcp/b49f8e02c3d3d94b/out/formatter-b49f8e02c3d3d94b)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 36 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 29 tests
[INFO] [stdout] test console_formats_structured_action ... ok
[INFO] [stdout] test console_handles_all_purpose_types ... ok
[INFO] [stdout] test branch_tree_shows_branches ... ok
[INFO] [stdout] test console_basic_no_color ... ok
[INFO] [stdout] test history_summary_branches_listed ... ok
[INFO] [stdout] test color_disabled_emits_no_ansi ... ok
[INFO] [stdout] test branch_tree_shows_main_steps ... ok
[INFO] [stdout] test history_summary_completed ... ok
[INFO] [stdout] test color_enabled_still_carries_content ... ok
[INFO] [stdout] test history_summary_metadata ... ok
[INFO] [stdout] test json_includes_optional_fields ... ok
[INFO] [stdout] test json_is_valid ... ok
[INFO] [stdout] test history_summary_basic ... ok
[INFO] [stdout] test console_shows_dependencies ... ok
[INFO] [stdout] test console_handles_custom_purpose ... ok
[INFO] [stdout] test history_summary_branch_status_symbols ... ok
[INFO] [stdout] test console_includes_confidence_percentage ... ok
[INFO] [stdout] test markdown_basic ... ok
[INFO] [stdout] test markdown_uncertainty_blockquote ... ok
[INFO] [stdout] test markdown_branch_badge ... ok
[INFO] [stdout] test console_shows_revision_info ... ok
[INFO] [stdout] test markdown_revises_badge ... ok
[INFO] [stdout] test markdown_revision_reason_blockquote ... ok
[INFO] [stdout] test markdown_tools_used ... ok
[INFO] [stdout] test history_summary_average_confidence ... ok
[INFO] [stdout] test markdown_confidence_badge ... ok
[INFO] [stdout] test console_shows_tools_used ... ok
[INFO] [stderr]      Running tests/mcp_schema.rs (/opt/rustwide/target/release/build/deliberate-mcp/75da4ba5b3e2e52a/out/mcp_schema-75da4ba5b3e2e52a)
[INFO] [stdout] test console_shows_branch_info ... ok
[INFO] [stdout] test console_shows_uncertainty ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stderr]      Running tests/server.rs (/opt/rustwide/target/release/build/deliberate-mcp/7660dfcba317f6c8/out/server-7660dfcba317f6c8)
[INFO] [stdout] test tools_list_attaches_output_schema_to_json_returning_tools ... ok
[INFO] [stdout] test get_step_call_returns_structured_step ... ok
[INFO] [stdout] test tool_renames_old_names_removed ... ok
[INFO] [stdout] test get_step_missing_emits_structured_error_envelope ... ok
[INFO] [stdout] test revise_estimate_call_returns_structured ... ok
[INFO] [stdout] test record_step_call_returns_structured_content ... ok
[INFO] [stdout] test pin_step_call_returns_structured ... ok
[INFO] [stdout] test export_trace_returns_text_no_structured_content ... ok
[INFO] [stdout] test trace_checkpoint_call_returns_structured ... ok
[INFO] [stdout] test wipe_trace_call_returns_structured_and_clears ... ok
[INFO] [stdout] test engine_status_call_returns_structured_content ... ok
[INFO] [stdout] test tools_list_carries_hints ... ok
[INFO] [stdout] test tools_list_carries_annotations ... ok
[INFO] [stdout] test tool_descriptions_carry_pitfalls_marker ... ok
[INFO] [stdout] test step_impact_call_returns_structured ... ok
[INFO] [stdout] test search_trace_call_returns_structured ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 110 tests
[INFO] [stdout] test accept_confidence_at_boundaries ... ok
[INFO] [stdout] test already_namespaced_session_id_is_not_double_prefixed ... ok
[INFO] [stdout] test branch_created_from_existing_step ... ok
[INFO] [stdout] test branch_from_self_rejected ... ok
[INFO] [stdout] test complex_multi_feature_step ... ok
[INFO] [stdout] test branch_disabled_creates_no_branch ... ok
[INFO] [stdout] test branches_summary_lists_each_active_branch ... ok
[INFO] [stdout] test confidence_infinity_rejected ... ok
[INFO] [stdout] test confidence_neg_infinity_rejected ... ok
[INFO] [stdout] test bare_u32_deps_still_deserialize ... ok
[INFO] [stdout] test constructor_starts_with_empty_history ... ok
[INFO] [stdout] test default_session_id_is_applied_when_caller_omits_one ... ok
[INFO] [stdout] test confidence_surfaces_in_recent_steps_not_top_level ... ok
[INFO] [stdout] test dependencies_missing_warns_but_continues ... ok
[INFO] [stdout] test dependencies_none_passes ... ok
[INFO] [stdout] test duplicate_step_number_is_allowed_when_revising ... ok
[INFO] [stdout] test confidence_nan_rejected ... ok
[INFO] [stdout] test duplicate_step_number_in_persistent_session_returns_actionable_error ... ok
[INFO] [stdout] test dependencies_future_is_invalid_error ... ok
[INFO] [stdout] test dependencies_satisfied_when_steps_exist ... ok
[INFO] [stdout] test branch_from_nonexistent_step_rejected ... ok
[INFO] [stdout] test execution_ref_stored_and_searchable ... ok
[INFO] [stdout] test dependencies_self_is_circular_error ... ok
[INFO] [stdout] test checkpoint_snapshot_flags_open_hypothesis_and_stale_branch ... ok
[INFO] [stdout] test expired_sessions_cleaned_up_on_force ... ok
[INFO] [stdout] test extract_tools_from_structured_action ... ok
[INFO] [stdout] test extract_tools_from_tools_used ... ok
[INFO] [stdout] test export_json_default ... ok
[INFO] [stdout] test empty_required_fields_without_xml_injection_gets_plain_error ... ok
[INFO] [stdout] test execution_ref_absent_when_not_set ... ok
[INFO] [stdout] test explicit_session_id_beats_default ... ok
[INFO] [stdout] test export_markdown ... ok
[INFO] [stdout] test extract_tools_combines_and_dedupes ... ok
[INFO] [stdout] test impact_partitions_downstream_by_relation ... ok
[INFO] [stdout] test extract_tools_empty_when_none ... ok
[INFO] [stdout] test export_console_text ... ok
[INFO] [stdout] test impact_reports_upstream_downstream_and_revision_chain ... ok
[INFO] [stdout] test merged_into_rejects_unknown_step ... ok
[INFO] [stdout] test merged_into_round_trips_through_set_branch_status ... ok
[INFO] [stdout] test impact_returns_empty_revision_chain_when_not_revised ... ok
[INFO] [stdout] test branch_auto_generates_id_and_name ... ok
[INFO] [stdout] test clear_history_resets_state ... ok
[INFO] [stdout] test completion_via_phrase_detection ... ok
[INFO] [stdout] test completion_via_is_final_step ... ok
[INFO] [stdout] test caller_session_id_gets_namespaced_under_project ... ok
[INFO] [stdout] test history_trimmed_when_exceeding_max ... ok
[INFO] [stdout] test branches_summary_response_field_appears_after_branching ... ok
[INFO] [stdout] test purpose_any_when_custom_allowed ... ok
[INFO] [stdout] test impact_errors_on_missing_step ... ok
[INFO] [stdout] test pin_errors_on_unknown_step ... ok
[INFO] [stdout] test process_valid_step ... ok
[INFO] [stdout] test purpose_case_insensitive_in_strict ... ok
[INFO] [stdout] test rationale_passes_when_disabled ... ok
[INFO] [stdout] test rationale_requires_to_prefix_when_enabled ... ok
[INFO] [stdout] test purpose_standard_only_in_strict ... ok
[INFO] [stdout] test recent_steps_carries_rationale_excerpt ... ok
[INFO] [stdout] test recent_steps_limit_is_configurable ... ok
[INFO] [stdout] test persistence_writes_atomically_no_tmp_file_left_behind ... ok
[INFO] [stdout] test refuted_dep_warning_fires ... ok
[INFO] [stdout] test reject_missing_required_fields ... ok
[INFO] [stdout] test reject_step_number_zero ... ok
[INFO] [stdout] test refuting_step_does_not_get_low_confidence_warning ... ok
[INFO] [stdout] test pin_marks_step_and_recent_steps_promotes_it ... ok
[INFO] [stdout] test persistence_clear_removes_disk_files ... ok
[INFO] [stdout] test partial_xml_injection_recovery_errors_only_on_still_missing_fields ... ok
[INFO] [stdout] test reject_confidence_above_1 ... ok
[INFO] [stdout] test response_echoes_thought_and_outcome_excerpts ... ok
[INFO] [stdout] test response_includes_recent_steps_after_second_step ... ok
[INFO] [stdout] test reject_confidence_below_0 ... ok
[INFO] [stdout] test reject_whitespace_only_field ... ok
[INFO] [stdout] test persistence_disabled_writes_nothing ... ok
[INFO] [stdout] test response_warns_on_low_confidence_dependency ... ok
[INFO] [stdout] test response_warns_when_step_exceeds_estimate ... ok
[INFO] [stdout] test revise_estimate_rejects_zero_and_empty_history ... ok
[INFO] [stdout] test persistence_round_trip_default_history ... ok
[INFO] [stdout] test revision_of_future_step_rejected ... ok
[INFO] [stdout] test revision_of_missing_step_is_warning_not_error ... ok
[INFO] [stdout] test revision_marks_original ... ok
[INFO] [stdout] test search_does_not_duplicate_branch_steps ... ok
[INFO] [stdout] test revisions_skipped_when_feature_disabled ... ok
[INFO] [stdout] test pinned_steps_lists_in_step_order ... ok
[INFO] [stdout] test search_finds_matches_across_text_fields ... ok
[INFO] [stdout] test renumber_on_load_is_idempotent_when_no_duplicates ... ok
[INFO] [stdout] test persistence_rejects_unsafe_session_ids ... ok
[INFO] [stdout] test revise_estimate_updates_last_step_in_place ... ok
[INFO] [stdout] test search_is_case_insensitive_and_returns_empty_for_no_query ... ok
[INFO] [stdout] test step_by_number_finds_main_and_branch_steps ... ok
[INFO] [stdout] test sessions_snapshot_marks_active_session ... ok
[INFO] [stdout] test session_created_when_id_provided ... ok
[INFO] [stdout] test step_numbers_unique_across_sessions_in_project ... ok
[INFO] [stdout] test session_metadata_stamps_project_id ... ok
[INFO] [stdout] test set_branch_status_marks_and_validates ... ok
[INFO] [stdout] test renumber_on_load_resolves_cross_session_duplicates ... ok
[INFO] [stdout] test strict_mode_rejects_invalid_thought ... ok
[INFO] [stdout] test tagged_dep_with_relation_round_trips ... ok
[INFO] [stdout] test status_snapshot_reflects_engine_state ... ok
[INFO] [stdout] test latest_revision_walks_full_chain ... ok
[INFO] [stdout] test session_id_with_sessions_disabled_emits_warning ... ok
[INFO] [stdout] test xml_injection_bare_tag_form_recovers_from_thought ... ok
[INFO] [stdout] test session_indexes_rebuilt_on_switch_back ... ok
[INFO] [stdout] test sessions_off_creates_no_sessions ... ok
[INFO] [stdout] test status_verbose_includes_pinned_and_sessions ... ok
[INFO] [stdout] test thought_prefix_accepts_valid_prefixes_in_strict ... ok
[INFO] [stdout] test thought_prefix_rejects_invalid_in_strict ... ok
[INFO] [stdout] test xml_injection_bare_tag_recovers_dependencies_and_branch_fields ... ok
[INFO] [stdout] test thought_prefix_unused_when_disabled ... ok
[INFO] [stdout] test tools_tracked_in_metadata ... ok
[INFO] [stdout] test xml_injection_in_thought_auto_recovers_missing_fields ... ok
[INFO] [stdout] test xml_injection_marker_without_recoverable_payload_still_diagnoses ... ok
[INFO] [stdout] test xml_injection_recovery_only_fills_empty_fields ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 110 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests deliberate_mcp
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "6255899c35f33eadae6b91e6f34ad9b51b118a5eeb2471f64253efe8bf154459", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6255899c35f33eadae6b91e6f34ad9b51b118a5eeb2471f64253efe8bf154459", kill_on_drop: false }`
[INFO] [stdout] 6255899c35f33eadae6b91e6f34ad9b51b118a5eeb2471f64253efe8bf154459
