[INFO] fetching crate polyforge-toolrunner 0.4.1...
[INFO] testing polyforge-toolrunner-0.4.1 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate polyforge-toolrunner 0.4.1 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate polyforge-toolrunner 0.4.1
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate polyforge-toolrunner 0.4.1
[INFO] tweaked toml for crates.io crate polyforge-toolrunner 0.4.1 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate polyforge-toolrunner 0.4.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 polyforge-toolrunner 0.4.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 polyforge-core v0.4.0
[INFO] [stderr]   Downloaded fs2 v0.4.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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] 0da24e15bbaa3dae29726cad54fe4d8a62ce28320da447619aba356bc66b4bfd
[INFO] running `Command { std: "docker" "start" "0da24e15bbaa3dae29726cad54fe4d8a62ce28320da447619aba356bc66b4bfd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "0da24e15bbaa3dae29726cad54fe4d8a62ce28320da447619aba356bc66b4bfd", 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" "0da24e15bbaa3dae29726cad54fe4d8a62ce28320da447619aba356bc66b4bfd" "/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" "0da24e15bbaa3dae29726cad54fe4d8a62ce28320da447619aba356bc66b4bfd", 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" "0da24e15bbaa3dae29726cad54fe4d8a62ce28320da447619aba356bc66b4bfd" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling fs2 v0.4.0
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling syn v3.0.3
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling polyforge-core v0.4.0
[INFO] [stderr]    Compiling polyforge-toolrunner v0.4.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 20.37s
[INFO] running `Command { std: "docker" "inspect" "0da24e15bbaa3dae29726cad54fe4d8a62ce28320da447619aba356bc66b4bfd", 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" "0da24e15bbaa3dae29726cad54fe4d8a62ce28320da447619aba356bc66b4bfd" "/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 polyforge-toolrunner v0.4.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 7.62s
[INFO] running `Command { std: "docker" "inspect" "0da24e15bbaa3dae29726cad54fe4d8a62ce28320da447619aba356bc66b4bfd", 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" "0da24e15bbaa3dae29726cad54fe4d8a62ce28320da447619aba356bc66b4bfd" "/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.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/polyforge_toolrunner-813e4899f2bb7ce3)
[INFO] [stdout] 
[INFO] [stdout] running 89 tests
[INFO] [stdout] test prober::tests::auto_container_when_kvm_absent_docker_without_runsc ... ok
[INFO] [stdout] test prober::tests::auto_prefers_firecracker_when_kvm_and_binaries_present ... ok
[INFO] [stdout] test prober::tests::auto_skips_fc_binaries_without_kvm ... ok
[INFO] [stdout] test prober::tests::auto_fails_closed_when_nothing_available ... ok
[INFO] [stdout] test prober::tests::auto_skips_kvm_without_fc_binaries ... ok
[INFO] [stdout] test prober::tests::override_gvisor_happy_returns_gvisor ... ok
[INFO] [stdout] test prober::tests::auto_gvisor_happy_when_kvm_absent_docker_runsc ... ok
[INFO] [stdout] test prober::tests::error_display_is_actionable ... ok
[INFO] [stdout] test prober::tests::override_container_without_runtime_names_runtime ... ok
[INFO] [stdout] test prober::tests::override_container_happy_even_without_kvm_or_runsc ... ok
[INFO] [stdout] test prober::tests::labels_match_attestation_metadata_prefixes ... ok
[INFO] [stdout] test prober::tests::override_gvisor_without_runsc_names_runsc ... ok
[INFO] [stdout] test prober::tests::override_never_falls_back_to_weaker_tier ... ok
[INFO] [stdout] test runner::tests::format_value_rule_is_eslint_scoped ... ok
[INFO] [stdout] test prober::tests::override_firecracker_with_kvm_but_no_binaries_names_binaries ... ok
[INFO] [stdout] test runner::tests::init_executor_process_is_idempotent ... ok
[INFO] [stdout] test runner::tests::init_executor_sandbox_requires_feature ... ok
[INFO] [stdout] test runner::tests::kind_code_names_render_for_conflict_message ... ok
[INFO] [stdout] test prober::tests::override_firecracker_without_kvm_names_kvm ... ok
[INFO] [stdout] test runner::tests::selection_defaults_to_process_without_init ... ok
[INFO] [stdout] test runner::tests::allowlist_v2_tools_are_lookupable ... ok
[INFO] [stdout] test runner::tests::arg_denylist_allows_benign_typed_args ... ok
[INFO] [stdout] test runner::tests::arg_denylist_rejects_mutating_and_code_loading_args ... ok
[INFO] [stdout] test runner::tests::test_absent_nix_devbox_render_none_token_and_stay_byte_stable ... ok
[INFO] [stdout] test prober::tests::override_gvisor_without_runtime_names_runtime ... ok
[INFO] [stdout] test runner::tests::process_backend_label_pinned_without_feature ... ok
[INFO] [stdout] test runner::tests::process_backend_yields_no_executor_digest ... ok
[INFO] [stdout] test runner::tests::pytest_single_token_no_plugin_arg_is_allowed ... ok
[INFO] [stdout] test runner::tests::test_allowlist_rejects_unknown_tool ... ok
[INFO] [stdout] test runner::tests::test_candidate_roots_prepends_git_root ... ok
[INFO] [stdout] test runner::tests::test_cargo_mutants_accepts_version_arg ... ok
[INFO] [stdout] test runner::tests::test_candidate_roots_walk_base_and_ancestors ... ok
[INFO] [stdout] test runner::tests::test_env_fingerprint_allowlist_values_deterministic ... ok
[INFO] [stdout] test runner::tests::test_cargo_mutants_rejects_shell_interpolation ... ok
[INFO] [stdout] test runner::tests::test_env_fingerprint_folds_allowlist_values ... ok
[INFO] [stdout] test runner::tests::test_attestation_carries_longer_composite_fingerprint ... ok
[INFO] [stdout] test runner::tests::spawn_uses_canonical_allowlist_entry_not_caller_bin ... ok
[INFO] [stdout] test runner::tests::test_attestation_has_tool_version_and_fingerprint ... ok
[INFO] [stdout] test runner::tests::test_fingerprint_changes_when_nix_devbox_cargo_added ... ok
[INFO] [stdout] test runner::tests::test_fingerprint_identical_for_identical_inputs ... ok
[INFO] [stdout] test runner::tests::test_env_fingerprint_discovers_uv_lock_under_workspace_root ... ok
[INFO] [stdout] test runner::tests::test_args_are_passed_verbatim ... ok
[INFO] [stdout] test runner::tests::test_env_fingerprint_changes_with_tool_version ... ok
[INFO] [stdout] test runner::tests::test_env_fingerprint_discovers_uv_lock_in_non_cargo_repo ... ok
[INFO] [stdout] test runner::tests::test_lookup_cargo_mutants ... ok
[INFO] [stdout] test runner::tests::test_env_fingerprint_no_lockfiles_up_tree_renders_none ... ok
[INFO] [stdout] test runner::tests::test_parse_timeout_defaults_and_overrides ... ok
[INFO] [stdout] test runner::tests::test_nix_digest_order_independent ... ok
[INFO] [stdout] test runner::tests::test_env_fingerprint_reads_real_workspace_lockfile ... ok
[INFO] [stdout] test runner::tests::test_signal_killed_child_reports_minus_one ... ok
[INFO] [stdout] test runner::tests::test_nix_segment_parser_validates_nix32_shape ... ok
[INFO] [stdout] test runner::tests::test_run_with_timeout_allowlisted_tool ... ok
[INFO] [stderr] kill: (640): No such process
[INFO] [stdout] test runner::tests::test_hanging_tool_times_out ... ok
[INFO] [stdout] test runner::tests::test_env_fingerprint_stable_across_runs ... ok
[INFO] [stdout] test runner::tests::test_no_shell_used ... ok
[INFO] [stdout] test runner::tests::test_kill_process_group_fallback_kills_child ... ok
[INFO] [stdout] test runner::tests::validate_arg_rejects_tab_metachar ... ok
[INFO] [stderr] kill: (668): No such process
[INFO] [stdout] test runner::tests::test_timeout_kills_process_tree ... FAILED
[INFO] [stdout] test runner::tests::test_tool_version_falls_back_for_failing_tool ... FAILED
[INFO] [stdout] test runner::tests::test_tool_version_is_real_output ... FAILED
[INFO] [stdout] test runner::tests::test_tool_version_reports_successful_tool_version ... FAILED
[INFO] [stdout] test verify::tests::test_failed_run_without_claim_appends_nothing ... ok
[INFO] [stdout] test verify::tests::test_failed_run_appends_discrepancy_entry ... FAILED
[INFO] [stdout] test verify::tests::test_git_state_from_marks_dirty_worktree ... FAILED
[INFO] [stdout] test runner::tests::test_wait_with_timeout_normal_completion ... FAILED
[INFO] [stdout] test verify::tests::test_git_state_from_reports_real_head ... FAILED
[INFO] [stdout] test verify::tests::test_appended_entry_is_verified_state ... FAILED
[INFO] [stdout] test verify::tests::test_attestation_ts_is_wallclock_epoch_millis ... FAILED
[INFO] [stdout] test verify::tests::test_tier_set_with_present_digest_passes_through ... ok
[INFO] [stdout] test verify::tests::test_tri_state_from_ledger_round_trips_validated ... ok
[INFO] [stdout] test verify::tests::test_claim_git_mismatch_boolean_combos ... FAILED
[INFO] [stdout] test verify::tests::test_discrepancy_ts_is_wallclock_epoch_millis ... FAILED
[INFO] [stdout] test verify::tests::test_truncate_ascii_caps_at_limit ... ok
[INFO] [stdout] test verify::tests::test_git_state_from_non_repo_fails_open ... ok
[INFO] [stdout] test verify::tests::test_legacy_path_without_tier_stays_untouched ... ok
[INFO] [stdout] test verify::tests::test_truncate_utf8_loop_terminates ... ok
[INFO] [stdout] test verify::tests::test_tri_state_from_ledger_round_trips_verified ... ok
[INFO] [stdout] test verify::tests::test_tier_set_with_missing_digest_fails_closed ... ok
[INFO] [stdout] test verify::tests::test_tri_state_from_ledger_keeps_claim_state ... ok
[INFO] [stdout] test verify::tests::test_truncate_ascii_never_returns_longer_than_limit ... ok
[INFO] [stdout] test verify::tests::test_verify_fails_on_tool_error ... FAILED
[INFO] [stdout] test verify::tests::test_tri_state_from_ledger_never_fabricates_validated ... ok
[INFO] [stdout] test verify::tests::test_verify_payload_carries_actual_git_state ... FAILED
[INFO] [stdout] test verify::tests::test_verify_promotes_claim_with_tool_attestation ... FAILED
[INFO] [stdout] test verify::tests::test_truncate_utf8_terminates_with_prefix ... ok
[INFO] [stdout] test verify::tests::test_verify_fails_without_claim ... ok
[INFO] [stdout] test verify::tests::test_truncate_utf8_preserves_codepoints ... ok
[INFO] [stdout] test verify::tests::test_verify_rejects_wrong_task_id ... ok
[INFO] [stdout] test verify::tests::test_verify_rejects_non_claim_entry ... ok
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- runner::tests::test_timeout_kills_process_tree stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'runner::tests::test_timeout_kills_process_tree' (619) panicked at src/runner.rs:1883:13:
[INFO] [stdout] grandchild 671 survived the process-group kill
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc3097473d - polyforge_toolrunner[effdd2ad65b987e4]::runner::tests::test_timeout_kills_process_tree
[INFO] [stdout]   12:     0x5cdc3099df99 - <polyforge_toolrunner[effdd2ad65b987e4]::runner::tests::test_timeout_kills_process_tree::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   13:     0x5cdc309aed9b - 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:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   15:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   16:     0x5cdc309bf562 - <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:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   18:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   19:     0x72aa5380f3d4 - clone
[INFO] [stdout]   20:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- runner::tests::test_tool_version_falls_back_for_failing_tool stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'runner::tests::test_tool_version_falls_back_for_failing_tool' (620) panicked at src/runner.rs:1987:51:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc30a5e3b2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5cdc309798bc - polyforge_toolrunner[effdd2ad65b987e4]::runner::tests::test_tool_version_falls_back_for_failing_tool
[INFO] [stdout]   13:     0x5cdc3099e359 - <polyforge_toolrunner[effdd2ad65b987e4]::runner::tests::test_tool_version_falls_back_for_failing_tool::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5cdc309aed9b - 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]   15:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5cdc309bf562 - <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]   18:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   20:     0x72aa5380f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- runner::tests::test_tool_version_is_real_output stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'runner::tests::test_tool_version_is_real_output' (622) panicked at src/runner.rs:1976:51:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc30a5e3b2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5cdc30974cbf - polyforge_toolrunner[effdd2ad65b987e4]::runner::tests::test_tool_version_is_real_output
[INFO] [stdout]   13:     0x5cdc3099dfb9 - <polyforge_toolrunner[effdd2ad65b987e4]::runner::tests::test_tool_version_is_real_output::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5cdc309aed9b - 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]   15:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5cdc309bf562 - <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]   18:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   20:     0x72aa5380f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- runner::tests::test_tool_version_reports_successful_tool_version stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'runner::tests::test_tool_version_reports_successful_tool_version' (641) panicked at src/runner.rs:2000:51:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc30a5e3b2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5cdc3097acbe - polyforge_toolrunner[effdd2ad65b987e4]::runner::tests::test_tool_version_reports_successful_tool_version
[INFO] [stdout]   13:     0x5cdc3099e3f9 - <polyforge_toolrunner[effdd2ad65b987e4]::runner::tests::test_tool_version_reports_successful_tool_version::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5cdc309aed9b - 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]   15:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5cdc309bf562 - <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]   18:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   20:     0x72aa5380f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- verify::tests::test_failed_run_appends_discrepancy_entry stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'verify::tests::test_failed_run_appends_discrepancy_entry' (675) panicked at src/verify.rs:431:48:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc30a5e3b2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5cdc3098c5e8 - polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_failed_run_appends_discrepancy_entry
[INFO] [stdout]   13:     0x5cdc3099e759 - <polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_failed_run_appends_discrepancy_entry::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5cdc309aed9b - 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]   15:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5cdc309bf562 - <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]   18:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   20:     0x72aa5380f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- verify::tests::test_git_state_from_marks_dirty_worktree stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'verify::tests::test_git_state_from_marks_dirty_worktree' (677) panicked at src/verify.rs:838:48:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc30a5e3b2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5cdc3098be8b - polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_git_state_from_marks_dirty_worktree
[INFO] [stdout]   13:     0x5cdc3099e739 - <polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_git_state_from_marks_dirty_worktree::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5cdc309aed9b - 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]   15:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5cdc309bf562 - <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]   18:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   20:     0x72aa5380f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- runner::tests::test_wait_with_timeout_normal_completion stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'runner::tests::test_wait_with_timeout_normal_completion' (645) panicked at src/runner.rs:1927:51:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc30a5e3b2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5cdc30978023 - polyforge_toolrunner[effdd2ad65b987e4]::runner::tests::test_wait_with_timeout_normal_completion
[INFO] [stdout]   13:     0x5cdc3099e1a9 - <polyforge_toolrunner[effdd2ad65b987e4]::runner::tests::test_wait_with_timeout_normal_completion::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5cdc309aed9b - 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]   15:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5cdc309bf562 - <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]   18:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   20:     0x72aa5380f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- verify::tests::test_git_state_from_reports_real_head stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'verify::tests::test_git_state_from_reports_real_head' (679) panicked at src/verify.rs:824:48:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc30a5e3b2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5cdc3098a823 - polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_git_state_from_reports_real_head
[INFO] [stdout]   13:     0x5cdc3099e6b9 - <polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_git_state_from_reports_real_head::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5cdc309aed9b - 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]   15:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5cdc309bf562 - <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]   18:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   20:     0x72aa5380f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- verify::tests::test_appended_entry_is_verified_state stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'verify::tests::test_appended_entry_is_verified_state' (667) panicked at src/verify.rs:594:48:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc30a5e3b2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5cdc3098a1d8 - polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_appended_entry_is_verified_state
[INFO] [stdout]   13:     0x5cdc3099e699 - <polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_appended_entry_is_verified_state::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5cdc309aed9b - 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]   15:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5cdc309bf562 - <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]   18:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   20:     0x72aa5380f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- verify::tests::test_attestation_ts_is_wallclock_epoch_millis stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'verify::tests::test_attestation_ts_is_wallclock_epoch_millis' (669) panicked at src/verify.rs:504:48:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc30a5e3b2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5cdc3098eb77 - polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_attestation_ts_is_wallclock_epoch_millis
[INFO] [stdout]   13:     0x5cdc3099e859 - <polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_attestation_ts_is_wallclock_epoch_millis::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5cdc309aed9b - 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]   15:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5cdc309bf562 - <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]   18:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   20:     0x72aa5380f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- verify::tests::test_claim_git_mismatch_boolean_combos stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'verify::tests::test_claim_git_mismatch_boolean_combos' (670) panicked at src/verify.rs:366:42:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc30a5e3b2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5cdc3098b422 - polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_claim_git_mismatch_boolean_combos
[INFO] [stdout]   13:     0x5cdc3099e6d9 - <polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_claim_git_mismatch_boolean_combos::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5cdc309aed9b - 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]   15:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5cdc309bf562 - <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]   18:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   20:     0x72aa5380f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- verify::tests::test_discrepancy_ts_is_wallclock_epoch_millis stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'verify::tests::test_discrepancy_ts_is_wallclock_epoch_millis' (674) panicked at src/verify.rs:529:48:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc30a5e3b2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5cdc3098f332 - polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_discrepancy_ts_is_wallclock_epoch_millis
[INFO] [stdout]   13:     0x5cdc3099e879 - <polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_discrepancy_ts_is_wallclock_epoch_millis::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5cdc309aed9b - 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]   15:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5cdc309bf562 - <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]   18:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   20:     0x72aa5380f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- verify::tests::test_verify_fails_on_tool_error stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'verify::tests::test_verify_fails_on_tool_error' (693) panicked at src/verify.rs:572:48:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc30a5e3b2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5cdc30988bb1 - polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_verify_fails_on_tool_error
[INFO] [stdout]   13:     0x5cdc3099e559 - <polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_verify_fails_on_tool_error::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5cdc309aed9b - 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]   15:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5cdc309bf562 - <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]   18:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   20:     0x72aa5380f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- verify::tests::test_verify_payload_carries_actual_git_state stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'verify::tests::test_verify_payload_carries_actual_git_state' (695) panicked at src/verify.rs:366:42:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc30a5e3b2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5cdc3098dcd2 - polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_verify_payload_carries_actual_git_state
[INFO] [stdout]   13:     0x5cdc3099e839 - <polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_verify_payload_carries_actual_git_state::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5cdc309aed9b - 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]   15:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5cdc309bf562 - <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]   18:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   20:     0x72aa5380f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- verify::tests::test_verify_promotes_claim_with_tool_attestation stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'verify::tests::test_verify_promotes_claim_with_tool_attestation' (697) panicked at src/verify.rs:476:48:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: PoisonError { .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5cdc30a47d81 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5cdc30a5deaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5cdc30a4cb7c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5cdc30a21666 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5cdc30a3ef79 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5cdc309bbab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5cdc30a3f2a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5cdc30a21712 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5cdc30a1a0f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5cdc30a223fd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5cdc30a5e5dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5cdc30a5e3b2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5cdc30990951 - polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_verify_promotes_claim_with_tool_attestation
[INFO] [stdout]   13:     0x5cdc3099e959 - <polyforge_toolrunner[effdd2ad65b987e4]::verify::tests::test_verify_promotes_claim_with_tool_attestation::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5cdc309aed9b - 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]   15:     0x5cdc309bc405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5cdc309b5cc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5cdc309bf562 - <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]   18:     0x5cdc30a46dc9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x72aa5377bdfa - <unknown>
[INFO] [stdout]   20:     0x72aa5380f3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     runner::tests::test_timeout_kills_process_tree
[INFO] [stdout]     runner::tests::test_tool_version_falls_back_for_failing_tool
[INFO] [stdout]     runner::tests::test_tool_version_is_real_output
[INFO] [stdout]     runner::tests::test_tool_version_reports_successful_tool_version
[INFO] [stdout]     runner::tests::test_wait_with_timeout_normal_completion
[INFO] [stdout]     verify::tests::test_appended_entry_is_verified_state
[INFO] [stdout]     verify::tests::test_attestation_ts_is_wallclock_epoch_millis
[INFO] [stdout]     verify::tests::test_claim_git_mismatch_boolean_combos
[INFO] [stdout]     verify::tests::test_discrepancy_ts_is_wallclock_epoch_millis
[INFO] [stdout]     verify::tests::test_failed_run_appends_discrepancy_entry
[INFO] [stdout]     verify::tests::test_git_state_from_marks_dirty_worktree
[INFO] [stdout]     verify::tests::test_git_state_from_reports_real_head
[INFO] [stdout]     verify::tests::test_verify_fails_on_tool_error
[INFO] [stdout]     verify::tests::test_verify_payload_carries_actual_git_state
[INFO] [stdout]     verify::tests::test_verify_promotes_claim_with_tool_attestation
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 74 passed; 15 failed; 0 ignored; 0 measured; 0 filtered out; finished in 6.39s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "0da24e15bbaa3dae29726cad54fe4d8a62ce28320da447619aba356bc66b4bfd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0da24e15bbaa3dae29726cad54fe4d8a62ce28320da447619aba356bc66b4bfd", kill_on_drop: false }`
[INFO] [stdout] 0da24e15bbaa3dae29726cad54fe4d8a62ce28320da447619aba356bc66b4bfd
