[INFO] fetching crate tracel-deploy 0.4.4...
[INFO] testing tracel-deploy-0.4.4 against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate tracel-deploy 0.4.4 into /workspace/builds/worker-2-tc2/source
[INFO] started tweaking crates.io crate tracel-deploy 0.4.4
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate tracel-deploy 0.4.4
[INFO] tweaked toml for crates.io crate tracel-deploy 0.4.4 written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate tracel-deploy 0.4.4 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 tracel-deploy 0.4.4 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] f558cefed9f2c0c38e0fc866214388f85d7bb37bc447ede833d7b47e0f140469
[INFO] running `Command { std: "docker" "start" "f558cefed9f2c0c38e0fc866214388f85d7bb37bc447ede833d7b47e0f140469", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f558cefed9f2c0c38e0fc866214388f85d7bb37bc447ede833d7b47e0f140469", 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" "f558cefed9f2c0c38e0fc866214388f85d7bb37bc447ede833d7b47e0f140469" "/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" "f558cefed9f2c0c38e0fc866214388f85d7bb37bc447ede833d7b47e0f140469", 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" "f558cefed9f2c0c38e0fc866214388f85d7bb37bc447ede833d7b47e0f140469" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]    Compiling zerocopy v0.8.57
[INFO] [stderr]    Compiling regex-automata v0.4.18
[INFO] [stderr]    Compiling nix v0.31.3
[INFO] [stderr]    Compiling syn v3.0.5
[INFO] [stderr]    Compiling jiff-core v0.1.0
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling thread_local v1.1.10
[INFO] [stderr]    Compiling smallvec v1.16.0
[INFO] [stderr]    Compiling jiff v0.2.35
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling ctrlc v3.5.2
[INFO] [stderr]    Compiling clap_derive v4.6.4
[INFO] [stderr]    Compiling derive_more-impl v2.1.1
[INFO] [stderr]    Compiling strum_macros v0.27.2
[INFO] [stderr]    Compiling tracel-xtask-macros v3.2.0
[INFO] [stderr]    Compiling tracel-deploy-macros v0.4.4
[INFO] [stderr]    Compiling regex v1.13.1
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling tracing-subscriber v0.3.23
[INFO] [stderr]    Compiling clap v4.6.6
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling env_filter v2.0.0
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling rand v0.9.5
[INFO] [stderr]    Compiling env_logger v0.11.11
[INFO] [stderr]    Compiling derive_more v2.1.1
[INFO] [stderr]    Compiling strum v0.27.2
[INFO] [stderr]    Compiling tracel-xtask v3.2.0
[INFO] [stderr]    Compiling tracel-deploy v0.4.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1m 32s
[INFO] running `Command { std: "docker" "inspect" "f558cefed9f2c0c38e0fc866214388f85d7bb37bc447ede833d7b47e0f140469", 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" "f558cefed9f2c0c38e0fc866214388f85d7bb37bc447ede833d7b47e0f140469" "/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 tracel-deploy v0.4.4 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused import: `std::io::Read`
[INFO] [stdout]    --> src/background.rs:281:9
[INFO] [stdout]     |
[INFO] [stdout] 281 |     use std::io::Read;
[INFO] [stdout]     |         ^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 22.15s
[INFO] running `Command { std: "docker" "inspect" "f558cefed9f2c0c38e0fc866214388f85d7bb37bc447ede833d7b47e0f140469", 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" "f558cefed9f2c0c38e0fc866214388f85d7bb37bc447ede833d7b47e0f140469" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: unused import: `std::io::Read`
[INFO] [stderr]    --> src/background.rs:281:9
[INFO] [stderr]     |
[INFO] [stderr] 281 |     use std::io::Read;
[INFO] [stderr]     |         ^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `tracel-deploy` (lib test) generated 1 warning (run `cargo fix --lib -p tracel-deploy --tests` to apply 1 suggestion)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.12s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/build/tracel-deploy/2d0f9f23ff6027b3/out/tracel_deploy-2d0f9f23ff6027b3)
[INFO] [stdout] 
[INFO] [stdout] running 131 tests
[INFO] [stdout] test background::tests::only_a_background_parent_queues ... ok
[INFO] [stdout] test background::tests::the_generated_hook_matches_the_verified_entry ... ok
[INFO] [stdout] test background::tests::hook_commands_quote_paths_with_whitespace ... ok
[INFO] [stdout] test background::tests::a_queued_run_truncates_the_previous_logs ... ok
[INFO] [stdout] test batch::tests::per_target_overrides_reach_the_context_and_the_plan ... ok
[INFO] [stdout] test batch::tests::fail_fast_marks_the_unexecuted_targets_not_run ... ok
[INFO] [stdout] test checkout::tests::a_background_invocation_queues_the_child_with_the_swapped_argv ... ok
[INFO] [stdout] test checkout::tests::a_caller_owned_plan_runs_for_every_package ... ok
[INFO] [stdout] test background::tests::a_queued_child_writes_its_log ... ok
[INFO] [stdout] test checkout::tests::a_dry_run_renders_the_checkout_plan_in_this_process ... FAILED
[INFO] [stdout] test checkout::tests::an_empty_package_list_is_an_error ... ok
[INFO] [stdout] test batch::tests::a_failing_target_does_not_stop_the_rest ... ok
[INFO] [stdout] test checkout::tests::a_workspace_flag_naming_another_checkout_is_rejected ... ok
[INFO] [stdout] test background::tests::the_queued_child_inherits_the_requested_flags ... ok
[INFO] [stdout] test batch::tests::a_second_batch_run_skips_unchanged_targets ... ok
[INFO] [stdout] test checkout::tests::every_package_gets_its_own_report ... ok
[INFO] [stdout] test checkout::tests::single_binary_flags_are_rejected_for_several_packages ... ok
[INFO] [stdout] test context::tests::build_inputs_fingerprint_tracks_added_removed_and_changed_files ... ok
[INFO] [stdout] test context::tests::build_inputs_fingerprint_is_stable_and_order_independent ... ok
[INFO] [stdout] test context::tests::builder_sets_binary_and_install_path ... ok
[INFO] [stdout] test context::tests::cargo_target_dir_follows_env_and_overrides ... FAILED
[INFO] [stdout] test context::tests::cargo_build_target_adds_the_triple ... FAILED
[INFO] [stdout] test plan::phase::tests::a_stateful_handler_can_skip_and_see_the_run ... ok
[INFO] [stdout] test context::tests::fingerprints_detect_content_changes ... ok
[INFO] [stdout] test context::tests::resolved_binary_path_lists_candidates_when_missing ... ok
[INFO] [stdout] test plan::phase::tests::a_simple_handler_reports_done ... ok
[INFO] [stdout] test plan::phase::tests::the_execution_order_is_the_timeline ... ok
[INFO] [stdout] test plan::phase::tests::the_run_state_carries_facts_notes_and_payloads ... ok
[INFO] [stdout] test plan::tests::a_failing_preflight_fails_the_dry_run_with_the_checked_items ... ok
[INFO] [stdout] test plan::tests::a_failed_handler_is_reported_and_still_runs_on_error_and_finally ... ok
[INFO] [stdout] test plan::phase::tests::skip_when_short_circuits_the_handler ... ok
[INFO] [stdout] test plan::tests::a_lock_left_behind_by_a_killed_deployment_is_taken_over ... ok
[INFO] [stdout] test plan::tests::an_install_that_is_already_the_built_binary_is_not_rotated ... ok
[INFO] [stdout] test plan::tests::a_failed_deploy_releases_the_lock ... ok
[INFO] [stdout] test plan::tests::cargo_build_command_line_carries_every_option ... ok
[INFO] [stdout] test plan::tests::cargo_build_command_line_uses_release_without_a_profile ... ok
[INFO] [stdout] test batch::tests::two_targets_both_deploy ... ok
[INFO] [stdout] test plan::tests::cargo_build_executes_the_command_line_it_describes ... ok
[INFO] [stdout] test plan::tests::default_reporter_follows_context_quiet ... ok
[INFO] [stdout] test plan::tests::deploy_lock_blocks_concurrent_deploys ... ok
[INFO] [stdout] test plan::tests::deploy_stamp_records_fingerprints ... ok
[INFO] [stdout] test plan::tests::changed_build_inputs_are_not_skipped ... ok
[INFO] [stdout] test plan::tests::dry_run_plan_goes_through_the_reporter ... ok
[INFO] [stdout] test plan::tests::dry_run_plan_lists_hooks_in_execution_order ... ok
[INFO] [stdout] test batch::tests::a_single_target_matches_a_direct_deploy ... ok
[INFO] [stdout] test plan::tests::dry_run_renders_default_plan_without_side_effects ... ok
[INFO] [stdout] test plan::tests::allow_failure_keeps_exit_code_and_stderr_tail ... ok
[INFO] [stdout] test plan::tests::dry_run_runs_preflight_and_nothing_else ... ok
[INFO] [stdout] test plan::tests::allowed_failure_reports_exit_code_and_stderr_tail ... ok
[INFO] [stdout] test plan::tests::force_disables_the_skip ... ok
[INFO] [stdout] test plan::tests::finally_restarts_service_after_rotate_failure ... ok
[INFO] [stderr] err
[INFO] [stdout] out
[INFO] [stdout] test plan::tests::executed_steps_go_through_the_reporter ... ok
[INFO] [stdout] test plan::tests::handlers_report_their_phase_and_outcome ... ok
[INFO] [stdout] test plan::tests::hook_results_are_reported ... ok
[INFO] [stdout] test plan::tests::dropping_a_lock_taken_over_by_someone_else_leaves_it_alone ... ok
[INFO] [stdout] test plan::tests::dry_run_skips_hooks_and_steps ... ok
[INFO] [stdout] test plan::tests::insertion_points_apply_to_a_caller_owned_plan_too ... ok
[INFO] [stdout] test plan::tests::inserted_steps_run_between_the_default_build_and_rotate ... ok
[INFO] [stdout] test plan::tests::installed_artifact_drift_is_not_skipped ... ok
[INFO] [stderr] [1m[91merror[0m: could not find `Cargo.toml` in `/tmp/tracel-deploy-build-904-1792350304407617890` or any parent directory
[INFO] [stdout] test plan::tests::inserted_steps_keep_their_call_order ... ok
[INFO] [stdout] test plan::tests::missing_or_legacy_stamps_do_not_skip ... ok
[INFO] [stdout] test plan::tests::install_is_current_answers_whether_the_rotation_would_install ... ok
[INFO] [stdout] test plan::tests::cargo_build_errors_include_step_name_and_paths ... ok
[INFO] [stdout] test plan::tests::post_is_skipped_but_on_error_and_finally_run ... ok
[INFO] [stdout] test plan::tests::pre_steps_and_post_hooks_run_in_order ... ok
[INFO] [stdout] test plan::tests::preflight_does_not_run_without_dry_run ... ok
[INFO] [stdout] test plan::tests::named_hook_failures_use_the_given_name ... ok
[INFO] [stdout] test plan::tests::on_error_failure_does_not_stop_finally ... ok
[INFO] [stdout] test plan::tests::rotate_reports_artifacts_and_duration ... ok
[INFO] [stdout] test plan::tests::rotate_reports_the_backup_it_replaced ... ok
[INFO] [stdout] test plan::tests::run_step_errors_include_program_and_args ... ok
[INFO] [stderr] err
[INFO] [stdout] test plan::tests::run_step_captures_stdout_and_stderr ... ok
[INFO] [stdout] test plan::tests::run_step_verify_failure_is_an_error ... ok
[INFO] [stderr] boom
[INFO] [stdout] test plan::tests::run_step_expected_status_mismatch_is_an_error ... ok
[INFO] [stderr] boom
[INFO] [stderr] [1m[91merror[0m: package ID specification `tracel-deploy-test` did not match any packages
[INFO] [stdout] test plan::tests::the_default_plan_is_unchanged_without_insertions ... ok
[INFO] [stdout] test plan::tests::run_step_expected_status_accepts_that_code ... ok
[INFO] [stdout] test plan::tests::the_pre_build_skip_is_opt_in ... ok
[INFO] [stdout] test plan::tests::verify_install_reports_mismatches ... FAILED
[INFO] [stdout] test plan::tests::without_defaults_idempotent_skip_skips_unchanged_work ... ok
[INFO] [stdout] test plan::tests::without_defaults_keeps_the_old_behaviour_without_explicit_switches ... ok
[INFO] [stdout] test plan::tests::without_defaults_verify_install_checks_the_installed_binary ... ok
[INFO] [stdout] test plan::tests::force_runs_the_default_plan_even_when_nothing_changed ... ok
[INFO] [stdout] test plan::tests::without_defaults_write_deploy_stamp_records_build_inputs ... ok
[INFO] [stdout] test rotate::tests::backup_max_age_removes_old_backups ... ok
[INFO] [stdout] test rotate::tests::atomic_replace_keeps_running_handle_on_old_inode ... ok
[INFO] [stdout] test rotate::tests::cleanup_ignores_removal_failures ... ok
[INFO] [stdout] test rotate::tests::dry_run_does_not_modify_destination ... ok
[INFO] [stdout] test rotate::tests::dry_run_keeps_backups ... ok
[INFO] [stdout] test rotate::tests::dry_run_neither_registers_nor_deletes_pending_backups ... ok
[INFO] [stdout] test rotate::tests::backup_retention_keeps_newest_backups ... ok
[INFO] [stdout] test rotate::tests::expired_pending_entries_are_discarded_without_an_attempt ... ok
[INFO] [stderr] [1m[91merror[0m: package ID specification `tracel-deploy-test` did not match any packages
[INFO] [stdout] test rotate::tests::failed_backup_removal_is_registered_and_rotate_succeeds ... ok
[INFO] [stdout] test rotate::tests::hold_binary_alive_for_rotate ... ignored
[INFO] [stdout] test plan::tests::the_default_plan_lets_cargo_decide ... ok
[INFO] [stdout] test rotate::tests::pending_cleanup_leaves_other_binaries_alone ... ok
[INFO] [stdout] test rotate::tests::pending_entries_beyond_the_limit_are_evicted ... ok
[INFO] [stdout] test rotate::tests::pending_backups_are_retried_by_the_next_cleanup ... ok
[INFO] [stdout] test rotate::tests::pending_registry_lives_in_the_backup_directory ... ok
[INFO] [stdout] test rotate::tests::rename_aside_keeps_the_backup_next_to_the_symlink_target ... ok
[INFO] [stdout] test rotate::tests::rename_aside_reports_a_failed_rollback ... ok
[INFO] [stdout] test rotate::tests::rename_aside_keeps_backup_and_installs_new_binary ... ok
[INFO] [stdout] test rotate::tests::rename_aside_reports_backup_rollback_and_cause ... ok
[INFO] [stdout] test rotate::tests::replaces_missing_destination ... ok
[INFO] [stderr] [1m[91merror[0m: package ID specification `tracel-deploy-test` did not match any packages
[INFO] [stdout] test rotate::tests::rotate_replaces_the_symlink_target_and_keeps_the_link ... ok
[INFO] [stderr] [1m[91merror[0m: package ID specification `tracel-deploy-test` did not match any packages
[INFO] [stdout] test rotate::tests::strategy_matrix_documents_unix_behaviour ... FAILED
[INFO] [stdout] test plan::tests::default_plan_switches_can_disable_the_skip ... ok
[INFO] [stdout] test plan::tests::stdout_reporter_keeps_the_printed_lines ... ok
[INFO] [stdout] test rotate::tests::strategy_labels_are_stable ... ok
[INFO] [stdout] test state::tests::failed_replace_cleans_the_temporary_file ... ok
[INFO] [stdout] test state::tests::missing_file_reads_as_none ... ok
[INFO] [stdout] test rotate::tests::unix_in_use_classification_covers_text_file_busy ... ok
[INFO] [stdout] test plan::tests::changed_build_inputs_run_the_default_plan ... ok
[INFO] [stdout] test rotate::tests::the_next_rotation_retries_registered_backups ... ok
[INFO] [stdout] test state::tests::remove_is_idempotent_and_forgets_the_file ... ok
[INFO] [stdout] test state::tests::resolve_install_path_does_not_repeat_the_extension ... ok
[INFO] [stdout] test state::tests::resolve_install_path_appends_the_binary_to_a_directory ... ok
[INFO] [stdout] test state::tests::resolve_install_path_defaults_to_the_cargo_bin_directory ... ok
[INFO] [stdout] test state::tests::overwrite_replaces_contents_without_leaving_a_temporary_file ... ok
[INFO] [stdout] test state::tests::write_creates_missing_directories ... ok
[INFO] [stdout] test workspace::tests::a_manifest_dir_without_a_workspace_falls_back_to_its_parent ... ok
[INFO] [stdout] test state::tests::same_file_path_is_case_sensitive_off_windows ... ok
[INFO] [stdout] test state::tests::resolve_install_path_keeps_a_file_path ... ok
[INFO] [stdout] test workspace::tests::the_current_directory_is_the_last_resort ... FAILED
[INFO] [stdout] test workspace::tests::the_explicit_root_wins ... ok
[INFO] [stdout] test workspace::tests::an_explicit_root_has_to_look_like_a_workspace ... ok
[INFO] [stdout] test state::tests::write_then_read_round_trips ... ok
[INFO] [stdout] test workspace::tests::the_manifest_dir_hint_walks_up_to_the_workspace ... ok
[INFO] [stdout] test rotate::tests::unix_strategy_dispatch_matches_the_matrix ... ok
[INFO] [stderr] [1m[92m   Compiling[0m tracel-deploy-cargo-mode v0.0.0 (/tmp/tracel-deploy-cargo-mode-904-1792350304489048889)
[INFO] [stdout] test plan::tests::run_step_timeout_kills_the_child ... ok
[INFO] [stderr] [1m[92m    Finished[0m `dev` profile [unoptimized + debuginfo] target(s) in 0.28s
[INFO] [stderr] [1m[92m    Finished[0m `dev` profile [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr] [1m[92m   Compiling[0m tracel-deploy-cargo-mode v0.0.0 (/tmp/tracel-deploy-cargo-mode-904-1792350304489048889)
[INFO] [stdout] test rotate::tests::fail_if_locked_rejects_an_executing_binary ... ok
[INFO] [stderr] [1m[92m    Finished[0m `dev` profile [unoptimized + debuginfo] target(s) in 0.20s
[INFO] [stdout] test plan::tests::the_default_plan_builds_with_cargo_and_rotates_only_a_real_change ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- checkout::tests::a_dry_run_renders_the_checkout_plan_in_this_process stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'checkout::tests::a_dry_run_renders_the_checkout_plan_in_this_process' (925) panicked at src/checkout.rs:282:9:
[INFO] [stdout] the build output comes from the workspace: /opt/rustwide/rustup-home/toolchains/1.100.0-beta.1-x86_64-unknown-linux-gnu/bin/cargo build -p my-app --color always --release
[INFO] [stdout] rotate /opt/rustwide/target/release/my-app -> /opt/rustwide/cargo-home/bin/my-app (strategy: auto)
[INFO] [stdout] after-rotate: verify install
[INFO] [stdout] after-rotate: write deploy stamp
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5558afc21331 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5558afc3700a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5558afc260dc - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5558afbf7dc6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5558afc16c09 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5558afb63880 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5558afc16dc2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5558afbf7e72 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5558afbf0059 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5558afbf904d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5558afc3776c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5558afb353a6 - <tracel_deploy[7b7c81d493806321]::checkout::tests::a_dry_run_renders_the_checkout_plan_in_this_process::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   12:     0x5558afb56ccb - 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:     0x5558afb63ea5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   14:     0x5558afb5d794 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   15:     0x5558afb66f32 - <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:     0x5558afc2027f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   17:     0x7b2a70f9bdfa - <unknown>
[INFO] [stdout]   18:     0x7b2a7102f3d4 - clone
[INFO] [stdout]   19:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- context::tests::cargo_target_dir_follows_env_and_overrides stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'context::tests::cargo_target_dir_follows_env_and_overrides' (938) panicked at src/context.rs:827:9:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: "/opt/rustwide/target/debug/my-service"
[INFO] [stdout]  right: "/tmp/tracel-deploy-context-target-dir-904-1792350304397626231/target/debug/my-service"
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5558afc21331 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5558afc3700a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5558afc260dc - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5558afbf7dc6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5558afc16c09 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5558afb63880 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5558afc16dc2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5558afbf7e72 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5558afbf0059 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5558afbf904d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5558afc3776c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5558afc37683 - core[a373ad73a504971]::panicking::assert_failed_inner
[INFO] [stdout]   12:     0x5558afb19ed4 - core[a373ad73a504971]::panicking::assert_failed::<std[617be2ca0a6fd877]::path::PathBuf, std[617be2ca0a6fd877]::path::PathBuf>
[INFO] [stdout]   13:     0x5558afb22e1c - <tracel_deploy[7b7c81d493806321]::context::tests::cargo_target_dir_follows_env_and_overrides::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5558afb56ccb - 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]   15:     0x5558afb63ea5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5558afb5d794 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5558afb66f32 - <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]   18:     0x5558afc2027f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x7b2a70f9bdfa - <unknown>
[INFO] [stdout]   20:     0x7b2a7102f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- context::tests::cargo_build_target_adds_the_triple stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'context::tests::cargo_build_target_adds_the_triple' (936) panicked at src/context.rs:862:38:
[INFO] [stdout] env lock: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5558afc21331 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5558afc3700a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5558afc260dc - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5558afbf7dc6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5558afc16c09 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5558afb63880 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5558afc16dc2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5558afbf7e72 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5558afbf0059 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5558afbf904d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5558afc3776c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5558afc37542 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]   12:     0x5558afb21877 - <tracel_deploy[7b7c81d493806321]::context::tests::cargo_build_target_adds_the_triple::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   13:     0x5558afb56ccb - 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]   14:     0x5558afb63ea5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   15:     0x5558afb5d794 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   16:     0x5558afb66f32 - <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]   17:     0x5558afc2027f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   18:     0x7b2a70f9bdfa - <unknown>
[INFO] [stdout]   19:     0x7b2a7102f3d4 - clone
[INFO] [stdout]   20:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- plan::tests::verify_install_reports_mismatches stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'plan::tests::verify_install_reports_mismatches' (1027) panicked at src/plan/mod.rs:1883:43:
[INFO] [stdout] matching fingerprints pass: installed binary /tmp/tracel-deploy-verify-904-1792350304503745729/installed is not executable (mode 100644)
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<alloc::string::String>
[INFO] [stdout]    1: tracel_deploy::plan::verify_installed_binary
[INFO] [stdout]    2: <tracel_deploy::plan::tests::verify_install_reports_mismatches::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]    3: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]    4: test::run_test::{closure#0}
[INFO] [stdout]    5: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]    6: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]    7: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]    8: <unknown>
[INFO] [stdout]    9: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5558afc21331 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5558afc3700a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5558afc260dc - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5558afbf7dc6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5558afc16c09 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5558afb63880 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5558afc16dc2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5558afbf7e72 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5558afbf0059 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5558afbf904d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5558afc3776c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5558afc37542 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]   12:     0x5558afab1cf6 - <tracel_deploy[7b7c81d493806321]::plan::tests::verify_install_reports_mismatches::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   13:     0x5558afb56ccb - 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]   14:     0x5558afb63ea5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   15:     0x5558afb5d794 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   16:     0x5558afb66f32 - <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]   17:     0x5558afc2027f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   18:     0x7b2a70f9bdfa - <unknown>
[INFO] [stdout]   19:     0x7b2a7102f3d4 - clone
[INFO] [stdout]   20:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- rotate::tests::strategy_matrix_documents_unix_behaviour stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'rotate::tests::strategy_matrix_documents_unix_behaviour' (1063) panicked at src/rotate.rs:2104:9:
[INFO] [stdout] fail-if-locked on unix: fail-if-locked: copy over the destination only; fail on a running destination instead of renaming it aside
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5558afc21331 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5558afc3700a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5558afc260dc - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5558afbf7dc6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5558afc16c09 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5558afb63880 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5558afc16dc2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5558afbf7e72 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5558afbf0059 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5558afbf904d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5558afc3776c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5558afad8876 - <tracel_deploy[7b7c81d493806321]::rotate::tests::strategy_matrix_documents_unix_behaviour::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   12:     0x5558afb56ccb - 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:     0x5558afb63ea5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   14:     0x5558afb5d794 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   15:     0x5558afb66f32 - <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:     0x5558afc2027f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   17:     0x7b2a70f9bdfa - <unknown>
[INFO] [stdout]   18:     0x7b2a7102f3d4 - clone
[INFO] [stdout]   19:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- workspace::tests::the_current_directory_is_the_last_resort stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'workspace::tests::the_current_directory_is_the_last_resort' (1081) panicked at src/workspace.rs:216:9:
[INFO] [stdout] detected /opt/rustwide is a workspace
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5558afc21331 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5558afc3700a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5558afc260dc - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5558afbf7dc6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5558afc16c09 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5558afb63880 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5558afc16dc2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5558afbf7e72 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5558afbf0059 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5558afbf904d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5558afc3776c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5558afb24ef9 - <tracel_deploy[7b7c81d493806321]::workspace::tests::the_current_directory_is_the_last_resort::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   12:     0x5558afb56ccb - 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:     0x5558afb63ea5 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   14:     0x5558afb5d794 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   15:     0x5558afb66f32 - <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:     0x5558afc2027f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   17:     0x7b2a70f9bdfa - <unknown>
[INFO] [stdout]   18:     0x7b2a7102f3d4 - clone
[INFO] [stdout]   19:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     checkout::tests::a_dry_run_renders_the_checkout_plan_in_this_process
[INFO] [stdout]     context::tests::cargo_build_target_adds_the_triple
[INFO] [stdout]     context::tests::cargo_target_dir_follows_env_and_overrides
[INFO] [stdout]     plan::tests::verify_install_reports_mismatches
[INFO] [stdout]     rotate::tests::strategy_matrix_documents_unix_behaviour
[INFO] [stdout]     workspace::tests::the_current_directory_is_the_last_resort
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 124 passed; 6 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.79s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "f558cefed9f2c0c38e0fc866214388f85d7bb37bc447ede833d7b47e0f140469", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f558cefed9f2c0c38e0fc866214388f85d7bb37bc447ede833d7b47e0f140469", kill_on_drop: false }`
[INFO] [stdout] f558cefed9f2c0c38e0fc866214388f85d7bb37bc447ede833d7b47e0f140469
