[INFO] cloning repository https://github.com/lpotthast/tokio-process-tools
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/lpotthast/tokio-process-tools" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Flpotthast%2Ftokio-process-tools", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Flpotthast%2Ftokio-process-tools'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 496e07d5dc0863c7446fd0830e4f5b2b3aedf77c
[INFO] testing lpotthast/tokio-process-tools against try#33835004928d3bf65db4d4712e1330766263b0bd for pr-155739
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Flpotthast%2Ftokio-process-tools" "/workspace/builds/worker-1-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/lpotthast/tokio-process-tools
[INFO] finished tweaking git repo https://github.com/lpotthast/tokio-process-tools
[INFO] tweaked toml for git repo https://github.com/lpotthast/tokio-process-tools written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/lpotthast/tokio-process-tools on toolchain 33835004928d3bf65db4d4712e1330766263b0bd
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/lpotthast/tokio-process-tools 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" "+33835004928d3bf65db4d4712e1330766263b0bd" "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" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 4cb4b7cdc153157c57f31ee8a40c72d1be2941fb74bbf5f636c116bb5234ae51
[INFO] running `Command { std: "docker" "start" "-a" "4cb4b7cdc153157c57f31ee8a40c72d1be2941fb74bbf5f636c116bb5234ae51", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "4cb4b7cdc153157c57f31ee8a40c72d1be2941fb74bbf5f636c116bb5234ae51", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4cb4b7cdc153157c57f31ee8a40c72d1be2941fb74bbf5f636c116bb5234ae51", kill_on_drop: false }`
[INFO] [stdout] 4cb4b7cdc153157c57f31ee8a40c72d1be2941fb74bbf5f636c116bb5234ae51
[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" "+33835004928d3bf65db4d4712e1330766263b0bd" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c099ed8a119a10a9be8da05b2d1096f8ebd127cbe1bf27c0b28505e749c8e09d
[INFO] running `Command { std: "docker" "start" "-a" "c099ed8a119a10a9be8da05b2d1096f8ebd127cbe1bf27c0b28505e749c8e09d", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.186
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling bitflags v2.11.1
[INFO] [stderr]    Compiling unwrap-infallible v1.0.0
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling nix v0.31.2
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling mio v1.2.0
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling typed-builder-macro v0.23.2
[INFO] [stderr]    Compiling tokio-macros v2.7.0
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling tokio v1.52.2
[INFO] [stderr]    Compiling typed-builder v0.23.2
[INFO] [stderr]    Compiling tokio-process-tools v0.11.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 14.18s
[INFO] running `Command { std: "docker" "inspect" "c099ed8a119a10a9be8da05b2d1096f8ebd127cbe1bf27c0b28505e749c8e09d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c099ed8a119a10a9be8da05b2d1096f8ebd127cbe1bf27c0b28505e749c8e09d", kill_on_drop: false }`
[INFO] [stdout] c099ed8a119a10a9be8da05b2d1096f8ebd127cbe1bf27c0b28505e749c8e09d
[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" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] fc1798b6cb1b7ac03b80ae9c8131430e9598de2a8a2684697bcc907abfe17895
[INFO] running `Command { std: "docker" "start" "-a" "fc1798b6cb1b7ac03b80ae9c8131430e9598de2a8a2684697bcc907abfe17895", kill_on_drop: false }`
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling cc v1.2.61
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling rayon-core v1.13.0
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling plotters-backend v0.3.7
[INFO] [stderr]    Compiling zerocopy-derive v0.8.48
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling tokio v1.52.2
[INFO] [stderr]    Compiling num-bigint v0.4.6
[INFO] [stderr]    Compiling num-iter v0.1.45
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling itertools v0.13.0
[INFO] [stderr]    Compiling plotters-svg v0.3.7
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling cast v0.3.0
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling rand v0.9.4
[INFO] [stderr]    Compiling rayon v1.12.0
[INFO] [stderr]    Compiling nix v0.31.2
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling tracing-test-macro v0.2.6
[INFO] [stderr]    Compiling num-rational v0.4.2
[INFO] [stderr]    Compiling alloca v0.4.0
[INFO] [stderr]    Compiling page_size v0.6.0
[INFO] [stderr]    Compiling indoc v2.0.7
[INFO] [stderr]    Compiling oorandom v11.1.5
[INFO] [stderr]    Compiling num v0.4.3
[INFO] [stderr]    Compiling zerocopy v0.8.48
[INFO] [stderr]    Compiling fastrand v2.4.1
[INFO] [stderr]    Compiling criterion-plot v0.8.2
[INFO] [stderr]    Compiling anes v0.1.6
[INFO] [stderr]    Compiling jiff v0.2.24
[INFO] [stderr]    Compiling clap v4.6.1
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling tracing-subscriber v0.3.23
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling tracing-test v0.2.6
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling assertr v0.6.0
[INFO] [stderr]    Compiling tokio-stream v0.1.18
[INFO] [stderr]    Compiling tokio-process-tools v0.11.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling tokio-test v0.4.5
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling proptest v1.11.0
[INFO] [stderr]    Compiling criterion v0.8.2
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 50.69s
[INFO] running `Command { std: "docker" "inspect" "fc1798b6cb1b7ac03b80ae9c8131430e9598de2a8a2684697bcc907abfe17895", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fc1798b6cb1b7ac03b80ae9c8131430e9598de2a8a2684697bcc907abfe17895", kill_on_drop: false }`
[INFO] [stdout] fc1798b6cb1b7ac03b80ae9c8131430e9598de2a8a2684697bcc907abfe17895
[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" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 14db37d7f00503701d6aaa99b4996db993119e69080d069c18fe2e426d8918e8
[INFO] running `Command { std: "docker" "start" "-a" "14db37d7f00503701d6aaa99b4996db993119e69080d069c18fe2e426d8918e8", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.31s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tokio_process_tools-d56f65c15ab7c048)
[INFO] [stdout] 
[INFO] [stdout] running 177 tests
[INFO] [stdout] test async_drop::tests::missing_runtime_panic_names_terminate_on_drop ... ok
[INFO] [stdout] test output_stream::backend::broadcast::state::tests::replay_last_chunks_starts_at_retention_boundary ... ok
[INFO] [stdout] test output_stream::backend::broadcast::fanout::tests::fanout_reader_splits_input_into_configured_chunks_and_eof ... ok
[INFO] [stdout] test output_stream::backend::broadcast::state::tests::seal_trims_replay_without_touching_terminal ... ok
[INFO] [stdout] test output_stream::backend::broadcast::fast::tests::fast_reader_splits_input_into_configured_chunks_and_eof ... ok
[INFO] [stdout] test output_stream::backend::broadcast::state::tests::reliable_append_waits_for_slow_subscriber_capacity ... ok
[INFO] [stdout] test output_stream::backend::broadcast::subscription::tests::active_subscription_does_not_duplicate_live_handoff ... ok
[INFO] [stdout] test output_stream::backend::broadcast::state::tests::best_effort_queue_emits_one_gap_after_overflow ... ok
[INFO] [stdout] test output_stream::backend::broadcast::subscription::tests::eof_is_replayed_to_late_subscribers_before_seal ... ok
[INFO] [stdout] test output_stream::backend::broadcast::subscription::tests::replay_late_subscriber_observes_retained_output_then_read_error ... ok
[INFO] [stdout] test output_stream::backend::broadcast::state::tests::replay_last_bytes_keeps_whole_chunks_covering_boundary ... ok
[INFO] [stdout] test output_stream::backend::broadcast::subscription::tests::slow_best_effort_subscriber_observes_gap_then_newer_tail ... ok
[INFO] [stdout] test output_stream::backend::broadcast::subscription::tests::no_replay_late_subscriber_observes_terminal_read_error ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::backend_selection::reliable_no_replay_uses_fanout_replay_backend ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::backend_selection::reliable_replay_uses_fanout_replay_backend ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::backend_selection::default_broadcast_uses_tokio_broadcast_fast_backend ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::drop_lifecycle::dropping_fast_stream_closes_waiting_subscribers ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::backend_selection::replay_enabled_best_effort_uses_fanout_replay_backend ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::reliable_delivery::block_until_subscribers_catch_up_preserves_all_output_for_active_subscribers ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::replay::active_subscribers_still_receive_unread_tail_data_after_seal ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::backend_selection::typed_best_effort_no_replay_uses_tokio_broadcast_fast_backend ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::replay::late_subscriber_receives_startup_line_with_replay_all ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::replay::late_best_effort_replay_subscriber_receives_retained_history_after_active_overflow ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::drop_lifecycle::dropping_fanout_replay_stream_closes_waiting_subscribers ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::replay::waiter_created_before_seal_can_match_replayed_startup_line ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::replay::slow_best_effort_replay_subscriber_observes_gap_then_newer_live_data ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::state::tests::no_replay_retains_no_chunks ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::state::tests::read_error_is_stored_as_terminal_state_not_replay_chunk ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::replay::best_effort_replay_delivers_terminal_after_pending_gap ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::replay::subscriber_created_after_seal_starts_live_by_default ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::state::tests::eof_is_stored_as_terminal_state_not_replay_chunk ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::state::tests::replay_last_bytes_keeps_whole_chunks_covering_boundary ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::state::tests::replay_last_bytes_retains_bounded_tail ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::state::tests::replay_all_retains_all_chunks ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::state::tests::seal_trims_retained_replay ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::state::tests::replay_last_chunks_retains_bounded_tail ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::subscription::tests::emits_gap_read_error_and_eof_from_replay ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::subscription::tests::emits_terminal_event_after_replay_and_closes_live_receiver ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::subscription::tests::drop_clears_active_backend_registration ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::subscription::tests::emits_replay_before_live_events ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::active_consumer::configured_second_subscriber_error_does_not_poison_state_or_stop_reader ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::active_consumer::multiple_subscribers_are_not_possible ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::consume::consume_runs_a_custom_sync_visitor_until_break ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::active_consumer::wait_for_line_claims_receiver_before_polling ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::consumer_lifecycle::abort_releases_single_subscriber_claim ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::consumer_lifecycle::drop_allows_later_collector ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::consumer_lifecycle::cancel_allows_later_collector ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::consumer_unit_lifecycle::abort_releases_single_subscriber_claim ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::consumer_unit_lifecycle::drop_allows_later_collector ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::line_waiter::stream_drop_closes_waiting_line_waiters ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::consume::consume_async_runs_a_custom_async_visitor_to_eof ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::reader_backpressure::configured_best_effort_yields_when_pending_gap_channel_is_full ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::line_waiter::subscribes_before_polling ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::reader_chunking::configured_reader_does_not_terminate_when_first_read_can_fill_the_entire_bytes_mut_buffer ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::consumer_lifecycle::wait_cancellation_releases_single_subscriber_claim ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::consumer_lifecycle::cancel_aborts_hanging_async_collector_after_timeout ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::consumer_unit_lifecycle::cancel_aborts_hanging_async_callback_after_timeout ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::line_waiter::timeout_allows_later_collector ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::replay::explicit_replay_after_seal_ignores_history_retained_for_active_subscribers ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::replay::seal_replay_drops_old_history_for_future_subscribers ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::reader_errors::configured_reader_publishes_read_error_without_panicking ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::replay::later_consumer_observes_read_error ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::replay::configured_subscription_after_seal_starts_live_with_empty_shared_replay ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::replay::configured_subscription_snapshots_replay_buffer_from_shared_state ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::replay::later_consumer_observes_eof ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::replay::replay_retains_output_between_consumers ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::replay::no_replay_discards_output_between_consumers ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::replay::replay_retention_limits_later_consumer ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::replay::typed_no_replay_starts_consumer_at_live_output ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::consumer_unit_lifecycle::wait_cancellation_releases_single_subscriber_claim ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::replay::typed_replay_all_delivers_pre_consumer_output_before_live_output ... ok
[INFO] [stdout] test output_stream::config::tests::one_config_constructs_both_stream_backends ... ok
[INFO] [stdout] test output_stream::config::tests::builder_creates_expected_delivery_and_replay_configs ... ok
[INFO] [stdout] test output_stream::consumer::tests::cancel_returns_cancelled_when_cooperative ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::replay::typed_wait_after_seal_starts_live ... ok
[INFO] [stdout] test output_stream::line::adapter::tests::r#async::flushes_trailing_unterminated_line_at_eof ... ok
[INFO] [stdout] test output_stream::line::adapter::tests::sync::break_from_inner_stops_parsing_immediately ... ok
[INFO] [stdout] test output_stream::backend::broadcast::tests::reliable_delivery::block_until_subscribers_catch_up_gated_multi_subscriber_collection_completes ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::reader_errors::configured_reader_records_read_error_while_active_queue_is_full ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::reader_backpressure::configured_reader_sends_pending_gap_before_resumed_chunk_delivery ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::reader_backpressure::configured_reader_sends_pending_gap_before_terminal_eof ... ok
[INFO] [stdout] test output_stream::line::parser::tests::buffer_compaction::compaction_does_not_drop_mid_line_partial_buffer ... ok
[INFO] [stdout] test output_stream::line::parser::tests::buffer_compaction::no_compaction_keeps_high_water_mark_when_threshold_is_none ... ok
[INFO] [stdout] test output_stream::line::parser::tests::buffer_compaction::compaction_releases_emitted_capacity_when_over_threshold ... ok
[INFO] [stdout] test output_stream::line::parser::tests::basic_line_parsing_cases ... ok
[INFO] [stdout] test output_stream::line::adapter::tests::sync::flushes_trailing_unterminated_line_at_eof ... ok
[INFO] [stdout] test output_stream::line::parser::tests::fast_path_borrows_when_line_fits_in_chunk_with_empty_buffer ... ok
[INFO] [stdout] test output_stream::line::parser::tests::gap_discards_partial_line_until_next_newline ... ok
[INFO] [stdout] test output_stream::line::parser::tests::leading_and_trailing_whitespace_is_preserved ... ok
[INFO] [stdout] test output_stream::line::adapter::tests::sync::gap_discards_partial_line ... ok
[INFO] [stdout] test output_stream::line::parser::tests::emit_additional_as_new_lines_does_not_emit_synthetic_empty_lines ... ok
[INFO] [stdout] test output_stream::line::parser::tests::max_line_length_of_0_disables_line_length_checks ... ok
[INFO] [stdout] test output_stream::line::parser::tests::overflow_drop_additional_data_persists_across_chunks ... ok
[INFO] [stdout] test output_stream::line::parser::tests::invalid_utf8_data ... ok
[INFO] [stdout] test output_stream::line::parser::tests::multi_byte_utf_8_characters_are_preserved_even_when_parsing_multiple_one_byte_chunks ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::writer_lifecycle::pending_writer_abort_releases_single_subscriber_claim ... ok
[INFO] [stdout] test output_stream::line::parser::tests::properties::multibyte_utf8_survives_chunk_split ... ok
[INFO] [stdout] test output_stream::line::parser::tests::rest_of_too_long_line_is_dropped ... ok
[INFO] [stdout] test output_stream::line::parser::tests::rest_of_too_long_line_is_returned_as_additional_lines ... ok
[INFO] [stdout] test output_stream::tests::cross_backend_consumable_smoke ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::basic_line_collection_limit_modes ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::chunk_collector_accepts_stateful_callback ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::chunk_collector_async_extends_sink_until_eof ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::collectors_return_stream_read_error ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::collectors_skip_gaps_and_keep_final_unterminated_line ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::drop_additional_preserves_retained_bytes_when_limit_rejects_line ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::drop_additional_preserves_retained_lines_when_oversized_line_arrives ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::drop_oldest_evicts_old_lines_when_new_line_fits_but_budget_is_exceeded ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::drop_oldest_preserves_retained_lines_when_oversized_line_arrives ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::drop_oldest_updates_retained_bytes_when_evicting_by_line_count ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::drop_oldest_with_zero_max_lines_retains_nothing ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::line_collector_accepts_stateful_callback ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::line_collector_async_break_stops_after_requested_line ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::push_chunk_boundary_matrix ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::push_line_boundary_matrix ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::raw_collection_keeps_expected_bytes_when_truncated ... ok
[INFO] [stdout] test output_stream::visitors::collect::tests::retained_bytes_tracks_appended_lines ... ok
[INFO] [stdout] test output_stream::visitors::inspect::tests::cancel_returns_cancelled_when_cooperative ... ok
[INFO] [stdout] test output_stream::visitors::inspect::tests::inspect_chunks::accepts_stateful_callback ... ok
[INFO] [stdout] test output_stream::visitors::inspect::tests::inspect_chunks_async::accepts_stateful_callback ... ok
[INFO] [stdout] test output_stream::visitors::inspect::tests::inspect_lines::inspectors_return_stream_read_error ... ok
[INFO] [stdout] test output_stream::visitors::inspect::tests::inspect_lines::inspectors_skip_gaps_and_visit_final_unterminated_line ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::reader_backpressure::configured_reader_records_eof_while_active_queue_is_full ... ok
[INFO] [stdout] test output_stream::line::parser::tests::properties::emit_additional_preserves_all_bytes ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::reader_drain::reader_drains_after_consumer_drop ... ok
[INFO] [stdout] test output_stream::visitors::wait::tests::wait_for_line::gap_does_not_join_lines ... ok
[INFO] [stdout] test output_stream::visitors::wait::tests::wait_for_line::honors_line_parsing_options ... ok
[INFO] [stdout] test output_stream::visitors::wait::tests::wait_for_line::matches_final_line ... ok
[INFO] [stdout] test output_stream::visitors::wait::tests::wait_for_line::matches_intermediary_line ... ok
[INFO] [stdout] test output_stream::visitors::inspect::tests::inspect_lines_async::preserves_unterminated_final_line ... ok
[INFO] [stdout] test output_stream::visitors::wait::tests::wait_for_line::reports_read_error ... ok
[INFO] [stdout] test output_stream::visitors::wait::tests::wait_for_line::returns_stream_closed_when_expected_is_not_matched_before_eof ... ok
[INFO] [stdout] test output_stream::visitors::wait::tests::wait_for_line_bounded::times_out_with_timeout_error ... ok
[INFO] [stdout] test output_stream::visitors::write::tests::chunk_write_error_handler_can_continue_then_stop ... ok
[INFO] [stdout] test output_stream::visitors::write::tests::chunk_writer_accepts_send_only_writer ... ok
[INFO] [stdout] test output_stream::visitors::write::tests::chunk_writer_mapped_writes_mapped_output ... ok
[INFO] [stdout] test output_stream::visitors::write::tests::chunk_writer_reports_and_can_handle_sink_write_errors ... ok
[INFO] [stdout] test output_stream::visitors::write::tests::line_write_error_handler_can_continue_after_sink_write_errors ... ok
[INFO] [stdout] test output_stream::visitors::write::tests::line_writer_reports_line_and_delimiter_write_errors ... ok
[INFO] [stdout] test output_stream::visitors::write::tests::line_writer_respects_requested_delimiter_mode ... ok
[INFO] [stdout] test output_stream::visitors::write::tests::mapped_writers_return_sink_write_errors ... ok
[INFO] [stdout] test output_stream::line::parser::tests::properties::embedded_nuls_are_treated_as_content ... ok
[INFO] [stdout] test panic_on_drop::tests::defuse_is_idempotent ... ok
[INFO] [stdout] test panic_on_drop::tests::defused_drop_does_not_panic ... ok
[INFO] [stdout] test panic_on_drop::tests::needs_drop ... ok
[INFO] [stdout] test process::name::tests::auto_name_debug_uses_command_debug_string ... ok
[INFO] [stdout] test process::name::tests::auto_name_defaults_to_safe_program_only_naming ... ok
[INFO] [stdout] test process::name::tests::auto_name_presets_match_settings_and_expected_output ... ok
[INFO] [stdout] test process::name::tests::auto_name_settings_builder_supports_custom_combination ... ok
[INFO] [stdout] test output_stream::line::parser::tests::properties::single_byte_chunks_match_single_chunk ... ok
[INFO] [stdout] test output_stream::line::parser::tests::properties::drop_additional_caps_emitted_line_length ... ok
[INFO] [stdout] test async_drop::tests::single_threaded_runtime_panic_names_terminate_on_drop ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::from_stream_panics_on_zero_max_buffered_chunks - should panic ... ok
[INFO] [stdout] test process_handle::output_collection::drain::tests::timed_output_collection_cancels_hanging_single_subscriber_sibling_after_error ... ok
[INFO] [stdout] test process_handle::output_collection::drain::tests::timed_output_collection_returns_early_stream_read_error_before_deadline ... ok
[INFO] [stdout] test output_stream::line::parser::tests::properties::rechunking_preserves_lines ... ok
[INFO] [stdout] test process_handle::termination::diagnostics::tests::termination_failed_preserves_recorded_attempt_errors_in_order ... ok
[INFO] [stdout] test process_handle::termination::shutdown::tests::builder::populates_unix_terminate_only_phase ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::from_stream_panics_on_zero_read_chunk_size - should panic ... ok
[INFO] [stdout] test process_handle::termination::shutdown::tests::builder::uses_interrupt_signal_for_unix_interrupt_only ... ok
[INFO] [stdout] test process_handle::termination::shutdown::tests::unix_sequence::from_phases_preserves_iteration_order ... ok
[INFO] [stdout] test process_handle::tests::closed_stdin_reports_closed ... ok
[INFO] [stdout] test output_stream::line::adapter::tests::r#async::new_panics_when_max_line_length_is_zero - should panic ... ok
[INFO] [stdout] test output_stream::line::adapter::tests::sync::new_panics_when_max_line_length_is_zero - should panic ... ok
[INFO] [stdout] test output_stream::visitors::inspect::tests::inspect_lines::panics_when_max_line_length_is_zero - should panic ... ok
[INFO] [stdout] test output_stream::visitors::inspect::tests::inspect_lines_async::panics_when_max_line_length_is_zero - should panic ... ok
[INFO] [stdout] test output_stream::visitors::wait::tests::wait_for_line::panics_when_max_line_length_is_zero - should panic ... ok
[INFO] [stdout] test process::stream_config::tests::max_buffered_chunks::panics_on_zero_for_single_subscriber ... ok
[INFO] [stdout] test process::stream_config::tests::max_buffered_chunks::panics_on_zero_for_broadcast ... ok
[INFO] [stdout] test process::stream_config::tests::read_chunk_size::panics_on_zero_value ... ok
[INFO] [stdout] test process_handle::termination::shutdown::tests::unix_sequence::from_phases_panics_on_empty_input - should panic ... ok
[INFO] [stdout] test panic_on_drop::tests::armed_drop_panics_with_expected_message ... ok
[INFO] [stdout] test output_stream::config::tests::invalid_configs_panic_with_parameter_names ... ok
[INFO] [stdout] test output_stream::line::parser::tests::properties::gap_emits_subset_of_no_gap_run ... ok
[INFO] [stdout] test process_handle::output_collection::drain::tests::timed_output_collection_times_out_stderr_when_stdout_finishes_first ... ok
[INFO] [stdout] test process_handle::output_collection::drain::tests::timed_output_collection_times_out_stdout_when_stderr_finishes_first ... ok
[INFO] [stdout] test output_stream::backend::single_subscriber::tests::reader_backpressure::handles_backpressure_by_dropping_newer_chunks_after_channel_buffer_filled_up ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 177 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.59s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/drop_guard.rs (/opt/rustwide/target/debug/deps/drop_guard-fd9bc10972fa66bc)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test must_be_terminated_is_idempotent_when_already_armed ... ok
[INFO] [stdout] test must_not_be_terminated_lets_child_outlive_dropped_handle ... ok
[INFO] [stdout] test must_be_terminated_re_arms_safeguards_after_opt_out ... ok
[INFO] [stdout] test must_not_be_terminated_still_closes_stdin_on_drop ... ok
[INFO] [stderr]      Running tests/kill.rs (/opt/rustwide/target/debug/deps/kill-e08e376da0885eb9)
[INFO] [stdout] test must_not_be_terminated_still_closes_stdout_pipe_on_drop ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test kill_disarms_cleanup_and_panic_guards ... ok
[INFO] [stdout] test kill_future_can_be_spawned_on_tokio_task ... ok
[INFO] [stdout] test kill_propagates_to_grandchildren ... FAILED
[INFO] [stderr] error: test failed, to rerun pass `--test kill`
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- kill_propagates_to_grandchildren stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'kill_propagates_to_grandchildren' (292) panicked at tests/kill.rs:132:14:
[INFO] [stdout] -------- assertr --------
[INFO] [stdout] Assertion failed at tests/kill.rs:132:14
[INFO] [stdout] 
[INFO] [stdout] Expected: true
[INFO] [stdout] 
[INFO] [stdout]   Actual: false
[INFO] [stdout] 
[INFO] [stdout] Details: [
[INFO] [stdout]     grandchild PID 328 still alive 10 s after kill,
[INFO] [stdout] ]
[INFO] [stdout] -------- assertr --------
[INFO] [stdout] 
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x652de2807cea - std[ec419fa8110287d5]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x652de2807cea - std[ec419fa8110287d5]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec419fa8110287d5]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x652de2807cea - std[ec419fa8110287d5]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x652de2807cea - <<std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[35159d6ffb30e017]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x652de281e00a - <core[35159d6ffb30e017]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x652de281e00a - core[35159d6ffb30e017]::fmt::write
[INFO] [stdout]    6:     0x652de280dfa2 - std[ec419fa8110287d5]::io::default_write_fmt::<alloc[a8a7aba520129d98]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x652de280dfa2 - <alloc[a8a7aba520129d98]::vec::Vec<u8> as std[ec419fa8110287d5]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x652de27e5dcf - <std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x652de27e5dcf - std[ec419fa8110287d5]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x652de27ffcf9 - std[ec419fa8110287d5]::panicking::default_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x652de26e10cc - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x652de26e10cc - test[a8007afcd3effadc]::test_main_inner::<test[a8007afcd3effadc]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x652de27fff72 - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x652de27fff72 - std[ec419fa8110287d5]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x652de27e5e88 - std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x652de27dd2c9 - std[ec419fa8110287d5]::sys::backtrace::__rust_end_short_backtrace::<std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x652de27e6bed - __rustc[cfb3622dd870db93]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x652de281e7cc - core[35159d6ffb30e017]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x652de26ce229 - <assertr[5805f1650a67048]::AssertThat<bool, assertr[5805f1650a67048]::mode::Panic>>::fail::<<assertr[5805f1650a67048]::AssertThat<bool, assertr[5805f1650a67048]::mode::Panic> as assertr[5805f1650a67048]::assertions::core::bool::BoolAssertions>::is_true::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/assertr-0.6.0/src/failure.rs:77:13
[INFO] [stdout]   20:     0x652de26d3413 - <assertr[5805f1650a67048]::AssertThat<bool, assertr[5805f1650a67048]::mode::Panic> as assertr[5805f1650a67048]::assertions::core::bool::BoolAssertions>::is_true
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/assertr-0.6.0/src/assertions/core/bool.rs:23:18
[INFO] [stdout]   21:     0x652de2699e33 - kill[bd92b0e8394685de]::kill_propagates_to_grandchildren::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/kill.rs:132:14
[INFO] [stdout]   22:     0x652de269d4d2 - <core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>> as core[35159d6ffb30e017]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/future/future.rs:133:9
[INFO] [stdout]   23:     0x652de26d0e4d - <tokio[621a320c2f7392cf]::runtime::park::CachedParkThread>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.2/src/runtime/park.rs:284:71
[INFO] [stdout]   24:     0x652de26ced82 - tokio[621a320c2f7392cf]::task::coop::with_budget::<core[35159d6ffb30e017]::task::poll::Poll<()>, <tokio[621a320c2f7392cf]::runtime::park::CachedParkThread>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.2/src/task/coop/mod.rs:167:5
[INFO] [stdout]   25:     0x652de26ced82 - tokio[621a320c2f7392cf]::task::coop::budget::<core[35159d6ffb30e017]::task::poll::Poll<()>, <tokio[621a320c2f7392cf]::runtime::park::CachedParkThread>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.2/src/task/coop/mod.rs:133:5
[INFO] [stdout]   26:     0x652de26ced82 - <tokio[621a320c2f7392cf]::runtime::park::CachedParkThread>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.2/src/runtime/park.rs:284:31
[INFO] [stdout]   27:     0x652de26bd164 - <tokio[621a320c2f7392cf]::runtime::context::blocking::BlockingRegionGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.2/src/runtime/context/blocking.rs:66:14
[INFO] [stdout]   28:     0x652de2695ed8 - <tokio[621a320c2f7392cf]::runtime::scheduler::multi_thread::MultiThread>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.2/src/runtime/scheduler/multi_thread/mod.rs:92:22
[INFO] [stdout]   29:     0x652de2687d7b - tokio[621a320c2f7392cf]::runtime::context::runtime::enter_runtime::<<tokio[621a320c2f7392cf]::runtime::scheduler::multi_thread::MultiThread>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.2/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   30:     0x652de2694384 - <tokio[621a320c2f7392cf]::runtime::scheduler::multi_thread::MultiThread>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.2/src/runtime/scheduler/multi_thread/mod.rs:91:9
[INFO] [stdout]   31:     0x652de26777d4 - <tokio[621a320c2f7392cf]::runtime::runtime::Runtime>::block_on_inner::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.2/src/runtime/runtime.rs:373:50
[INFO] [stdout]   32:     0x652de26779cf - <tokio[621a320c2f7392cf]::runtime::runtime::Runtime>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.2/src/runtime/runtime.rs:345:18
[INFO] [stdout]   33:     0x652de269b441 - kill[bd92b0e8394685de]::kill_propagates_to_grandchildren
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/kill.rs:124:10
[INFO] [stdout]   34:     0x652de2699037 - kill[bd92b0e8394685de]::kill_propagates_to_grandchildren::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/kill.rs:50:44
[INFO] [stdout]   35:     0x652de26763a6 - <kill[bd92b0e8394685de]::kill_propagates_to_grandchildren::{closure#0} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   36:     0x652de26d43ab - <fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   37:     0x652de26d43ab - test[a8007afcd3effadc]::__rust_begin_short_backtrace::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:724:18
[INFO] [stdout]   38:     0x652de26e1b9b - test[a8007afcd3effadc]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:74
[INFO] [stdout]   39:     0x652de26e1b9b - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   40:     0x652de26e1b9b - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   41:     0x652de26e1b9b - std[ec419fa8110287d5]::panicking::catch_unwind::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   42:     0x652de26e1b9b - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   43:     0x652de26e1b9b - test[a8007afcd3effadc]::run_test_in_process
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:27
[INFO] [stdout]   44:     0x652de26e1b9b - test[a8007afcd3effadc]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:668:43
[INFO] [stdout]   45:     0x652de26dc574 - test[a8007afcd3effadc]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:698:41
[INFO] [stdout]   46:     0x652de26dc574 - std[ec419fa8110287d5]::sys::backtrace::__rust_begin_short_backtrace::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   47:     0x652de26e47a2 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   48:     0x652de26e47a2 - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   49:     0x652de26e47a2 - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   50:     0x652de26e47a2 - std[ec419fa8110287d5]::panicking::catch_unwind::<(), core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   51:     0x652de26e47a2 - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   52:     0x652de26e47a2 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   53:     0x652de26e47a2 - <std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   54:     0x652de280738f - <alloc[a8a7aba520129d98]::boxed::Box<dyn core[35159d6ffb30e017]::ops::function::FnOnce<(), Output = ()> + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   55:     0x652de280738f - <std[ec419fa8110287d5]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   56:     0x78c6d3760aa4 - <unknown>
[INFO] [stdout]   57:     0x78c6d37eda64 - clone
[INFO] [stdout]   58:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     kill_propagates_to_grandchildren
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 2 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 10.15s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "14db37d7f00503701d6aaa99b4996db993119e69080d069c18fe2e426d8918e8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "14db37d7f00503701d6aaa99b4996db993119e69080d069c18fe2e426d8918e8", kill_on_drop: false }`
[INFO] [stdout] 14db37d7f00503701d6aaa99b4996db993119e69080d069c18fe2e426d8918e8
