[INFO] fetching crate mcpi 0.1.8...
[INFO] testing mcpi-0.1.8 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-1
[INFO] extracting crate mcpi 0.1.8 into /workspace/builds/worker-1-tc2/source
[INFO] started tweaking crates.io crate mcpi 0.1.8
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate mcpi 0.1.8
[INFO] tweaked toml for crates.io crate mcpi 0.1.8 written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate mcpi 0.1.8 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 mcpi 0.1.8 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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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] e7439c44b9b934da4ac0155a2608b1339e4dd27b4b10bf43bd8fc47c86d56fdc
[INFO] running `Command { std: "docker" "start" "-a" "e7439c44b9b934da4ac0155a2608b1339e4dd27b4b10bf43bd8fc47c86d56fdc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e7439c44b9b934da4ac0155a2608b1339e4dd27b4b10bf43bd8fc47c86d56fdc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e7439c44b9b934da4ac0155a2608b1339e4dd27b4b10bf43bd8fc47c86d56fdc", kill_on_drop: false }`
[INFO] [stdout] e7439c44b9b934da4ac0155a2608b1339e4dd27b4b10bf43bd8fc47c86d56fdc
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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] 4de33e5258138e17e5096e5134d43ed0ff7ab9ff02fdb85bbdf3b4def11296b2
[INFO] running `Command { std: "docker" "start" "-a" "4de33e5258138e17e5096e5134d43ed0ff7ab9ff02fdb85bbdf3b4def11296b2", kill_on_drop: false }`
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling rustls v0.23.37
[INFO] [stderr]    Compiling anstyle-parse v1.0.0
[INFO] [stderr]    Compiling nix v0.28.0
[INFO] [stderr]    Compiling colorchoice v1.0.5
[INFO] [stderr]    Compiling icu_normalizer v2.1.1
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling webpki-roots v1.0.6
[INFO] [stderr]    Compiling nibble_vec v0.1.0
[INFO] [stderr]    Compiling endian-type v0.1.2
[INFO] [stderr]    Compiling iri-string v0.7.10
[INFO] [stderr]    Compiling dirs-sys v0.4.1
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling clap_derive v4.6.0
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling rustyline-derive v0.10.0
[INFO] [stderr]    Compiling anstream v1.0.0
[INFO] [stderr]    Compiling radix_trie v0.2.1
[INFO] [stderr]    Compiling home v0.5.12
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling colored v2.2.0
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling uuid v1.22.0
[INFO] [stderr]    Compiling dirs v5.0.1
[INFO] [stderr]    Compiling shell-words v1.1.1
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling fd-lock v4.0.4
[INFO] [stderr]    Compiling crossterm v0.29.0
[INFO] [stderr]    Compiling rustyline v14.0.0
[INFO] [stderr]    Compiling clap v4.6.0
[INFO] [stderr]    Compiling comfy-table v7.2.2
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling rustls-webpki v0.103.9
[INFO] [stderr]    Compiling hyper v1.8.1
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling hyper-rustls v0.27.7
[INFO] [stderr]    Compiling reqwest v0.12.28
[INFO] [stderr]    Compiling mcpi v0.1.8 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 32.72s
[INFO] running `Command { std: "docker" "inspect" "4de33e5258138e17e5096e5134d43ed0ff7ab9ff02fdb85bbdf3b4def11296b2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4de33e5258138e17e5096e5134d43ed0ff7ab9ff02fdb85bbdf3b4def11296b2", kill_on_drop: false }`
[INFO] [stdout] 4de33e5258138e17e5096e5134d43ed0ff7ab9ff02fdb85bbdf3b4def11296b2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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] c9952542634382d75286dcca5fc4f932daccf65387217a81c2277ed53686f450
[INFO] running `Command { std: "docker" "start" "-a" "c9952542634382d75286dcca5fc4f932daccf65387217a81c2277ed53686f450", kill_on_drop: false }`
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling hyper v1.8.1
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling hyper-rustls v0.27.7
[INFO] [stderr]    Compiling reqwest v0.12.28
[INFO] [stderr]    Compiling mcpi v0.1.8 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 23.67s
[INFO] running `Command { std: "docker" "inspect" "c9952542634382d75286dcca5fc4f932daccf65387217a81c2277ed53686f450", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c9952542634382d75286dcca5fc4f932daccf65387217a81c2277ed53686f450", kill_on_drop: false }`
[INFO] [stdout] c9952542634382d75286dcca5fc4f932daccf65387217a81c2277ed53686f450
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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] f53082f2de91ef21ff50ebf212cc496cac9fd1c623256c8fab47156d58367fa1
[INFO] running `Command { std: "docker" "start" "-a" "f53082f2de91ef21ff50ebf212cc496cac9fd1c623256c8fab47156d58367fa1", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.29s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/mcpi-adea1653e0164fc9)
[INFO] [stdout] 
[INFO] [stdout] running 46 tests
[INFO] [stdout] test commands::tests::cmd_cap_set_inserts_payload ... ok
[INFO] [stdout] test commands::tests::cmd_set_env_inserts_kv ... ok
[INFO] [stdout] test commands::tests::cmd_set_name_updates_state ... ok
[INFO] [stdout] test commands::tests::cmd_quit_returns_true ... ok
[INFO] [stdout] test commands::tests::cmd_cap_remove_existing ... ok
[INFO] [stdout] test commands::tests::cmd_set_timeout_valid ... ok
[INFO] [stdout] test commands::tests::raw_json_arg_empty_input ... ok
[INFO] [stdout] test commands::tests::cmd_set_timeout_zero_is_error ... ok
[INFO] [stdout] test commands::tests::cmd_unknown_returns_false ... ok
[INFO] [stdout] test commands::tests::raw_json_arg_no_remaining ... ok
[INFO] [stdout] test commands::tests::raw_json_arg_skip_one ... ok
[INFO] [stdout] test commands::tests::raw_json_arg_skip_two ... ok
[INFO] [stdout] test commands::tests::cmd_empty_returns_false ... ok
[INFO] [stdout] test config::tests::export_config_stdio_no_env ... ok
[INFO] [stdout] test config::tests::repl_state_is_connected_false ... ok
[INFO] [stdout] test display::tests::extract_schema_keys_empty_properties ... ok
[INFO] [stdout] test display::tests::extract_schema_keys_no_properties_key ... ok
[INFO] [stdout] test config::tests::connection_config_default_values ... ok
[INFO] [stdout] test display::tests::extract_schema_keys_with_properties ... ok
[INFO] [stdout] test config::tests::write_config_no_panic_stdout ... ok
[INFO] [stdout] test display::tests::print_resource_templates_with_entries_no_panic ... ok
[INFO] [stdout] test display::tests::print_tools_empty_no_panic ... ok
[INFO] [stdout] test protocol::template_tests::mcp_resource_template_defaults ... ok
[INFO] [stdout] test protocol::template_tests::mcp_resource_template_deserialization ... ok
[INFO] [stdout] test config::tests::export_config_http_with_env ... ok
[INFO] [stdout] test protocol::tests::jsonrpc_request_serde_roundtrip ... ok
[INFO] [stdout] test protocol::tests::jsonrpc_response_error_deserialization ... ok
[INFO] [stdout] test commands::tests::cmd_exit_returns_true ... ok
[INFO] [stdout] test config::tests::export_config_http_with_headers ... ok
[INFO] [stdout] test config::tests::export_config_http_no_env ... ok
[INFO] [stdout] test config::tests::export_config_stdio_with_env ... ok
[INFO] [stdout] test config::tests::export_config_uses_server_name_as_key ... ok
[INFO] [stdout] test protocol::tests::mcp_tool_input_schema_rename ... ok
[INFO] [stdout] test config::tests::write_config_to_file ... ok
[INFO] [stdout] test protocol::tests::notification_log_missing_params ... ok
[INFO] [stdout] test protocol::tests::notification_prompts_list_changed ... ok
[INFO] [stdout] test protocol::tests::notification_resources_list_changed ... ok
[INFO] [stdout] test protocol::tests::notification_tools_list_changed ... ok
[INFO] [stdout] test protocol::tests::server_capabilities_default_all_none ... ok
[INFO] [stdout] test protocol::tests::notification_unknown_method ... ok
[INFO] [stdout] test display::tests::print_resource_templates_empty_no_panic ... ok
[INFO] [stdout] test config::tests::completer_state_new_empty ... ok
[INFO] [stdout] test display::tests::extract_schema_keys_with_required ... ok
[INFO] [stdout] test protocol::tests::notification_log_message ... ok
[INFO] [stdout] test display::tests::extract_schema_keys_all_required ... ok
[INFO] [stdout] test config::tests::repl_state_is_connected_true ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 46 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/mcpi-f2d8e6736d6009cf)
[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] [stderr]      Running tests/client_mock.rs (/opt/rustwide/target/debug/deps/client_mock-e0d6c5996a770de4)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test call_tool_sends_correct_params ... ok
[INFO] [stdout] test initialize_sends_initialized_notification ... ok
[INFO] [stdout] test handles_server_request_with_handler ... ok
[INFO] [stdout] test list_resource_templates_sends_correct_method ... ok
[INFO] [stdout] test handles_server_request_no_handler ... ok
[INFO] [stdout] test list_resource_templates_empty_response ... ok
[INFO] [stdout] test routes_notification_to_channel ... ok
[INFO] [stdout] test list_tools_parses_response ... ok
[INFO] [stdout] test list_resource_templates_parses_response ... ok
[INFO] [stdout] test list_resources_parses_response ... ok
[INFO] [stdout] test routes_response_to_pending_request ... ok
[INFO] [stdout] test timeout_on_no_response ... ok
[INFO] [stderr]    Doc-tests mcpi
[INFO] [stdout] test fails_fast_on_channel_close ... 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] 
[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" "f53082f2de91ef21ff50ebf212cc496cac9fd1c623256c8fab47156d58367fa1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f53082f2de91ef21ff50ebf212cc496cac9fd1c623256c8fab47156d58367fa1", kill_on_drop: false }`
[INFO] [stdout] f53082f2de91ef21ff50ebf212cc496cac9fd1c623256c8fab47156d58367fa1