[INFO] fetching crate rash-ssh 0.2.1...
[INFO] testing rash-ssh-0.2.1 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate rash-ssh 0.2.1 into /workspace/builds/worker-2-tc2/source
[INFO] started tweaking crates.io crate rash-ssh 0.2.1
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate rash-ssh 0.2.1
[INFO] tweaked toml for crates.io crate rash-ssh 0.2.1 written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate rash-ssh 0.2.1 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 rash-ssh 0.2.1 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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 3922e01a61b4d7ebaf5fc080892212df77dce6bafe5f6dc113efa48828734a90
[INFO] running `Command { std: "docker" "start" "3922e01a61b4d7ebaf5fc080892212df77dce6bafe5f6dc113efa48828734a90", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3922e01a61b4d7ebaf5fc080892212df77dce6bafe5f6dc113efa48828734a90", 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" "3922e01a61b4d7ebaf5fc080892212df77dce6bafe5f6dc113efa48828734a90" "/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" "3922e01a61b4d7ebaf5fc080892212df77dce6bafe5f6dc113efa48828734a90", 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" "3922e01a61b4d7ebaf5fc080892212df77dce6bafe5f6dc113efa48828734a90" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.24
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling winnow v1.0.4
[INFO] [stderr]    Compiling memchr v2.8.3
[INFO] [stderr]    Compiling bytes v1.12.1
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]    Compiling winnow v0.7.15
[INFO] [stderr]    Compiling toml_writer v1.1.2+spec-1.1.0
[INFO] [stderr]    Compiling toml_parser v1.1.3+spec-1.1.0
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling syn v3.0.5
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling mio v1.2.3
[INFO] [stderr]    Compiling socket2 v0.6.5
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling toml_datetime v0.7.5+spec-1.1.0
[INFO] [stderr]    Compiling serde_spanned v1.1.1
[INFO] [stderr]    Compiling toml v0.9.12+spec-1.1.0
[INFO] [stderr]    Compiling tokio-macros v2.7.2
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling rash-ssh v0.2.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 31.46s
[INFO] running `Command { std: "docker" "inspect" "3922e01a61b4d7ebaf5fc080892212df77dce6bafe5f6dc113efa48828734a90", 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" "3922e01a61b4d7ebaf5fc080892212df77dce6bafe5f6dc113efa48828734a90" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling rash-ssh v0.2.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 4.96s
[INFO] running `Command { std: "docker" "inspect" "3922e01a61b4d7ebaf5fc080892212df77dce6bafe5f6dc113efa48828734a90", 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" "3922e01a61b4d7ebaf5fc080892212df77dce6bafe5f6dc113efa48828734a90" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "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/build/rash-ssh/aead9299b7942ee7/out/rash-aead9299b7942ee7)
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/build/rash-ssh/523a840a90b051b3/out/rash-523a840a90b051b3)
[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] [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/cli_split.rs (/opt/rustwide/target/debug/build/rash-ssh/4a381d182bdc18b5/out/cli_split-4a381d182bdc18b5)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test d2_p_takes_a_value_on_modern_openssh ... ok
[INFO] [stdout] test forwards_are_injected_where_dash_m_stood ... ok
[INFO] [stdout] test long_options_belong_to_rash ... ok
[INFO] [stdout] test d3_nothing_after_the_separator_is_rewritten ... ok
[INFO] [stdout] test version_is_rash_s_not_ssh_s ... ok
[INFO] [stdout] test dash_m_inside_a_cluster ... ok
[INFO] [stdout] test monitor_port_forms ... ok
[INFO] [stdout] test d1_unknown_options_are_forwarded_not_rejected ... ok
[INFO] [stdout] test d4_f_inside_an_option_value_is_never_stripped ... ok
[INFO] [stdout] test dash_f_is_rash_s_and_is_stripped_from_clusters ... ok
[INFO] [stderr]      Running tests/config_resolve.rs (/opt/rustwide/target/debug/build/rash-ssh/00a12c462bd64827/out/config_resolve-00a12c462bd64827)
[INFO] [stdout] test errors ... ok
[INFO] [stdout] test passthrough_shapes ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 26 tests
[INFO] [stdout] test an_unknown_log_format_is_rejected ... ok
[INFO] [stdout] test d6_ipv6_monitor_host_is_bracketed ... ok
[INFO] [stdout] test an_unknown_session_names_the_ones_that_exist ... ok
[INFO] [stdout] test debug_outranks_loglevel ... ok
[INFO] [stdout] test background_disables_the_starting_gate ... ok
[INFO] [stdout] test a_bad_monitor_key_says_what_was_wanted ... ok
[INFO] [stdout] test a_session_can_select_the_unix_monitor_and_json_logs ... ok
[INFO] [stdout] test an_enormous_poll_time_does_not_overflow_the_timeout_clamp ... ok
[INFO] [stdout] test max_lifetime_clamps_both_poll_times ... ok
[INFO] [stdout] test an_over_long_socket_path_is_rejected_up_front ... ok
[INFO] [stdout] test max_start_and_message_pass_through ... ok
[INFO] [stdout] test a_session_layers_over_defaults ... ok
[INFO] [stdout] test first_poll_follows_poll_unless_set ... ok
[INFO] [stdout] test monitor_port_precedence ... ok
[INFO] [stdout] test log_targets_and_levels_by_name ... ok
[INFO] [stdout] test defaults_match_autossh ... ok
[INFO] [stdout] test env_sourced_port_injects_at_the_front ... ok
[INFO] [stdout] test monitor_modes_produce_the_right_forwards ... ok
[INFO] [stderr]      Running tests/e2e.rs (/opt/rustwide/target/debug/build/rash-ssh/c9931e394f020eb6/out/e2e-c9931e394f020eb6)
[INFO] [stdout] test rash_variables_outrank_autossh_ones ... ok
[INFO] [stdout] test touch_pidfile_reads_its_value ... ok
[INFO] [stdout] test rejections ... ok
[INFO] [stdout] test the_config_file_is_searched_in_order ... ok
[INFO] [stdout] test the_environment_outranks_the_config_file ... ok
[INFO] [stdout] test the_unix_monitor_forwards_sockets_not_ports ... ok
[INFO] [stdout] test short_poll_shrinks_the_net_timeout ... ok
[INFO] [stdout] test ssh_path_override ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[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] [stderr]      Running tests/manual.rs (/opt/rustwide/target/debug/build/rash-ssh/7d4827b78a2ef3bb/out/manual-7d4827b78a2ef3bb)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test it_writes_the_manual_page_and_nothing_else ... ok
[INFO] [stdout] test what_comes_out_is_an_mdoc_page ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/monitor.rs (/opt/rustwide/target/debug/build/rash-ssh/02df9344382590ab/out/monitor-02df9344382590ab)
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stderr] rash: monitor listening on 127.0.0.1:25001
[INFO] [stdout] test a_missing_socket_directory_is_created_private ... ok
[INFO] [stderr] rash: monitor listening on /tmp/rash-t719-mkdir/rash-719-in.sock
[INFO] [stdout] test a_disabled_monitor_is_never_probed ... ok
[INFO] [stderr] rash: monitor listening on /tmp/rash-t719-ok/rash-719-in.sock
[INFO] [stdout] test a_loop_probe_succeeds_when_the_data_comes_back ... ok
[INFO] [stderr] rash: monitor listening on 127.0.0.1:25003
[INFO] [stdout] test a_unix_probe_succeeds_when_the_data_comes_back ... ok
[INFO] [stderr] rash: connection ok
[INFO] [stdout] test the_listener_is_close_on_exec ... ok
[INFO] [stderr] rash: connection ok
[INFO] [stderr] rash: monitor listening on /tmp/rash-t719-dead/rash-719-in.sock
[INFO] [stderr] rash: /tmp/rash-t719-dead/rash-719-out.sock: No such file or directory (os error 2)
[INFO] [stderr] rash: monitor attempt 1 of 3 failed
[INFO] [stderr] rash: monitor listening on 127.0.0.1:25005
[INFO] [stderr] rash: monitor listening on 127.0.0.1:25007
[INFO] [stderr] rash: 127.0.0.1:25006: Connection refused (os error 111)
[INFO] [stderr] rash: monitor attempt 1 of 3 failed
[INFO] [stdout] test a_socket_directory_owned_by_someone_else_is_refused ... ok
[INFO] [stderr] rash: monitor listening on /tmp/rash-t719-cleanup/rash-719-in.sock
[INFO] [stdout] test the_unix_sockets_are_removed_on_exit ... ok
[INFO] [stderr] rash: monitor attempt 1 of 3 failed
[INFO] [stdout] test an_echo_probe_succeeds ... ok
[INFO] [stderr] rash: connection ok
[INFO] [stdout] test the_probe_message_is_identifiable_and_unique ... ok
[INFO] [stderr] rash: monitor listening on /tmp/rash-t719-rotate/rash-719-in.sock
[INFO] [stdout] test the_remote_socket_path_is_new_on_every_start ... ok
[INFO] [stderr] rash: 127.0.0.1:25006: Connection refused (os error 111)
[INFO] [stderr] rash: monitor attempt 2 of 3 failed
[INFO] [stderr] rash: /tmp/rash-t719-dead/rash-719-out.sock: No such file or directory (os error 2)
[INFO] [stderr] rash: monitor attempt 2 of 3 failed
[INFO] [stderr] rash: monitor attempt 2 of 3 failed
[INFO] [stderr] rash: 127.0.0.1:25006: Connection refused (os error 111)
[INFO] [stderr] rash: monitor attempt 3 of 3 failed
[INFO] [stderr] rash: tried connection 3 times and failed
[INFO] [stderr] rash: /tmp/rash-t719-dead/rash-719-out.sock: No such file or directory (os error 2)
[INFO] [stdout] test a_probe_fails_when_nothing_is_listening ... ok
[INFO] [stderr] rash: monitor attempt 3 of 3 failed
[INFO] [stdout] test a_unix_probe_fails_when_nothing_answers ... ok
[INFO] [stderr] rash: tried connection 3 times and failed
[INFO] [stderr] rash: monitor attempt 3 of 3 failed
[INFO] [stderr] rash: tried connection 3 times and failed
[INFO] [stdout] test an_echo_probe_fails_when_the_reply_differs ... ok
[INFO] [stderr] rash: timeout polling to accept read connection
[INFO] [stderr] rash: monitor attempt 1 of 3 failed
[INFO] [stderr] rash: timeout polling to accept read connection
[INFO] [stderr] rash: monitor attempt 2 of 3 failed
[INFO] [stderr] rash: timeout polling to accept read connection
[INFO] [stdout] test a_loop_probe_fails_when_traffic_is_black_holed ... ok
[INFO] [stderr] rash: monitor attempt 3 of 3 failed
[INFO] [stdout] 
[INFO] [stderr] rash: tried connection 3 times and failed
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.61s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/pidfile.rs (/opt/rustwide/target/debug/build/rash-ssh/bdb4d869696f245c/out/pidfile-bdb4d869696f245c)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test a_file_removed_underneath_us_is_not_an_error_on_drop ... ok
[INFO] [stdout] test it_writes_our_pid_and_removes_the_file_on_drop ... ok
[INFO] [stdout] test a_file_claimed_by_another_process_is_left_alone ... ok
[INFO] [stdout] test touch_moves_the_modification_time_without_disturbing_the_contents ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/policy.rs (/opt/rustwide/target/debug/build/rash-ssh/4d9a096285e985e8/out/policy-4d9a096285e985e8)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test the_first_start_never_sleeps ... ok
[INFO] [stdout] test the_starting_gate_catches_a_first_session_that_dies_at_once ... ok
[INFO] [stdout] test gate_boundary_is_inclusive ... ok
[INFO] [stdout] test min_time_has_a_floor_of_ten_seconds ... ok
[INFO] [stdout] test backoff_curve_matches_the_documented_table ... ok
[INFO] [stdout] test a_killed_child_is_always_restarted ... ok
[INFO] [stdout] test staying_up_long_enough_resets_the_backoff ... ok
[INFO] [stderr]    Doc-tests rash
[INFO] [stdout] test exit_status_table ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 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" "3922e01a61b4d7ebaf5fc080892212df77dce6bafe5f6dc113efa48828734a90", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3922e01a61b4d7ebaf5fc080892212df77dce6bafe5f6dc113efa48828734a90", kill_on_drop: false }`
[INFO] [stdout] 3922e01a61b4d7ebaf5fc080892212df77dce6bafe5f6dc113efa48828734a90
