[INFO] fetching crate sharpebench-sim 0.28.0...
[INFO] testing sharpebench-sim-0.28.0 against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate sharpebench-sim 0.28.0 into /workspace/builds/worker-1-tc2/source
[INFO] started tweaking crates.io crate sharpebench-sim 0.28.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate sharpebench-sim 0.28.0
[INFO] tweaked toml for crates.io crate sharpebench-sim 0.28.0 written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate sharpebench-sim 0.28.0 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 sharpebench-sim 0.28.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+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-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 2ec1f1b9bf620798ca561d31523691ac858e2d55e8b9a77892cd027b64fd8460
[INFO] running `Command { std: "docker" "start" "2ec1f1b9bf620798ca561d31523691ac858e2d55e8b9a77892cd027b64fd8460", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2ec1f1b9bf620798ca561d31523691ac858e2d55e8b9a77892cd027b64fd8460", 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" "2ec1f1b9bf620798ca561d31523691ac858e2d55e8b9a77892cd027b64fd8460" "/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" "2ec1f1b9bf620798ca561d31523691ac858e2d55e8b9a77892cd027b64fd8460", 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" "2ec1f1b9bf620798ca561d31523691ac858e2d55e8b9a77892cd027b64fd8460" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling cpufeatures v0.3.1
[INFO] [stderr]    Compiling sharpebench-stats v0.28.0
[INFO] [stderr]    Compiling hybrid-array v0.4.15
[INFO] [stderr]    Compiling syn v3.0.5
[INFO] [stderr]    Compiling crypto-common v0.2.2
[INFO] [stderr]    Compiling block-buffer v0.12.1
[INFO] [stderr]    Compiling digest v0.11.3
[INFO] [stderr]    Compiling sha2 v0.11.0
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling sharpebench-protocol v0.28.0
[INFO] [stderr]    Compiling sharpebench-core v0.28.0
[INFO] [stderr]    Compiling sharpebench-sim v0.28.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 54.32s
[INFO] running `Command { std: "docker" "inspect" "2ec1f1b9bf620798ca561d31523691ac858e2d55e8b9a77892cd027b64fd8460", 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" "2ec1f1b9bf620798ca561d31523691ac858e2d55e8b9a77892cd027b64fd8460" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling sharpebench-sim v0.28.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 25.50s
[INFO] running `Command { std: "docker" "inspect" "2ec1f1b9bf620798ca561d31523691ac858e2d55e8b9a77892cd027b64fd8460", 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" "2ec1f1b9bf620798ca561d31523691ac858e2d55e8b9a77892cd027b64fd8460" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/build/sharpebench-sim/06e1a46997d2757e/out/sharpebench_sim-06e1a46997d2757e)
[INFO] [stdout] 
[INFO] [stdout] running 127 tests
[INFO] [stdout] test agent::tests::momentum_ignores_history_before_the_requested_window ... ok
[INFO] [stdout] test agent::tests::momentum_invalid_window_or_prices_cannot_allocate_or_panic ... ok
[INFO] [stdout] test costs::tests::a_set_borrow_rate_is_serialized_and_read_back ... ok
[INFO] [stdout] test costs::tests::a_zero_borrow_rate_leaves_the_serialized_cost_model_unchanged ... ok
[INFO] [stdout] test costs::tests::execution_noise_validation_rejects_unsafe_public_values ... ok
[INFO] [stdout] test agent::tests::risk_managed_scales_gross_down_with_volatility ... ok
[INFO] [stdout] test agent::tests::momentum_lookbacks_can_choose_opposite_positions ... ok
[INFO] [stdout] test agent::tests::risk_managed_is_flat_during_warmup ... ok
[INFO] [stdout] test costs::tests::noise_stream_is_a_pure_function_of_seed_step_symbol ... ok
[INFO] [stdout] test costs::tests::financing_only_bites_above_full_investment ... ok
[INFO] [stdout] test agent::tests::momentum_requires_exactly_lookback_plus_one_closes ... ok
[INFO] [stdout] test costs::tests::impact_grows_with_participation ... ok
[INFO] [stdout] test costs::tests::impact_is_concave ... ok
[INFO] [stdout] test costs::tests::liquidity_cap_clamps_large_trades ... ok
[INFO] [stdout] test agent::tests::random_agent_varies_on_single_symbol_universe ... ok
[INFO] [stdout] test costs::tests::profile_none_is_frictionless ... ok
[INFO] [stdout] test costs::tests::trf_factor_matches_hand_computed_fixture ... ok
[INFO] [stdout] test costs::tests::a_negative_zero_borrow_rate_is_written_as_no_rate ... ok
[INFO] [stdout] test agent::tests::momentum_unavailable_symbols_do_not_dilute_the_winners ... ok
[INFO] [stdout] test costs::tests::reported_profile_names_are_the_names_in_the_evidence_records ... ok
[INFO] [stdout] test costs::tests::short_borrow_bites_on_every_short_dollar_without_a_threshold ... ok
[INFO] [stdout] test costs::tests::trf_cost_defaults_to_none_and_is_byte_neutral ... ok
[INFO] [stdout] test costs::tests::worst_case_is_strictly_harsher_with_delay ... ok
[INFO] [stdout] test costs::tests::realistic_profile_is_typical_costs_plus_noise ... ok
[INFO] [stdout] test costs::tests::named_profiles_charge_no_short_borrow ... ok
[INFO] [stdout] test data::tests::csv_requires_valid_complete_economic_rows ... ok
[INFO] [stdout] test data::tests::dividend_yield_builder_pays_a_fraction_of_price ... ok
[INFO] [stdout] test data::tests::from_csv_aligns_on_common_dates ... ok
[INFO] [stdout] test data::tests::from_csv_rejects_malformed_input ... ok
[INFO] [stdout] test data::tests::history_is_point_in_time ... ok
[INFO] [stdout] test data::tests::masking_preserves_dividends_under_the_price_symbol_mapping ... ok
[INFO] [stdout] test data::tests::flash_crash_has_a_big_drop ... ok
[INFO] [stdout] test data::tests::raw_csv_preserves_signed_quotes_without_implying_return_model_validity ... ok
[INFO] [stdout] test data::tests::stress_suite_has_scenarios ... ok
[INFO] [stdout] test data::tests::synthetic_is_byte_identical_golden ... ok
[INFO] [stdout] test data::tests::synthetic_is_deterministic ... ok
[INFO] [stdout] test data::tests::vol_mult_widens_the_path_and_jumps_perturb_it ... ok
[INFO] [stdout] test agent::tests::risk_managed_halts_on_drawdown_and_reenters_on_fresh_trend ... ok
[INFO] [stdout] test agent::tests::risk_managed_is_deterministic ... ok
[INFO] [stdout] test costs::tests::profile_typical_matches_default_costs_no_delay ... ok
[INFO] [stdout] test costs::tests::short_borrow_validation_boundary_refuses_a_rebate_or_a_non_finite_rate ... ok
[INFO] [stdout] test data::tests::masking_anonymizes_but_preserves_prices ... ok
[INFO] [stdout] test costs::tests::trf_factor_converges_within_the_pinned_cap ... ok
[INFO] [stdout] test data::tests::csv_duplicate_keys_and_ambiguous_columns_are_refused ... ok
[INFO] [stdout] test data::tests::whipsaw_has_near_zero_drift ... ok
[INFO] [stdout] test costs::tests::noise_field_is_serde_default_so_old_configs_still_parse ... ok
[INFO] [stdout] test costs::tests::trf_factor_zero_cost_is_unity ... ok
[INFO] [stdout] test agent::tests::risk_managed_is_flat_in_a_downtrend ... ok
[INFO] [stdout] test engine::tests::backtest_produces_returns_and_trace ... ok
[INFO] [stdout] test engine::tests::carried_order_fills_next_bar_for_a_non_reissuing_agent ... ok
[INFO] [stdout] test engine::tests::different_seeds_diverge ... ok
[INFO] [stdout] test engine::tests::execution_costs_debit_cash_not_target_quantity ... ok
[INFO] [stdout] test engine::tests::costly_rebalances_reach_target_inventory_without_crossing_flat ... ok
[INFO] [stdout] test engine::tests::financing_costs_reduce_leveraged_returns ... ok
[INFO] [stdout] test engine::tests::fresh_order_supersedes_a_carried_one ... ok
[INFO] [stdout] test engine::tests::default_profile_ignores_the_noise_machinery ... ok
[INFO] [stdout] test engine::tests::delayed_fill_records_one_decision_and_keeps_its_rationale ... ok
[INFO] [stdout] test engine::tests::dividends_lift_buy_and_hold_return ... ok
[INFO] [stdout] test engine::tests::liquidity_cap_changes_fills ... ok
[INFO] [stdout] test engine::tests::per_order_rationale_is_captured_into_the_trace ... ok
[INFO] [stdout] test engine::tests::realistic_profile_changes_fills ... ok
[INFO] [stdout] test env::tests::crisis_suite_scenarios_run ... ok
[INFO] [stdout] test engine::tests::signed_targets_open_shorts_and_financing_uses_gross_exposure ... ok
[INFO] [stdout] test env::tests::clone_restore_state_reproduces_trajectory ... ok
[INFO] [stdout] test env::tests::env_step_matches_run_backtest ... ok
[INFO] [stdout] test env::tests::env_state_serializes_round_trip ... ok
[INFO] [stdout] test external::tests::agent_environment_resolves_allowlist_extras_and_passthrough_only ... ok
[INFO] [stdout] test external::tests::an_oversized_line_is_scored_as_an_agent_fault ... ok
[INFO] [stdout] test external::tests::credential_values_stay_out_of_the_environment_identity ... ok
[INFO] [stdout] test env::tests::env_observation_is_point_in_time ... ok
[INFO] [stdout] test external::tests::external_wire_parser_fails_closed_on_semantic_faults ... ok
[INFO] [stdout] test external::tests::effective_nonsecret_values_change_the_environment_identity ... ok
[INFO] [stdout] test external::tests::cumulative_stdout_quota_accepts_the_boundary_and_refuses_the_next_line ... ok
[INFO] [stdout] test engine::tests::realistic_profile_is_deterministic_per_seed ... ok
[INFO] [stdout] test replay_nulls::tests::a_layout_draws_every_placement_about_equally_often ... ok
[INFO] [stdout] test engine::tests::self_reported_cost_populates_run_cost_and_dsr_per_cost ... ok
[INFO] [stdout] test replay_nulls::tests::a_saturated_percentile_reports_an_exact_bound_and_no_plug_in_error ... ok
[INFO] [stdout] test replay_nulls::tests::holding_periods_are_the_maximal_invested_runs ... ok
[INFO] [stdout] test engine::tests::realistic_seeds_are_distinct_but_bounded ... ok
[INFO] [stdout] test replay_nulls::tests::the_placement_space_caps_the_percentile ... ok
[INFO] [stdout] test replay_nulls::tests::a_layout_keeps_every_period_whole_and_apart_inside_the_window ... ok
[INFO] [stdout] test replay_nulls::tests::window_streams_differ_by_window_and_by_seed ... ok
[INFO] [stdout] test sizing_response::tests::a_flat_agent_reports_constant_zero_exposure ... ok
[INFO] [stdout] test sizing_response::tests::a_short_or_misaligned_trajectory_is_refused ... ok
[INFO] [stdout] test replay_nulls::tests::the_percentile_counts_ties_as_half ... ok
[INFO] [stdout] test sizing_response::tests::a_volatility_targeting_agent_sizes_down_and_correlates_negatively ... ok
[INFO] [stdout] test sizing_response::tests::an_agent_that_sizes_up_in_turbulence_correlates_positively ... ok
[INFO] [stdout] test sizing_response::tests::gross_exposure_counts_shorts_at_their_absolute_value ... ok
[INFO] [stdout] test sizing_response::tests::exposure_is_measured_against_the_nav_the_target_was_sized_on ... ok
[INFO] [stdout] test external::tests::a_child_dead_at_startup_fails_fast_as_an_exit_not_a_timeout ... ok
[INFO] [stdout] test external::tests::a_variable_named_in_the_passthrough_reaches_the_agent ... ok
[INFO] [stdout] test sizing_response::tests::buy_and_hold_reports_constant_exposure_not_a_correlation ... ok
[INFO] [stdout] test sizing_response::tests::out_of_domain_parameters_are_refused ... ok
[INFO] [stdout] test external::tests::a_dead_child_whose_pipe_is_held_open_is_still_detected ... ok
[INFO] [stdout] test sizing_response::tests::the_replayed_book_is_the_scored_book ... ok
[INFO] [stdout] test sizing_response::tests::the_report_serializes_reasons_by_name ... ok
[INFO] [stdout] test sizing_response::tests::tied_volatilities_share_a_quintile ... ok
[INFO] [stdout] test replay_nulls::tests::the_placement_count_is_the_support_of_the_layout ... ok
[INFO] [stdout] test sizing_response::tests::the_first_pair_waits_for_a_full_window ... ok
[INFO] [stdout] test trajectory::tests::a_regrade_that_would_invent_a_decision_is_refused ... ok
[INFO] [stdout] test sizing_response::tests::trailing_volatility_never_reads_a_later_close ... ok
[INFO] [stdout] test trajectory::tests::a_regrade_without_a_reason_or_a_source_identity_is_refused ... ok
[INFO] [stdout] test trajectory::tests::a_regrade_records_every_changed_evaluator_input ... ok
[INFO] [stdout] test trajectory::tests::a_superseding_grade_never_replaces_frozen_published_evidence ... ok
[INFO] [stdout] test external::tests::a_spawned_agent_does_not_inherit_the_harness_environment ... ok
[INFO] [stdout] test trajectory::tests::a_regrade_buys_no_decisions_and_leaves_the_source_artifact_alone ... ok
[INFO] [stdout] test trajectory::tests::capture_matches_a_plain_run ... ok
[INFO] [stdout] test external::tests::an_agent_that_answers_then_exits_is_a_success_not_an_exit_fault ... ok
[INFO] [stdout] test sizing_response::tests::too_few_pairs_and_constant_volatility_are_typed ... ok
[INFO] [stdout] test trajectory::tests::tampered_trajectory_yields_a_different_run ... ok
[INFO] [stdout] test transport::tests::an_exit_is_retryable_and_counts_as_a_transport_fault ... ok
[INFO] [stdout] test transport::tests::health_records_faults_distinctly ... ok
[INFO] [stdout] test transport::tests::breaker_trips_after_consecutive_faults_and_resets_on_success ... ok
[INFO] [stdout] test trajectory::tests::trajectory_records_one_step_per_window_day ... ok
[INFO] [stdout] test transport::tests::retry_recovers_a_transient_blip ... ok
[INFO] [stdout] test trajectory::tests::capture_then_replay_is_byte_identical ... ok
[INFO] [stdout] test windows::tests::regime_classifies_trends ... ok
[INFO] [stdout] test transport::tests::persistent_transport_fault_exhausts_retries ... ok
[INFO] [stdout] test transport::tests::protocol_fault_is_not_retried ... ok
[INFO] [stdout] test external::tests::stdout_backpressure_bounds_consumption_without_dropping_lines ... ok
[INFO] [stdout] test windows::tests::walk_forward_disjoint_and_stepped ... ok
[INFO] [stdout] test external::tests::one_decision_line_is_bounded_at_the_budget_and_not_before_it ... ok
[INFO] [stdout] test external::tests::the_decision_deadline_includes_a_child_that_never_reads_stdin ... ok
[INFO] [stdout] test external::tests::the_post_exit_drain_delivers_a_line_in_flight_and_rules_only_on_silence ... ok
[INFO] [stdout] test external::tests::an_http_endpoint_trickling_bytes_cannot_outlast_the_decision_budget ... ok
[INFO] [stdout] test external::tests::a_silent_subprocess_times_out_instead_of_hanging_the_harness ... ok
[INFO] [stdout] test external::tests::teardown_reaches_a_grandchild_that_holds_the_stdout_pipe ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- external::tests::teardown_reaches_a_grandchild_that_holds_the_stdout_pipe stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'external::tests::teardown_reaches_a_grandchild_that_holds_the_stdout_pipe' (804) panicked at src/external.rs:1169:9:
[INFO] [stdout] the backgrounded grandchild outlived the teardown, so it is still holding the stdout pipe open
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e79f16e7b61 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5e79f16fe6ca - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5e79f16ec43c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5e79f16c1af6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5e79f16df629 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5e79f1650720 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5e79f16df7e2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5e79f16c1bd4 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5e79f16ba439 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5e79f16c2a3d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5e79f16fedfc - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5e79f1607bc4 - <sharpebench_sim[8dd580a03f4097f1]::external::tests::teardown_reaches_a_grandchild_that_holds_the_stdout_pipe::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   12:     0x5e79f1643b6b - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   13:     0x5e79f1650d45 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   14:     0x5e79f164a634 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   15:     0x5e79f1653dd2 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   16:     0x5e79f16e6a9f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   17:     0x7d274cc33dfa - <unknown>
[INFO] [stdout]   18:     0x7d274ccc73d4 - clone
[INFO] [stdout]   19:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     external::tests::teardown_reaches_a_grandchild_that_holds_the_stdout_pipe
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 126 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.17s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "2ec1f1b9bf620798ca561d31523691ac858e2d55e8b9a77892cd027b64fd8460", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2ec1f1b9bf620798ca561d31523691ac858e2d55e8b9a77892cd027b64fd8460", kill_on_drop: false }`
[INFO] [stdout] 2ec1f1b9bf620798ca561d31523691ac858e2d55e8b9a77892cd027b64fd8460
