[INFO] fetching crate rustible-sdk 0.8.1...
[INFO] testing rustible-sdk-0.8.1 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate rustible-sdk 0.8.1 into /workspace/builds/worker-1-tc1/source
[INFO] started tweaking crates.io crate rustible-sdk 0.8.1
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate rustible-sdk 0.8.1
[INFO] tweaked toml for crates.io crate rustible-sdk 0.8.1 written to /workspace/builds/worker-1-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate rustible-sdk 0.8.1 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate rustible-sdk 0.8.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.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded ref-cast-impl v1.0.27
[INFO] [stderr]   Downloaded similar v2.7.0
[INFO] [stderr]   Downloaded zeroize v1.9.0
[INFO] [stderr]   Downloaded ref-cast v1.0.27
[INFO] [stderr]   Downloaded schemars_derive v1.2.2
[INFO] [stderr]   Downloaded serde_derive_internals v0.30.0
[INFO] [stderr]   Downloaded thiserror-impl v2.0.20
[INFO] [stderr]   Downloaded thiserror v2.0.20
[INFO] [stderr]   Downloaded bitflags v2.13.1
[INFO] [stderr]   Downloaded schemars v1.2.2
[INFO] [stderr]   Downloaded minijinja v3.0.0
[INFO] [stderr]   Downloaded syn v3.0.5
[INFO] [stderr]   Downloaded rustix v1.1.4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] d942adc071ae2fe5d36aad8f6a641765976c80352c0caedade3e82bfe2b2e8fc
[INFO] running `Command { std: "docker" "start" "d942adc071ae2fe5d36aad8f6a641765976c80352c0caedade3e82bfe2b2e8fc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d942adc071ae2fe5d36aad8f6a641765976c80352c0caedade3e82bfe2b2e8fc", 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" "d942adc071ae2fe5d36aad8f6a641765976c80352c0caedade3e82bfe2b2e8fc" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d942adc071ae2fe5d36aad8f6a641765976c80352c0caedade3e82bfe2b2e8fc", 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" "d942adc071ae2fe5d36aad8f6a641765976c80352c0caedade3e82bfe2b2e8fc" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v3.0.5
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling zmij v1.0.23
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling ref-cast v1.0.27
[INFO] [stderr]    Compiling anyhow v1.0.104
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling itoa v1.0.18
[INFO] [stderr]    Compiling bitflags v2.13.1
[INFO] [stderr]    Compiling hashbrown v0.17.1
[INFO] [stderr]    Compiling equivalent v1.0.2
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling fastrand v2.5.0
[INFO] [stderr]    Compiling dyn-clone v1.0.20
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling percent-encoding v2.3.2
[INFO] [stderr]    Compiling similar v2.7.0
[INFO] [stderr]    Compiling zeroize v1.9.0
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling indexmap v2.14.2
[INFO] [stderr]    Compiling serde_derive_internals v0.30.0
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling ref-cast-impl v1.0.27
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling schemars_derive v1.2.2
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling schemars v1.2.2
[INFO] [stderr]    Compiling minijinja v3.0.0
[INFO] [stderr]    Compiling rustible-sdk v0.8.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 53.29s
[INFO] running `Command { std: "docker" "inspect" "d942adc071ae2fe5d36aad8f6a641765976c80352c0caedade3e82bfe2b2e8fc", 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" "d942adc071ae2fe5d36aad8f6a641765976c80352c0caedade3e82bfe2b2e8fc" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling rustible-sdk v0.8.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 50.02s
[INFO] running `Command { std: "docker" "inspect" "d942adc071ae2fe5d36aad8f6a641765976c80352c0caedade3e82bfe2b2e8fc", 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" "d942adc071ae2fe5d36aad8f6a641765976c80352c0caedade3e82bfe2b2e8fc" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.07s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/rustible_sdk-1c758b42a9831eb6)
[INFO] [stdout] 
[INFO] [stdout] running 365 tests
[INFO] [stdout] test backend::elevated::tests::a_frame_over_the_limit_is_a_corrupt_stream_and_is_latched ... ok
[INFO] [stdout] test backend::elevated::tests::a_commands_output_is_measured_exactly_without_encoding_it ... ok
[INFO] [stdout] test backend::elevated::tests::a_commands_env_reaches_the_child_through_the_helper ... ok
[INFO] [stdout] test backend::elevated::tests::a_dead_helper_carries_the_spawners_note ... ok
[INFO] [stdout] test backend::elevated::tests::a_bare_refusal_still_says_what_was_refused ... ok
[INFO] [stdout] test backend::elevated::tests::a_chunk_frame_is_built_without_growing ... ok
[INFO] [stdout] test backend::elevated::tests::a_full_table_refuses_before_any_side_effect ... ok
[INFO] [stdout] test backend::elevated::tests::a_name_that_is_not_utf8_works_through_the_helper ... ok
[INFO] [stdout] test backend::elevated::tests::a_helper_that_cannot_start_names_a_missing_account_and_only_then ... ok
[INFO] [stdout] test backend::elevated::tests::a_chunk_at_the_wrong_offset_abandons_the_write ... ok
[INFO] [stdout] test backend::elevated::tests::a_parent_gone_mid_write_leaves_nothing ... ok
[INFO] [stdout] test backend::elevated::tests::a_child_the_signal_misses_is_reaped_through_eof ... ok
[INFO] [stdout] test backend::elevated::tests::a_dead_helper_fails_its_step_like_any_other_failure ... ok
[INFO] [stdout] test backend::elevated::tests::a_listing_of_several_batches_comes_back_whole_and_sorted ... ok
[INFO] [stdout] test backend::elevated::tests::a_dead_helpers_report_reaches_a_step_once ... ok
[INFO] [stdout] test backend::elevated::tests::a_read_and_a_write_interleave_on_one_helper ... ok
[INFO] [stdout] test backend::elevated::tests::a_staged_write_is_0600_between_two_chunks_through_the_helper ... ok
[INFO] [stdout] test backend::elevated::tests::a_source_that_fails_writes_nothing ... ok
[INFO] [stdout] test backend::elevated::tests::a_rejected_password_is_refused_instead_of_hanging ... ok
[INFO] [stdout] test backend::elevated::tests::a_root_helper_without_a_password_starts_as_it_always_did ... ok
[INFO] [stdout] test backend::elevated::tests::a_stream_of_another_kind_is_not_ended ... ok
[INFO] [stdout] test backend::elevated::tests::a_rewrite_through_the_helper_keeps_setuid_and_setgid ... ok
[INFO] [stdout] test backend::elevated::tests::an_unexpected_answer_quotes_nothing ... ok
[INFO] [stdout] test backend::elevated::tests::an_escalated_read_leaves_no_copy_behind ... ok
[INFO] [stdout] test backend::elevated::tests::a_commands_large_stdin_and_output_cross_in_chunks ... ok
[INFO] [stdout] test backend::elevated::tests::dead_helper_reports_exit_and_stderr ... ok
[INFO] [stdout] test backend::elevated::tests::measure_one_gib_through_the_helper ... ignored, a measurement, run by hand in release
[INFO] [stdout] test backend::elevated::tests::an_oversized_request_is_refused_without_latching ... ok
[INFO] [stdout] test backend::elevated::tests::helper_refuses_mutations_while_checking ... ok
[INFO] [stdout] test backend::elevated::tests::an_unknown_handle_is_ebadf_and_releasing_one_is_fine ... ok
[INFO] [stdout] test backend::elevated::tests::a_root_helper_with_a_password_waits_for_its_ready_byte ... ok
[INFO] [stdout] test backend::elevated::tests::output_that_fits_the_frame_exactly_is_answered_whole ... ok
[INFO] [stdout] test backend::elevated::tests::files_of_every_size_round_trip_and_a_small_one_is_one_round_trip ... ok
[INFO] [stdout] test backend::elevated::tests::a_cold_then_warm_helper_runs_from_the_accounts_own_copy ... ok
[INFO] [stdout] test backend::elevated::tests::streamed_spawn_behind_a_stand_in_sudo ... ignored, run by the tests that call behind_stand_in_sudo
[INFO] [stdout] test backend::elevated::tests::releasing_a_stream_never_spawns_a_helper_or_panics ... ok
[INFO] [stdout] test backend::elevated::tests::primitives_round_trip_through_the_helper_loop ... ok
[INFO] [stdout] test backend::elevated::tests::the_reader_keeps_each_chunks_remainder ... ok
[INFO] [stdout] test backend::elevated::tests::the_refusal_fits_a_small_frame_whatever_the_request_said ... ok
[INFO] [stdout] test backend::fake::tests::a_kept_owner_that_cannot_be_given_does_not_fail_a_staged_write ... ok
[INFO] [stdout] test backend::fake::tests::a_refused_owner_fails_a_staged_write_and_leaves_the_target ... ok
[INFO] [stdout] test backend::elevated::tests::a_password_is_fed_before_each_streamed_spawn ... ok
[INFO] [stdout] test backend::fake::tests::a_write_at_a_symlink_takes_the_targets_mode ... ok
[INFO] [stdout] test backend::fake::tests::chown_clears_the_bits_linux_clears ... ok
[INFO] [stdout] test backend::fake::tests::read_dir_lists_direct_children_only ... ok
[INFO] [stdout] test backend::fake::tests::read_link_on_non_symlink_fails ... ok
[INFO] [stdout] test backend::fake::tests::reads_are_logged_with_the_bytes_served ... ok
[INFO] [stdout] test backend::fake::tests::remove_is_not_recursive_but_remove_all_is ... ok
[INFO] [stdout] test backend::fake::tests::rename_moves_entries_and_replaces_the_target ... ok
[INFO] [stdout] test backend::fake::tests::a_rewrite_keeps_owner_and_mode_setuid_included ... ok
[INFO] [stdout] test backend::fake::tests::set_mode_and_set_owner_follow_symlinks_as_chmod_does ... ok
[INFO] [stdout] test backend::fake::tests::set_mode_through_a_dangling_symlink_is_not_found ... ok
[INFO] [stdout] test backend::fake::tests::set_owner_clears_setuid_and_every_call_is_recorded ... ok
[INFO] [stdout] test backend::fake::tests::symlink_read_link_and_stat_kind ... ok
[INFO] [stdout] test backend::fake::tests::write_from_applies_attributes_to_the_staged_file_before_the_rename ... ok
[INFO] [stdout] test backend::local::tests::a_copy_that_cannot_be_given_its_owner_is_kept ... ok
[INFO] [stdout] test backend::elevated::tests::reads_of_several_chunks_are_allowed_while_checking ... ok
[INFO] [stdout] test backend::local::tests::a_copy_that_fails_part_way_leaves_nothing ... ok
[INFO] [stdout] test backend::fake::tests::symlinks_are_followed_by_read_and_stat_follow_but_not_stat ... ok
[INFO] [stdout] test backend::local::tests::a_new_file_given_a_mode_is_created_at_0600 ... ok
[INFO] [stdout] test backend::local::tests::a_requested_owner_that_is_refused_leaves_the_target_untouched ... ok
[INFO] [stdout] test backend::elevated::tests::the_65th_stream_is_refused_and_closing_one_frees_a_slot ... ok
[INFO] [stdout] test backend::local::tests::a_new_file_gets_the_umask_mode_unless_one_is_asked_for ... ok
[INFO] [stdout] test backend::local::tests::a_requested_mode_is_masked_to_its_permission_bits ... ok
[INFO] [stdout] test backend::local::tests::a_rewrite_given_a_mode_keeps_the_rest ... ok
[INFO] [stdout] test backend::elevated::tests::no_frame_the_helper_writes_is_over_its_limit ... ok
[INFO] [stdout] test backend::elevated::tests::no_home_and_no_temp_directory_is_refused_naming_both ... ok
[INFO] [stdout] test backend::local::tests::an_uncommitted_write_leaves_nothing ... ok
[INFO] [stdout] test backend::local::tests::copy_drops_setuid_setgid_and_sticky ... ok
[INFO] [stdout] test backend::local::tests::copy_never_writes_through_a_link_or_an_existing_file ... ok
[INFO] [stdout] test backend::local::tests::a_write_at_a_symlink_takes_the_targets_mode ... ok
[INFO] [stdout] test backend::local::tests::creation_mode_is_0600_unless_a_new_file_keeps_the_umask_mode ... ok
[INFO] [stdout] test backend::local::tests::symlink_read_link_read_dir_on_real_fs ... ok
[INFO] [stdout] test backend::elevated::tests::an_account_without_a_home_gets_a_private_temp_copy ... ok
[INFO] [stdout] test backend::elevated::tests::sudo_refusing_an_account_that_does_not_exist_names_the_account ... ok
[INFO] [stdout] test backend::tests::attr_steps_put_setuid_and_setgid_after_the_owner ... ok
[INFO] [stdout] test channel::tests::a_local_fetch_replaces_its_destination_only_on_its_last_chunk ... ok
[INFO] [stdout] test backend::local::tests::copy_refuses_a_fifo_without_blocking ... ok
[INFO] [stdout] test channel::tests::cancel_flag_is_sticky_and_keeps_first_reason ... ok
[INFO] [stdout] test backend::local::tests::the_target_is_looked_at_when_the_write_commits ... ok
[INFO] [stdout] test backend::local::tests::the_staged_file_is_0600_between_two_chunks ... ok
[INFO] [stdout] test channel::tests::eof_on_the_channel_cancels ... ok
[INFO] [stdout] test backend::local::tests::a_rewrite_keeps_setuid_and_setgid ... ok
[INFO] [stdout] test channel::tests::abandoning_a_transfer_does_not_wedge_the_reader ... ok
[INFO] [stdout] test channel::tests::denial_and_eof_surface_as_errors ... ok
[INFO] [stdout] test channel::tests::file_frames_are_matched_by_request_id_and_may_overlap ... ok
[INFO] [stdout] test ctx::tests::a_block_holding_a_step_is_transparent_to_the_steps_methods ... ok
[INFO] [stdout] test ctx::tests::a_block_moves_no_counter_and_draws_no_id ... ok
[INFO] [stdout] test ctx::tests::a_block_left_by_a_foreign_panic_is_closed ... ok
[INFO] [stdout] test ctx::tests::a_block_returning_the_step_that_matters_drives_a_restart ... ok
[INFO] [stdout] test ctx::tests::a_block_returns_its_closures_value ... ok
[INFO] [stdout] test ctx::tests::a_block_that_returned_an_error_is_closed ... ok
[INFO] [stdout] test ctx::tests::a_body_error_without_a_failed_step_is_named_once_under_its_block ... ok
[INFO] [stdout] test ctx::tests::a_changed_step_reports_the_intents_diff ... ok
[INFO] [stdout] test ctx::tests::a_child_that_outlives_a_block_is_outside_it ... ok
[INFO] [stdout] test ctx::tests::a_child_made_before_a_block_is_prefixed_during_it_only ... ok
[INFO] [stdout] test ctx::tests::a_block_left_by_a_real_run_missing_output_is_closed ... ok
[INFO] [stdout] test backend::local::tests::requested_attributes_are_in_place_before_the_rename ... ok
[INFO] [stdout] test ctx::tests::a_failed_step_adds_no_block_line ... ok
[INFO] [stdout] test ctx::tests::a_failed_step_carries_the_failed_command ... ok
[INFO] [stdout] test ctx::tests::a_failed_apply_reports_the_intents_diff ... ok
[INFO] [stdout] test ctx::tests::a_foreign_panic_in_check_leaves_the_phase_idle ... ok
[INFO] [stdout] test ctx::tests::a_failed_step_is_recorded_by_id_and_its_error_carries_id_and_blocks ... ok
[INFO] [stdout] test ctx::tests::a_foreign_panic_is_resumed_after_block_finished ... ok
[INFO] [stdout] test ctx::tests::a_layer_is_claimed_only_by_the_ctx_that_attached_it ... ok
[INFO] [stdout] test ctx::tests::a_missing_output_read_inside_an_intents_diff_fails_that_step ... ok
[INFO] [stdout] test ctx::tests::a_missing_output_read_inside_check_fails_that_step ... ok
[INFO] [stdout] test ctx::tests::a_real_run_does_not_absorb_a_returned_output_unavailable ... ok
[INFO] [stdout] test ctx::tests::a_real_run_does_not_absorb_the_deref_payload ... ok
[INFO] [stdout] test ctx::tests::a_real_step_asks_nothing ... ok
[INFO] [stdout] test ctx::tests::a_sink_that_panics_on_block_started_leaves_no_frame ... ok
[INFO] [stdout] test ctx::tests::a_step_cancelled_after_check_reports_the_intents_diff ... ok
[INFO] [stdout] test ctx::tests::a_step_refused_before_it_started_records_nothing_and_names_its_blocks ... ok
[INFO] [stdout] test ctx::tests::a_ran_unchanged_step_keeps_the_intents_diff_and_says_so ... ok
[INFO] [stdout] test ctx::tests::a_missing_output_read_in_always_changes_fails_that_step ... ok
[INFO] [stdout] test ctx::tests::a_would_change_step_reports_the_intents_diff ... ok
[INFO] [stdout] test channel::tests::local_source_serves_and_writes_under_the_root ... ok
[INFO] [stdout] test ctx::tests::a_step_through_as_root_carries_the_blocks_prefix ... ok
[INFO] [stdout] test ctx::tests::an_absorption_warns_inside_the_block ... ok
[INFO] [stdout] test ctx::tests::applied_deref_unwinds_with_a_typed_payload ... ok
[INFO] [stdout] test ctx::tests::block_events_pair_up_on_a_value ... ok
[INFO] [stdout] test ctx::tests::an_absorbed_blocks_value_names_the_original_step ... ok
[INFO] [stdout] test ctx::tests::block_events_pair_up_on_absorption ... ok
[INFO] [stdout] test ctx::tests::a_block_absorbs_a_read_of_a_step_outside_it ... ok
[INFO] [stdout] test ctx::tests::block_events_pair_up_on_an_error ... ok
[INFO] [stdout] test ctx::tests::check_mode_step_has_no_output_and_never_applies ... ok
[INFO] [stdout] test ctx::tests::every_failure_path_records_the_step ... ok
[INFO] [stdout] test ctx::tests::cancelled_run_starts_no_further_step ... ok
[INFO] [stdout] test ctx::tests::cancel_during_check_skips_apply_and_fails_the_step ... ok
[INFO] [stdout] test ctx::tests::each_account_is_asked_about_once_per_run ... ok
[INFO] [stdout] test ctx::tests::fetch_under_check_sends_no_chunk_and_names_the_destination ... ok
[INFO] [stdout] test ctx::tests::is_change_tells_the_two_plans_apart ... ok
[INFO] [stdout] test ctx::tests::fetch_under_check_writes_nothing_locally_and_names_the_destination ... ok
[INFO] [stdout] test ctx::tests::probe_absorbed_reads_print_nothing ... ignored, run by an_absorbed_read_does_not_run_the_panic_hook in a child process
[INFO] [stdout] test ctx::tests::reading_an_absorbed_blocks_value_is_absorbed_by_the_outer_block ... ok
[INFO] [stdout] test ctx::tests::root_and_the_own_identity_are_never_asked_about ... ok
[INFO] [stdout] test ctx::tests::an_absorbed_read_does_not_run_the_panic_hook ... ok
[INFO] [stdout] test ctx::tests::local_file_lands_in_a_temp_dir_and_secret_stays_in_memory ... ok
[INFO] [stdout] test ctx::tests::the_catcher_count_comes_back_down_on_this_thread ... ok
[INFO] [stdout] test ctx::tests::the_error_line_is_printed_once_through_a_context_layer ... ok
[INFO] [stdout] test ctx::tests::step_events_carry_the_block_path ... ok
[INFO] [stdout] test ctx::tests::the_innermost_block_absorbs_and_the_outer_continues ... ok
[INFO] [stdout] test backend::elevated::tests::a_stream_given_up_half_way_is_released ... ok
[INFO] [stdout] test ctx::tests::under_check_a_missing_output_read_through_deref_ends_the_block ... ok
[INFO] [stdout] test ctx::tests::under_check_a_host_that_cannot_escalate_refuses_as_a_real_run_does ... ok
[INFO] [stdout] test ctx::tests::under_check_a_body_error_is_still_an_error ... ok
[INFO] [stdout] test ctx::tests::the_login_override_note_names_both_accounts_and_the_inventory_level ... ok
[INFO] [stdout] test ctx::tests::under_check_a_step_as_an_existing_account_runs_its_check ... ok
[INFO] [stdout] test ctx::tests::under_check_a_missing_output_read_with_question_mark_ends_the_block ... ok
[INFO] [stdout] test ctx::tests::under_check_a_step_as_a_missing_account_waits_without_checking ... ok
[INFO] [stdout] test diff::tests::many_collapses_the_shapes_that_would_mean_nothing ... ok
[INFO] [stdout] test ctx::tests::under_check_an_id_that_cannot_be_spawned_fails_the_step_naming_the_probe ... ok
[INFO] [stdout] test diff::tests::many_renders_its_parts_in_order ... ok
[INFO] [stdout] test ctx::tests::fetch_reads_through_sys_and_lands_under_host_name ... ok
[INFO] [stdout] test ctx::tests::with_no_catcher_a_missing_output_panics_with_its_message ... ok
[INFO] [stdout] test error::tests::a_missing_output_unwinds_silently_only_to_a_catcher_that_can_catch ... ok
[INFO] [stdout] test diff::tests::short_of_a_summary_is_its_first_line ... ok
[INFO] [stdout] test diff::tests::short_skips_parts_with_nothing_to_say ... ok
[INFO] [stdout] test error::tests::a_signalled_command_names_the_signal_instead_of_an_ambiguous_minus_one ... ok
[INFO] [stdout] test error::tests::option_context ... ok
[INFO] [stdout] test error::tests::foreign_errors_convert_with_question_mark ... ok
[INFO] [stdout] test event::tests::block_prefix_renders_the_path ... ok
[INFO] [stdout] test error::tests::context_chains_outermost_first ... ok
[INFO] [stdout] test error::tests::alternate_display_is_the_whole_chain ... ok
[INFO] [stdout] test event::tests::compact_does_not_repeat_the_command_for_a_frame_without_an_id ... ok
[INFO] [stdout] test event::tests::compact_does_not_repeat_a_one_line_diff_at_v ... ok
[INFO] [stdout] test event::tests::compact_keeps_no_command_below_v ... ok
[INFO] [stdout] test backend::elevated::tests::a_silent_spawn_is_killed_at_the_deadline ... ok
[INFO] [stdout] test event::tests::compact_needs_the_same_stderr_unless_one_was_cut ... ok
[INFO] [stdout] test event::tests::compact_names_the_failed_steps_blocks_and_counts_recovered ... ok
[INFO] [stdout] test event::tests::compact_prefixes_steps_in_blocks_and_prints_no_block_line ... ok
[INFO] [stdout] test event::tests::compact_prints_a_failed_steps_full_diff_at_v ... ok
[INFO] [stdout] test event::tests::compact_prints_a_caught_failures_command_at_v ... ok
[INFO] [stdout] test event::tests::compact_prints_an_escaped_failures_command_once ... ok
[INFO] [stdout] test event::tests::compact_prints_an_ok_steps_full_diff_at_v ... ok
[INFO] [stdout] test event::tests::the_escaped_set_is_request_rs_set_at_every_boundary ... ok
[INFO] [stdout] test facts::tests::a_truncated_sysctl_answer_falls_back_field_by_field ... ok
[INFO] [stdout] test facts::tests::darwin_sysctl_output_maps_to_the_four_fields ... ok
[INFO] [stdout] test facts::tests::distro_table_is_unchanged_by_the_macos_variant ... ok
[INFO] [stdout] test facts::tests::every_package_manager_present_is_reported_not_the_first ... ok
[INFO] [stdout] test facts::tests::no_known_manager_is_an_empty_set ... ok
[INFO] [stdout] test facts::tests::os_names_itself_as_the_kernel_spells_it ... ok
[INFO] [stdout] test event::tests::compact_prints_a_different_command_for_a_frame_without_an_id ... ok
[INFO] [stdout] test facts::tests::plist_finds_the_key_it_was_asked_for ... ok
[INFO] [stdout] test facts::tests::plist_of_rubbish_is_none_not_a_panic ... ok
[INFO] [stdout] test freed::tests::the_probe_counts_what_was_not_wiped ... ok
[INFO] [stdout] test launch::tests::a_cold_run_installs_in_the_home_and_tries_again ... ok
[INFO] [stdout] test event::tests::compact_names_the_signal_that_killed_a_command ... ok
[INFO] [stdout] test launch::tests::a_home_copy_that_still_does_not_run_falls_through_too ... ok
[INFO] [stdout] test launch::tests::a_name_without_a_content_hash_goes_straight_to_the_temp_directory ... ok
[INFO] [stdout] test event::tests::compact_prints_control_and_invisible_characters_escaped ... ok
[INFO] [stdout] test event::tests::every_status_has_an_emitter ... ok
[INFO] [stdout] test event::tests::compact_prints_a_multi_line_message_on_several_lines ... ok
[INFO] [stdout] test ctx::tests::fetch_streams_its_chunks_in_order_with_one_last ... ok
[INFO] [stdout] test launch::tests::a_relative_home_is_not_a_home ... ok
[INFO] [stdout] test ctx::tests::a_missing_account_is_named_by_a_real_system_in_both_modes ... ok
[INFO] [stdout] test launch::tests::a_relative_temp_copy_is_execd_by_path ... ok
[INFO] [stdout] test launch::tests::a_warm_run_is_one_spawn ... ok
[INFO] [stdout] test launch::tests::any_other_install_failure_is_refused_with_its_cause ... ok
[INFO] [stdout] test launch::tests::an_unusable_or_noexec_home_falls_through_to_the_temp_directory ... ok
[INFO] [stdout] test launch::tests::content_addressed_names ... ok
[INFO] [stdout] test launch::tests::argv_passes_everything_variable_as_arguments ... ok
[INFO] [stdout] test launch::tests::end_of_options_precedes_every_operand ... ok
[INFO] [stdout] test launch::tests::escalation_words ... ok
[INFO] [stdout] test launch::tests::both_places_unusable_is_refused_naming_both_causes ... ok
[INFO] [stdout] test launch::tests::sudos_rejection_lines ... ok
[INFO] [stdout] test launch::tests::suffixes_differ ... ok
[INFO] [stdout] test launch::tests::the_deadline_message_names_the_wait_and_the_last_line ... ok
[INFO] [stdout] test launch::tests::every_script_is_one_line ... ok
[INFO] [stdout] test mask::tests::a_long_secret_is_masked_anywhere ... ok
[INFO] [stdout] test mask::tests::a_panic_message_is_masked_only_when_it_holds_a_secret ... ok
[INFO] [stdout] test mask::tests::a_placeholder_is_never_split ... ok
[INFO] [stdout] test mask::tests::a_run_reaching_the_end_of_what_was_read_is_still_a_cut ... ok
[INFO] [stdout] test backend::local::tests::stdin_reaches_the_child_and_a_large_input_does_not_deadlock ... ok
[INFO] [stdout] test mask::tests::a_secret_registered_on_another_thread_does_not_mask_this_ones_output ... ok
[INFO] [stdout] test mask::tests::a_secret_straddling_the_cut_is_masked_whole ... ok
[INFO] [stdout] test mask::tests::a_secret_under_four_characters_is_not_registered ... ok
[INFO] [stdout] test mask::tests::a_short_secret_is_masked_only_as_a_whole_word ... ok
[INFO] [stdout] test mask::tests::a_short_secret_on_the_cut_is_qualified_by_one_touching_it ... ok
[INFO] [stdout] test mask::tests::an_inner_span_that_qualifies_qualifies_its_run ... ok
[INFO] [stdout] test mask::tests::apply_prefix_leaves_a_secret_under_four_characters ... ok
[INFO] [stdout] test mask::tests::apply_prefix_sees_only_this_threads_secrets ... ok
[INFO] [stdout] test mask::tests::apply_prefix_with_nothing_registered_only_cuts ... ok
[INFO] [stdout] test mask::tests::every_secret_registers_itself ... ok
[INFO] [stdout] test mask::tests::overlapping_and_touching_secrets_are_one_placeholder ... ok
[INFO] [stdout] test mask::tests::a_secret_over_the_cap_is_registered_as_its_start ... ok
[INFO] [stdout] test mask::tests::registering_twice_and_interleaving_keep_every_secret ... ok
[INFO] [stdout] test mask::tests::secrets_sharing_a_prefix_are_told_apart ... ok
[INFO] [stdout] test mask::tests::the_form_encoded_form_is_masked ... ok
[INFO] [stdout] test mask::tests::the_html_safe_json_percent_and_html_forms_are_masked ... ok
[INFO] [stdout] test mask::tests::the_json_forms_are_masked ... ok
[INFO] [stdout] test mask::tests::the_sink_masks_every_string_of_an_event ... ok
[INFO] [stdout] test mask::tests::whitespace_around_a_secret_is_not_part_of_it ... ok
[INFO] [stdout] test protocol::tests::chunk_frames_json_is_byte_identical_to_the_plain_vec_encoding ... ok
[INFO] [stdout] test protocol::tests::diff_json_is_byte_identical_to_the_public_enum_encoding ... ok
[INFO] [stdout] test protocol::tests::encode_frame_refuses_only_past_its_limit ... ok
[INFO] [stdout] test protocol::tests::frame_sink_sends_a_failed_commands_stderr_within_the_limit ... ok
[INFO] [stdout] test protocol::tests::frames_round_trip_with_binary_chunks ... ok
[INFO] [stdout] test protocol::tests::protocol_5_carries_block_paths ... ok
[INFO] [stdout] test protocol::tests::protocol_6_carries_the_login_override ... ok
[INFO] [stdout] test protocol::tests::protocol_7_carries_recovered_and_the_failed_steps_blocks ... ok
[INFO] [stdout] test protocol::tests::protocol_8_carries_the_failed_steps_command ... ok
[INFO] [stdout] test protocol::tests::start_frame_password_is_optional_and_secret ... ok
[INFO] [stdout] test protocol::tests::a_chunk_frame_leaves_no_copy_behind ... ok
[INFO] [stdout] test protocol::tests::stderr_is_dropped_when_the_bare_frame_fits_exactly ... ok
[INFO] [stdout] test protocol::tests::stderr_that_fits_or_cannot_help_is_left_whole ... ok
[INFO] [stdout] test protocol::tests::stderr_with_no_room_for_the_marker_is_dropped ... ok
[INFO] [stdout] test registry::tests::describe_carries_the_playbooks_ssh_user ... ok
[INFO] [stdout] test runtime::tests::a_bail_without_a_step_fails_the_host_and_the_caught_step_stays_recovered ... ok
[INFO] [stdout] test runtime::tests::a_cancelled_run_fails_the_host_even_when_every_error_is_swallowed ... ok
[INFO] [stdout] test runtime::tests::a_cancelled_step_that_escapes_is_reported_once ... ok
[INFO] [stdout] test protocol::tests::stderr_too_large_for_a_frame_keeps_its_tail ... ok
[INFO] [stdout] test launch::tests::a_temp_directory_that_exists_is_not_used ... ok
[INFO] [stdout] test runtime::tests::a_context_layer_added_by_the_playbook_keeps_the_step_identified ... ok
[INFO] [stdout] test runtime::tests::a_failure_caught_by_an_enclosing_block_is_recovered ... ok
[INFO] [stdout] test runtime::tests::a_failure_escaping_nested_blocks_fails_the_host_and_names_its_blocks ... ok
[INFO] [stdout] test runtime::tests::a_caught_failure_then_an_escaping_one_is_one_of_each ... ok
[INFO] [stdout] test runtime::tests::a_hand_built_step_failed_layer_claims_no_recorded_failure ... ok
[INFO] [stdout] test runtime::tests::a_panic_fails_the_host_whatever_was_caught_before_it ... ok
[INFO] [stdout] test launch::tests::install_then_try_runs_the_copy_from_the_home ... ok
[INFO] [stdout] test runtime::tests::a_real_run_fails_the_host_on_output_unavailable ... ok
[INFO] [stdout] test runtime::tests::a_retry_that_heals_recovers_and_does_not_fail_the_host ... ok
[INFO] [stdout] test runtime::tests::a_run_cancelled_before_any_step_still_fails_the_host ... ok
[INFO] [stdout] test runtime::tests::a_step_error_returned_with_question_mark_fails_the_host ... ok
[INFO] [stdout] test runtime::tests::a_step_that_failed_once_the_run_was_cancelled_is_failed_even_when_caught ... ok
[INFO] [stdout] test runtime::tests::an_ephemeral_copy_removes_itself_and_its_directory_only ... ok
[INFO] [stdout] test runtime::tests::an_error_from_a_dry_twin_claims_its_own_step ... ok
[INFO] [stdout] test runtime::tests::an_earlier_steps_error_returned_later_fails_that_step ... ok
[INFO] [stdout] test launch::tests::the_temp_directory_is_private_whatever_the_umask ... ok
[INFO] [stdout] test launch::tests::a_copy_in_the_temp_directory_is_run_as_ephemeral ... ok
[INFO] [stdout] test runtime::tests::check_vars_playbook_selection_and_no_vars ... ok
[INFO] [stdout] test runtime::tests::an_unabsorbed_deref_payload_reports_a_clean_message ... ok
[INFO] [stdout] test runtime::tests::an_error_from_a_second_ctx_does_not_claim_this_runs_step ... ok
[INFO] [stdout] test runtime::tests::check_vars_round_trip ... ok
[INFO] [stdout] test runtime::tests::classify_is_by_id_and_floors_a_failed_host_at_one ... ok
[INFO] [stdout] test runtime::tests::every_warning_producer_reaches_the_summary ... ok
[INFO] [stdout] test runtime::tests::a_panic_prints_its_message_masked ... FAILED
[INFO] [stdout] test runtime::tests::an_optional_step_wrapped_in_ok_does_not_fail_the_host ... ok
[INFO] [stdout] test runtime::tests::failures_in_blocks_and_as_user_share_one_classification ... ok
[INFO] [stdout] test runtime::tests::probe_a_panic_holding_a_secret ... ignored, run by a_panic_prints_its_message_masked in a child process
[INFO] [stdout] test runtime::tests::failed_frame_carries_the_step_name ... ok
[INFO] [stdout] test runtime::tests::only_a_dry_run_built_to_abort_is_warned ... ok
[INFO] [stdout] test runtime::tests::retries_exhausted_count_the_last_failed_and_the_rest_recovered ... ok
[INFO] [stdout] test runtime::tests::under_check_a_panic_in_a_block_still_fails_the_host ... ok
[INFO] [stdout] test runtime::tests::under_check_a_caught_read_inside_an_op_is_recovered ... ok
[INFO] [stdout] test launch::tests::a_copy_that_is_not_executable_is_not_run ... ok
[INFO] [stdout] test runtime::tests::under_check_a_read_inside_an_op_fails_the_host ... ok
[INFO] [stdout] test runtime::tests::under_check_a_read_through_an_absorbed_block_ends_the_dry_run_without_failing ... ok
[INFO] [stdout] test runtime::tests::under_check_a_cancelled_run_fails_the_host_even_when_the_rest_is_absorbed ... ok
[INFO] [stdout] test runtime::tests::under_check_an_absorbed_read_is_neither_failed_nor_recovered ... ok
[INFO] [stdout] test secret::tests::a_secret_grows_without_leaving_a_copy ... ok
[INFO] [stdout] test secret::tests::bytes_are_zeroized ... ok
[INFO] [stdout] test runtime::tests::the_runs_system_carries_the_login_override_note ... ok
[INFO] [stdout] test runtime::tests::under_check_a_top_level_missing_output_ends_the_dry_run_without_failing ... ok
[INFO] [stdout] test secret::tests::serde_round_trip_as_json_string ... ok
[INFO] [stdout] test secret::tests::debug_and_str_are_safe ... ok
[INFO] [stdout] test runtime::tests::grep_caught_as_not_found_does_not_fail_the_host ... ok
[INFO] [stdout] test stream::tests::a_chunk_out_of_order_or_onto_a_directory_ends_its_fetch ... ok
[INFO] [stdout] test stream::tests::fetch_destinations_are_confined_and_written_in_order ... ok
[INFO] [stdout] test stream::tests::an_unfinished_fetch_leaves_the_destination_and_no_temporary_file ... ok
[INFO] [stdout] test runtime::tests::every_event_of_a_run_is_masked_before_it_is_emitted ... ok
[INFO] [stdout] test stream::tests::run_dir_names_cannot_escape_the_temp_directory ... ok
[INFO] [stdout] test stream::tests::a_complete_fetch_replaces_the_destination_on_its_last_chunk ... ok
[INFO] [stdout] test system::tests::a_backup_carries_no_setuid_setgid_or_sticky ... ok
[INFO] [stdout] test system::tests::a_backup_keeps_the_owner_of_the_file ... ok
[INFO] [stdout] test system::tests::a_backup_skips_a_file_already_at_its_name ... ok
[INFO] [stdout] test system::tests::a_backup_of_a_directory_is_refused ... ok
[INFO] [stdout] test stream::tests::requests_outside_the_workspace_are_denied ... ok
[INFO] [stdout] test stream::tests::a_fetch_keeps_the_mode_of_the_file_it_replaces_and_replaces_a_link ... ok
[INFO] [stdout] test system::tests::a_backup_skips_a_symlink_planted_at_its_name ... ok
[INFO] [stdout] test system::tests::a_backup_that_fails_otherwise_tries_one_name ... ok
[INFO] [stdout] test system::tests::a_backup_with_every_name_taken_fails_and_writes_nothing ... ok
[INFO] [stdout] test system::tests::open_read_errors_name_the_path ... ok
[INFO] [stdout] test system::tests::predictable_names_do_not_block_a_backup ... ok
[INFO] [stdout] test system::tests::symlink_is_refused_during_check ... ok
[INFO] [stdout] test stream::tests::chunking_always_ends_with_last ... ok
[INFO] [stdout] test system::tests::in_process_helper_runs_every_primitive_through_a_helper ... ok
[INFO] [stdout] test system::tests::a_local_backup_skips_planted_names_and_drops_setuid ... ok
[INFO] [stdout] test template::tests::a_dynamic_template_with_a_load_fails_before_it_renders ... ok
[INFO] [stdout] test stream::tests::chunks_reassemble_through_write_chunks ... ok
[INFO] [stdout] test template::tests::a_target_loads_the_file_the_macro_resolved_it_to ... ok
[INFO] [stdout] test system::tests::a_failing_source_writes_nothing_on_any_backend ... ok
[INFO] [stdout] test launch::tests::a_tmpdir_that_looks_like_a_flag_is_a_path ... ok
[INFO] [stdout] test template::tests::a_value_that_does_not_serialize_fails_at_any_depth ... ok
[INFO] [stdout] test template::tests::a_target_the_macro_did_not_resolve_never_loads_another_file_by_its_name ... ok
[INFO] [stdout] test template::tests::first_load_finds_every_statement_and_its_line ... ok
[INFO] [stdout] test template::tests::a_value_that_does_not_serialize_fails_naming_its_argument ... ok
[INFO] [stdout] test system::tests::the_escalation_note_and_method_survive_each_other ... ok
[INFO] [stdout] test template::tests::named_arguments_override_the_spread ... ok
[INFO] [stdout] test template::tests::first_load_ignores_raw_text_strings_and_names ... ok
[INFO] [stdout] test template::tests::the_dynamic_environment_has_no_loader ... ok
[INFO] [stdout] test system::tests::write_from_is_refused_while_checking_and_open_read_is_not ... ok
[INFO] [stdout] test testing::tests::a_dry_twin_continues_its_parents_step_ids_in_check_mode ... ok
[INFO] [stdout] test testing::tests::a_dry_twin_reports_inside_the_parents_open_blocks ... ok
[INFO] [stdout] test testing::tests::image_result_passes_only_with_a_clean_report ... ok
[INFO] [stdout] test testing::tests::panic_message_reads_the_output_unavailable_payload ... ok
[INFO] [stdout] test template::tests::lstrip_blocks_is_off_as_in_ansible ... ok
[INFO] [stdout] test testing::tests::parse_report_reads_the_last_report_line ... ok
[INFO] [stdout] test template::tests::the_spread_must_be_a_map_with_string_keys ... ok
[INFO] [stdout] test testing::tests::test_artifact_matches_the_exact_target_name_only ... ok
[INFO] [stdout] test template::tests::a_deep_include_chain_is_counted_not_listed ... ok
[INFO] [stdout] test testing::tests::test_artifact_picks_the_test_target_by_name ... ok
[INFO] [stdout] test testing::tests::test_path_inside_a_module_keeps_the_module ... ok
[INFO] [stdout] test testing::tests::test_path_at_crate_root_is_the_name ... ok
[INFO] [stdout] test vars::tests::all_missing_vars_reported_at_once ... ok
[INFO] [stdout] test vars::tests::did_you_mean_picks_the_closest_within_two_edits ... ok
[INFO] [stdout] test vars::tests::missing_required_names_every_gap ... ok
[INFO] [stdout] test vars::tests::parse_var_coerces_json_else_string ... ok
[INFO] [stdout] test vars::tests::enums_and_lists_are_flat ... ok
[INFO] [stdout] test vars::tests::scalar_for_a_list_field_becomes_a_one_element_list ... ok
[INFO] [stdout] test vars::tests::missing_required_reads_well ... ok
[INFO] [stdout] test vars::tests::schema_marks_required ... ok
[INFO] [stdout] test vars::tests::nested_struct_is_a_flatness_violation ... ok
[INFO] [stdout] test vars::tests::null_means_no_vars ... ok
[INFO] [stdout] test vars::tests::type_mismatches_follow_the_schema ... ok
[INFO] [stdout] test vars::tests::unknown_keys_warn_with_suggestion ... ok
[INFO] [stdout] test launch::tests::a_short_stream_is_refused_and_leaves_nothing ... ok
[INFO] [stdout] test system::tests::escalated_reads_and_writes_carry_any_size ... ok
[INFO] [stdout] test backend::elevated::tests::a_command_through_the_helper_does_not_deadlock_on_large_stdin ... ok
[INFO] [stdout] test channel::tests::the_feeder_waits_rather_than_buffering_a_whole_file ... ok
[INFO] [stdout] test backend::elevated::tests::no_byte_of_the_binary_is_written_before_the_install_answers ... ok
[INFO] [stdout] test backend::elevated::tests::a_helper_whose_stderr_outlives_it_is_reported_within_the_bound ... ok
[INFO] [stdout] test backend::elevated::tests::a_shutdown_waits_for_stderr_only_as_long_as_the_helper ... ok
[INFO] [stdout] test backend::elevated::tests::a_file_over_48_mib_crosses_the_helper_in_bounded_frames ... ok
[INFO] [stdout] test backend::elevated::tests::a_helper_that_exits_at_once_reports_its_stderr_every_time ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- runtime::tests::a_panic_prints_its_message_masked stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'runtime::tests::a_panic_prints_its_message_masked' (1818) panicked at src/runtime.rs:1118:9:
[INFO] [stdout] 
[INFO] [stdout] thread 'runtime::tests::probe_a_panic_holding_a_secret' panicked at src/runtime.rs:1081:13:
[INFO] [stdout] login failed with <secret>
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0: rustible_sdk::mask::install_panic_hook::{closure#0}::{closure#0}
[INFO] [stdout]    1: std::panicking::panic_with_hook
[INFO] [stdout]    2: std::panicking::panic_handler::{closure#0}
[INFO] [stdout]    3: std::sys::backtrace::__rust_end_short_backtrace::<std::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    4: __rustc::rust_begin_unwind
[INFO] [stdout]    5: core::panicking::panic_fmt
[INFO] [stdout]    6: <rustible_sdk::runtime::tests::PANICS_WITH_A_SECRET::{closure#0} as core::ops::function::FnOnce<(&mut rustible_sdk::ctx::Ctx, serde_json::value::Value)>>::call_once
[INFO] [stdout]    7: rustible_sdk::runtime::execute
[INFO] [stdout]    8: rustible_sdk::runtime::tests::run
[INFO] [stdout]    9: rustible_sdk::runtime::tests::probe_a_panic_holding_a_secret
[INFO] [stdout]   10: <rustible_sdk::runtime::tests::probe_a_panic_holding_a_secret::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] 
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5bd2c2a582d1 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5bd2c2a718ba - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5bd2c2a5d59c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5bd2c2a2eda6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5bd2c2a4e239 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5bd2c28de220 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5bd2c2a4e562 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5bd2c2a2ee52 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5bd2c2a26e99 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5bd2c2a2fedd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5bd2c2a7209c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5bd2c27a5ad6 - rustible_sdk[294b9d6a3e1222d2]::runtime::tests::a_panic_prints_its_message_masked
[INFO] [stdout]   12:     0x5bd2c272b319 - <rustible_sdk[294b9d6a3e1222d2]::runtime::tests::a_panic_prints_its_message_masked::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   13:     0x5bd2c28d150b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   14:     0x5bd2c28deb75 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   15:     0x5bd2c28d8434 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   16:     0x5bd2c28e1cd2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   17:     0x5bd2c2a571e9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   18:     0x75b423cb3dfa - <unknown>
[INFO] [stdout]   19:     0x75b423d473d4 - clone
[INFO] [stdout]   20:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     runtime::tests::a_panic_prints_its_message_masked
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 360 passed; 1 failed; 4 ignored; 0 measured; 0 filtered out; finished in 21.22s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "d942adc071ae2fe5d36aad8f6a641765976c80352c0caedade3e82bfe2b2e8fc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d942adc071ae2fe5d36aad8f6a641765976c80352c0caedade3e82bfe2b2e8fc", kill_on_drop: false }`
[INFO] [stdout] d942adc071ae2fe5d36aad8f6a641765976c80352c0caedade3e82bfe2b2e8fc
