[INFO] fetching crate rexec 0.5.3...
[INFO] testing rexec-0.5.3 against 1.99.0-beta.8 for beta-1.100-2
[INFO] extracting crate rexec 0.5.3 into /workspace/builds/worker-4-tc1/source
[INFO] started tweaking crates.io crate rexec 0.5.3
[INFO] finished tweaking crates.io crate rexec 0.5.3
[INFO] tweaked toml for crates.io crate rexec 0.5.3 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate rexec 0.5.3 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate rexec 0.5.3 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.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded rust-mcp-macros v0.9.1
[INFO] [stderr]   Downloaded rust-mcp-transport v0.9.1
[INFO] [stderr]   Downloaded rust-mcp-sdk v0.9.0
[INFO] [stderr]   Downloaded rust-mcp-schema v0.10.3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/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:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 655e67a38d2e0d42c3e139c09c186a74a0e46ce6ddfe4c122b33f1ed7d8472dd
[INFO] running `Command { std: "docker" "start" "655e67a38d2e0d42c3e139c09c186a74a0e46ce6ddfe4c122b33f1ed7d8472dd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "655e67a38d2e0d42c3e139c09c186a74a0e46ce6ddfe4c122b33f1ed7d8472dd", 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" "655e67a38d2e0d42c3e139c09c186a74a0e46ce6ddfe4c122b33f1ed7d8472dd" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "655e67a38d2e0d42c3e139c09c186a74a0e46ce6ddfe4c122b33f1ed7d8472dd", 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" "655e67a38d2e0d42c3e139c09c186a74a0e46ce6ddfe4c122b33f1ed7d8472dd" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v3.0.6
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling futures-sink v0.3.34
[INFO] [stderr]    Compiling smallvec v1.16.1
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]    Compiling cfg_aliases v0.2.2
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling time-core v0.1.9
[INFO] [stderr]    Compiling clap_lex v1.1.1
[INFO] [stderr]    Compiling num_threads v0.1.7
[INFO] [stderr]    Compiling deranged v0.5.8
[INFO] [stderr]    Compiling chrono v0.4.45
[INFO] [stderr]    Compiling nix v0.31.3
[INFO] [stderr]    Compiling futures-channel v0.3.34
[INFO] [stderr]    Compiling clap_builder v4.6.7
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling mio v1.2.3
[INFO] [stderr]    Compiling socket2 v0.6.5
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling time v0.3.55
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling uuid v1.26.1
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling futures-macro v0.3.34
[INFO] [stderr]    Compiling tokio-macros v2.7.2
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling async-trait v0.1.92
[INFO] [stderr]    Compiling clap_derive v4.6.7
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling futures-util v0.3.34
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling clap v4.6.7
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling rust-mcp-schema v0.10.3
[INFO] [stderr]    Compiling futures-executor v0.3.34
[INFO] [stderr]    Compiling rust-mcp-macros v0.9.1
[INFO] [stderr]    Compiling futures v0.3.34
[INFO] [stderr]    Compiling tokio-stream v0.1.19
[INFO] [stderr]    Compiling rust-mcp-transport v0.9.1
[INFO] [stderr]    Compiling rust-mcp-sdk v0.9.0
[INFO] [stderr]    Compiling rexec v0.5.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 50.84s
[INFO] running `Command { std: "docker" "inspect" "655e67a38d2e0d42c3e139c09c186a74a0e46ce6ddfe4c122b33f1ed7d8472dd", 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" "655e67a38d2e0d42c3e139c09c186a74a0e46ce6ddfe4c122b33f1ed7d8472dd" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling rexec v0.5.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 4.15s
[INFO] running `Command { std: "docker" "inspect" "655e67a38d2e0d42c3e139c09c186a74a0e46ce6ddfe4c122b33f1ed7d8472dd", 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" "655e67a38d2e0d42c3e139c09c186a74a0e46ce6ddfe4c122b33f1ed7d8472dd" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.10s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rexec-1a374c61d12cb7dd)
[INFO] [stdout] 
[INFO] [stdout] running 54 tests
[INFO] [stdout] test cli::tests::long_list_value_still_works ... ok
[INFO] [stdout] test client::tests::attach_renderer_colors_headers_and_preserves_raw_output ... ok
[INFO] [stdout] test client::tests::plain_renderer_introduces_no_ansi_sequences ... ok
[INFO] [stdout] test cli::tests::short_s_still_means_start_host ... ok
[INFO] [stdout] test cli::tests::run_timeout_defaults_to_zero ... ok
[INFO] [stdout] test filter::tests::replaces_carriage_return_with_newline ... ok
[INFO] [stdout] test cli::tests::host_path_addition_can_be_disabled ... ok
[INFO] [stdout] test client::tests::renderer_includes_zero_for_unlimited_commands ... ok
[INFO] [stdout] test host::tests::attachment_disconnect_is_detected_without_an_event ... ok
[INFO] [stdout] test cli::tests::parses_repeatable_environment_overrides ... ok
[INFO] [stdout] test cli::tests::attach_color_flags_are_mapped ... ok
[INFO] [stdout] test cli::tests::list_count_can_be_overridden ... ok
[INFO] [stdout] test cli::tests::parses_run_timeout_seconds ... ok
[INFO] [stdout] test client::tests::renderer_includes_requested_timeout_on_command_line ... ok
[INFO] [stdout] test filter::tests::strips_sgr_color_sequence ... ok
[INFO] [stdout] test filter::tests::strips_cursor_movement_csi ... ok
[INFO] [stdout] test cli::tests::silent_is_a_long_only_host_option ... ok
[INFO] [stdout] test filter::tests::strips_osc_terminated_by_bel ... ok
[INFO] [stdout] test filter::tests::strips_osc_terminated_by_st ... ok
[INFO] [stdout] test host::tests::user_bin_dirs_are_not_added_twice ... ok
[INFO] [stdout] test filter::tests::handles_single_char_esc_sequence ... ok
[INFO] [stdout] test host::tests::user_bin_dirs_are_prepended_in_order ... ok
[INFO] [stdout] test filter::tests::handles_split_csi_across_chunks ... ok
[INFO] [stdout] test filter::tests::passes_through_plain_ascii ... ok
[INFO] [stdout] test mcp::tests::exec_requires_environment_object ... ok
[INFO] [stdout] test host::tests::timeout_wait_can_be_cancelled ... ok
[INFO] [stdout] test mcp::tests::exec_schema_exposes_environment_controls_and_timeout ... ok
[INFO] [stdout] test cli::tests::list_defaults_to_ten ... ok
[INFO] [stdout] test host::tests::disconnected_timeout_wait_is_not_an_expiration ... ok
[INFO] [stdout] test host::tests::timeout_wait_reports_expiration ... ok
[INFO] [stdout] test cli::tests::parses_clear_environment ... ok
[INFO] [stdout] test mcp::tests::exec_accepts_environment_object_and_clear_flag ... ok
[INFO] [stdout] test host::tests::queuing_console_output_does_not_wait_for_its_turn ... ok
[INFO] [stdout] test mcp::tests::exec_timeout_defaults_to_zero ... ok
[INFO] [stdout] test protocol::tests::attach_action_selects_raw_ansi_output ... ok
[INFO] [stdout] test protocol::tests::request_timeout_defaults_to_zero ... ok
[INFO] [stdout] test pty_exec::tests::absent_stdin_is_immediate_eof ... ok
[INFO] [stdout] test pty_exec::tests::provided_stdin_is_closed_after_payload ... ok
[INFO] [stdout] test host::tests::only_existing_user_bin_dirs_are_added ... ok
[INFO] [stdout] test service::tests::service_starts_the_silent_host ... ok
[INFO] [stdout] test protocol::tests::zero_timeout_is_omitted ... ok
[INFO] [stdout] test host::tests::command_without_fresh_ping_is_rejected ... ok
[INFO] [stdout] test service::tests::executable_path_escapes_systemd_specifiers ... ok
[INFO] [stdout] test service::tests::systemctl_options_precede_the_enable_command ... ok
[INFO] [stdout] test mcp::tests::repeated_request_disconnects_always_recover ... ok
[INFO] [stdout] test mcp::tests::connector_retries_until_the_host_appears ... ok
[INFO] [stdout] test mcp::tests::poisoned_pool_lock_does_not_strand_the_server ... ok
[INFO] [stdout] test mcp::tests::overlapping_calls_acquire_independent_connections ... ok
[INFO] [stdout] test mcp::tests::connector_bounds_a_tool_wait_but_keeps_retrying ... ok
[INFO] [stdout] test mcp::tests::long_running_command_does_not_trigger_reconnection ... ok
[INFO] [stdout] test host::tests::verified_connection_accepts_multiple_commands ... ok
[INFO] [stdout] test host::tests::clear_env_removes_inherited_values_before_overrides ... ok
[INFO] [stdout] test mcp::tests::waiting_call_reuses_a_connection_returned_during_retry ... ok
[INFO] [stdout] test host::tests::whoami_env_cannot_be_overridden_by_request ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 54 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.24s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/rexec/main.rs (/opt/rustwide/target/debug/deps/rexec-6a5bafce22056370)
[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]    Doc-tests rexec
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/mcp.rs - mcp::CheckHostTool::request_params (line 73) ... ignored
[INFO] [stdout] test src/mcp.rs - mcp::ExecTool::request_params (line 36) ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.28s; merged doctests compilation took 0.27s
[INFO] running `Command { std: "docker" "inspect" "655e67a38d2e0d42c3e139c09c186a74a0e46ce6ddfe4c122b33f1ed7d8472dd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "655e67a38d2e0d42c3e139c09c186a74a0e46ce6ddfe4c122b33f1ed7d8472dd", kill_on_drop: false }`
[INFO] [stdout] 655e67a38d2e0d42c3e139c09c186a74a0e46ce6ddfe4c122b33f1ed7d8472dd
