[INFO] fetching crate unified-agent-sdk 0.1.0...
[INFO] testing unified-agent-sdk-0.1.0 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-1
[INFO] extracting crate unified-agent-sdk 0.1.0 into /workspace/builds/worker-0-tc2/source
[INFO] started tweaking crates.io crate unified-agent-sdk 0.1.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate unified-agent-sdk 0.1.0
[INFO] tweaked toml for crates.io crate unified-agent-sdk 0.1.0 written to /workspace/builds/worker-0-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate unified-agent-sdk 0.1.0 on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate unified-agent-sdk 0.1.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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] c3dbe64a1014da25c011aaef051bb750bdd708b245a86d8c50ff24d0dfc832c0
[INFO] running `Command { std: "docker" "start" "-a" "c3dbe64a1014da25c011aaef051bb750bdd708b245a86d8c50ff24d0dfc832c0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c3dbe64a1014da25c011aaef051bb750bdd708b245a86d8c50ff24d0dfc832c0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c3dbe64a1014da25c011aaef051bb750bdd708b245a86d8c50ff24d0dfc832c0", kill_on_drop: false }`
[INFO] [stdout] c3dbe64a1014da25c011aaef051bb750bdd708b245a86d8c50ff24d0dfc832c0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a7f69c4f8b337f4ca6a170564ca325ad360ca09d48cb44d8c456c53d5fb9d8a2
[INFO] running `Command { std: "docker" "start" "-a" "a7f69c4f8b337f4ca6a170564ca325ad360ca09d48cb44d8c456c53d5fb9d8a2", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.182
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling futures-channel v0.3.32
[INFO] [stderr]    Compiling env_home v0.1.0
[INFO] [stderr]    Compiling nix v0.31.2
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling which v8.0.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling socket2 v0.6.2
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling getrandom v0.4.1
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling tempfile v3.26.0
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling async-stream-impl v0.3.6
[INFO] [stderr]    Compiling pin-project-internal v1.1.11
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling async-stream v0.3.6
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling pin-project v1.1.11
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling claude-code-client-sdk v0.1.46
[INFO] [stderr]    Compiling codex-client-sdk v0.107.0
[INFO] [stderr]    Compiling unified-agent-sdk v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 26.32s
[INFO] running `Command { std: "docker" "inspect" "a7f69c4f8b337f4ca6a170564ca325ad360ca09d48cb44d8c456c53d5fb9d8a2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a7f69c4f8b337f4ca6a170564ca325ad360ca09d48cb44d8c456c53d5fb9d8a2", kill_on_drop: false }`
[INFO] [stdout] a7f69c4f8b337f4ca6a170564ca325ad360ca09d48cb44d8c456c53d5fb9d8a2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 41d9cfa75a6c22498c9db93c82a5ae4a163f3dbcd0fb909c2289b0cef89e544d
[INFO] running `Command { std: "docker" "start" "-a" "41d9cfa75a6c22498c9db93c82a5ae4a163f3dbcd0fb909c2289b0cef89e544d", kill_on_drop: false }`
[INFO] [stderr]    Compiling unified-agent-sdk v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 4.17s
[INFO] running `Command { std: "docker" "inspect" "41d9cfa75a6c22498c9db93c82a5ae4a163f3dbcd0fb909c2289b0cef89e544d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "41d9cfa75a6c22498c9db93c82a5ae4a163f3dbcd0fb909c2289b0cef89e544d", kill_on_drop: false }`
[INFO] [stdout] 41d9cfa75a6c22498c9db93c82a5ae4a163f3dbcd0fb909c2289b0cef89e544d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3549a3684b8d3ba70c29ea7788c71287916555812c5d1f5a006b147c88a15634
[INFO] running `Command { std: "docker" "start" "-a" "3549a3684b8d3ba70c29ea7788c71287916555812c5d1f5a006b147c88a15634", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.17s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/unified_agent_sdk-c16ce2ff3a873a8b)
[INFO] [stdout] 
[INFO] [stdout] running 43 tests
[INFO] [stdout] test event::converter::tests::converts_message_log_for_stream_pipeline ... ok
[INFO] [stdout] test event::converter::tests::converts_tool_call_by_status_for_stream_pipeline ... ok
[INFO] [stdout] test event::converter::tests::ignores_tool_call_running_state_in_one_to_one_converter ... ok
[INFO] [stdout] test event::converter::tests::maps_error_consistently_across_conversion_helpers ... ok
[INFO] [stdout] test event::converter::tests::maps_tool_call_status_to_expected_events ... ok
[INFO] [stdout] test event::converter::tests::token_usage_fans_out_context_usage_with_provider_limit ... ok
[INFO] [stdout] test event::converter::tests::token_usage_uses_context_window_override_when_limit_unknown ... ok
[INFO] [stdout] test event::converter::tests::preserves_string_payloads_for_failed_tool_calls ... ok
[INFO] [stdout] test event::converter::tests::zero_context_window_override_is_treated_as_unknown ... ok
[INFO] [stdout] test event::converter::tests::maps_message_to_message_received ... ok
[INFO] [stdout] test event::tests::trigger_executes_hooks_concurrently ... ok
[INFO] [stdout] test providers::claude_code::executor::tests::query_success_check_rejects_error_result_messages ... ok
[INFO] [stdout] test profile::tests::parse_models_output_skips_plain_text_headers ... ok
[INFO] [stdout] test profile::tests::parse_models_output_accepts_inline_label_format ... ok
[INFO] [stdout] test providers::claude_code::normalizer::tests::extracts_limit_when_explicitly_present ... ok
[INFO] [stdout] test providers::claude_code::normalizer::tests::flush_emits_error_for_incomplete_json ... ok
[INFO] [stdout] test providers::claude_code::normalizer::tests::normalizes_claude_stream_incrementally ... ok
[INFO] [stdout] test providers::claude_code::normalizer::tests::flush_clears_pending_tool_calls ... ok
[INFO] [stdout] test providers::claude_code::normalizer::tests::extracts_max_tokens_when_limit_is_absent ... ok
[INFO] [stdout] test providers::claude_code::executor::tests::fallback_session_ids_are_unique ... ok
[INFO] [stdout] test providers::claude_code::normalizer::tests::numeric_usage_keeps_unknown_limit ... ok
[INFO] [stdout] test providers::codex::normalizer::tests::normalize_is_incremental ... ok
[INFO] [stdout] test providers::claude_code::normalizer::tests::ignores_whitespace_only_user_text_blocks ... ok
[INFO] [stdout] test providers::claude_code::normalizer::tests::invalid_utf8_is_reported_as_error_log ... ok
[INFO] [stdout] test providers::claude_code::executor::tests::query_success_check_rejects_missing_result_messages ... ok
[INFO] [stdout] test providers::claude_code::executor::tests::query_success_check_accepts_success_result_messages ... ok
[INFO] [stdout] test providers::claude_code::normalizer::tests::numeric_zero_usage_is_suppressed ... ok
[INFO] [stdout] test providers::claude_code::executor::tests::resolve_cli_path_accepts_executable_file_override ... ok
[INFO] [stdout] test providers::claude_code::executor::tests::resolve_cli_path_rejects_directory_override ... ok
[INFO] [stdout] test providers::codex::normalizer::tests::maps_required_codex_items ... ok
[INFO] [stdout] test providers::codex::normalizer::tests::flush_processes_trailing_data ... ok
[INFO] [stdout] test session::tests::wait_defaults_to_completed_success_when_unmanaged ... ok
[INFO] [stdout] test session::tests::session_event_stream_marks_completion_as_failed_when_errors_seen ... ok
[INFO] [stdout] test session::tests::session_event_stream_builds_pipeline_and_triggers_hooks ... ok
[INFO] [stdout] test session::tests::cancel_delegates_to_registered_lifecycle_controller ... ok
[INFO] [stdout] test session::tests::session_event_stream_applies_context_window_override ... ok
[INFO] [stdout] test session::tests::wait_uses_session_lifecycle_controller ... ok
[INFO] [stdout] test providers::codex::profile::tests::finds_codex_in_home_global_locations ... ok
[INFO] [stdout] test profile::tests::resolve_uses_discovered_reasoning_when_models_are_unavailable ... ok
[INFO] [stdout] test profile::tests::resolve_applies_runtime_overrides ... ok
[INFO] [stdout] test providers::codex::profile::tests::finds_codex_in_ancestor_node_modules_bin ... ok
[INFO] [stdout] test profile::tests::load_merges_default_and_variant_profiles ... ok
[INFO] [stderr]      Running tests/event_flow_integration_tests.rs (/opt/rustwide/target/debug/deps/event_flow_integration_tests-f46233984eba7100)
[INFO] [stderr]    Doc-tests unified_agent_sdk
[INFO] [stdout] test profile::tests::load_auto_reloads_when_profile_file_changes ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 43 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.11s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test codex_pipeline_marks_session_failed_on_error_event ... ok
[INFO] [stdout] test claude_pipeline_marks_session_failed_on_malformed_input ... ok
[INFO] [stdout] test codex_pipeline_emits_successful_event_flow ... ok
[INFO] [stdout] test claude_pipeline_emits_message_and_usage_events ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test src/lib.rs - (line 26) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 53) - compile ... ok
[INFO] [stdout] test src/event.rs - event::HookManager::trigger (line 173) ... ok
[INFO] [stdout] test src/profile.rs - profile::ProfileManager::resolve (line 208) - compile ... ok
[INFO] [stdout] test src/providers/claude_code/executor.rs - providers::claude_code::executor::ClaudeCodeExecutor (line 29) - compile ... ok
[INFO] [stdout] test src/providers/codex/executor.rs - providers::codex::executor::CodexExecutor (line 20) - compile ... ok
[INFO] [stdout] test src/profile.rs - profile::parse_models_output (line 479) ... ok
[INFO] [stdout] test src/lib.rs - (line 76) - compile ... ok
[INFO] [stdout] test src/executor.rs - executor::SpawnConfig (line 48) ... ok
[INFO] [stdout] test src/session.rs - session::AgentSession::event_stream (line 133) ... ok
[INFO] [stdout] test src/profile.rs - profile::parse_reasoning_output (line 515) ... ok
[INFO] [stdout] test src/types.rs - types::ContextUsage (line 78) ... ok
[INFO] [stdout] test src/executor.rs - executor::AgentExecutor (line 82) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 1.40s; merged doctests compilation took 1.34s
[INFO] running `Command { std: "docker" "inspect" "3549a3684b8d3ba70c29ea7788c71287916555812c5d1f5a006b147c88a15634", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3549a3684b8d3ba70c29ea7788c71287916555812c5d1f5a006b147c88a15634", kill_on_drop: false }`
[INFO] [stdout] 3549a3684b8d3ba70c29ea7788c71287916555812c5d1f5a006b147c88a15634