[INFO] cloning repository https://github.com/sabercat204/phonetool
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/sabercat204/phonetool" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fsabercat204%2Fphonetool", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fsabercat204%2Fphonetool'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] b384151da6f52b8773a1a697ec6ac6754a796b37
[INFO] testing sabercat204/phonetool against 1.100.0-beta.1 for beta-1.100-4
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fsabercat204%2Fphonetool" "/workspace/builds/worker-6-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-6-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/sabercat204/phonetool
[INFO] finished tweaking git repo https://github.com/sabercat204/phonetool
[INFO] tweaked toml for git repo https://github.com/sabercat204/phonetool written to /workspace/builds/worker-6-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/sabercat204/phonetool 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 git repo https://github.com/sabercat204/phonetool 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] [stderr] warning: unused workspace dependency `anyhow`
[INFO] [stderr]   --> Cargo.toml:10:1
[INFO] [stderr]    |
[INFO] [stderr] 10 | anyhow = "1"
[INFO] [stderr]    | ^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::unused_workspace_dependencies` is set to `warn` by default
[INFO] [stderr] help: consider removing the workspace dependency `anyhow`
[INFO] [stderr] warning: unused workspace dependency `phonetool-subprocess`
[INFO] [stderr]   --> Cargo.toml:58:25
[INFO] [stderr]    |
[INFO] [stderr] 58 | [workspace.dependencies.phonetool-subprocess]
[INFO] [stderr]    |                         ^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr] help: consider removing the workspace dependency `phonetool-subprocess`
[INFO] [stderr] warning: workspace (manifest) generated 2 warnings
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] 74002129db6729eedd68bcb72c81640d97c5c65684cfb1be117fee5b01f9e2fe
[INFO] running `Command { std: "docker" "start" "74002129db6729eedd68bcb72c81640d97c5c65684cfb1be117fee5b01f9e2fe", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "74002129db6729eedd68bcb72c81640d97c5c65684cfb1be117fee5b01f9e2fe", 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" "74002129db6729eedd68bcb72c81640d97c5c65684cfb1be117fee5b01f9e2fe" "/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" "74002129db6729eedd68bcb72c81640d97c5c65684cfb1be117fee5b01f9e2fe", 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" "74002129db6729eedd68bcb72c81640d97c5c65684cfb1be117fee5b01f9e2fe" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] warning: unused workspace dependency `anyhow`
[INFO] [stderr]   --> Cargo.toml:10:1
[INFO] [stderr]    |
[INFO] [stderr] 10 | anyhow = "1"
[INFO] [stderr]    | ^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::unused_workspace_dependencies` is set to `warn` by default
[INFO] [stderr] help: consider removing the workspace dependency `anyhow`
[INFO] [stderr] warning: unused workspace dependency `phonetool-subprocess`
[INFO] [stderr]   --> Cargo.toml:58:25
[INFO] [stderr]    |
[INFO] [stderr] 58 | [workspace.dependencies.phonetool-subprocess]
[INFO] [stderr]    |                         ^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr] help: consider removing the workspace dependency `phonetool-subprocess`
[INFO] [stderr] warning: workspace (manifest) generated 2 warnings
[INFO] [stderr]    Compiling quote v1.0.46
[INFO] [stderr]    Compiling zerocopy v0.8.53
[INFO] [stderr]    Compiling pkg-config v0.3.33
[INFO] [stderr]    Compiling serde_json v1.0.150
[INFO] [stderr]    Compiling ahash v0.8.12
[INFO] [stderr]    Compiling cc v1.2.66
[INFO] [stderr]    Compiling smallvec v1.15.2
[INFO] [stderr]    Compiling fallible-iterator v0.3.0
[INFO] [stderr]    Compiling bitflags v2.13.0
[INFO] [stderr]    Compiling memchr v2.8.2
[INFO] [stderr]    Compiling fallible-streaming-iterator v0.1.9
[INFO] [stderr]    Compiling strength_reduce v0.2.4
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling log v0.4.33
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling syn v2.0.118
[INFO] [stderr]    Compiling libsqlite3-sys v0.30.1
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling primal-check v0.3.4
[INFO] [stderr]    Compiling transpose v0.2.3
[INFO] [stderr]    Compiling rustfft v6.4.1
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling hashbrown v0.14.5
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling clap_derive v4.6.1
[INFO] [stderr]    Compiling hashlink v0.9.1
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling tracing-subscriber v0.3.23
[INFO] [stderr]    Compiling clap v4.6.1
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling phonetool-authgate v0.17.0 (/opt/rustwide/workdir/crates/phonetool-authgate)
[INFO] [stderr]    Compiling rusqlite v0.32.1
[INFO] [stderr]    Compiling phonetool-core v0.17.0 (/opt/rustwide/workdir/crates/phonetool-core)
[INFO] [stderr]    Compiling phonetool-numintel v0.17.0 (/opt/rustwide/workdir/crates/phonetool-numintel)
[INFO] [stderr]    Compiling phonetool-sdr-rx v0.17.0 (/opt/rustwide/workdir/crates/phonetool-sdr-rx)
[INFO] [stderr]    Compiling phonetool-rf-tx v0.17.0 (/opt/rustwide/workdir/crates/phonetool-rf-tx)
[INFO] [stderr]    Compiling phonetool-attest v0.17.0 (/opt/rustwide/workdir/crates/phonetool-attest)
[INFO] [stderr]    Compiling phonetool-subprocess v0.17.0 (/opt/rustwide/workdir/crates/phonetool-subprocess)
[INFO] [stderr]    Compiling phonetool-wardial v0.17.0 (/opt/rustwide/workdir/crates/phonetool-wardial)
[INFO] [stderr]    Compiling phonetool-ss7 v0.17.0 (/opt/rustwide/workdir/crates/phonetool-ss7)
[INFO] [stderr]    Compiling phonetool-cell-survey v0.17.0 (/opt/rustwide/workdir/crates/phonetool-cell-survey)
[INFO] [stderr]    Compiling phonetool-legacy-hw v0.17.0 (/opt/rustwide/workdir/crates/phonetool-legacy-hw)
[INFO] [stderr]    Compiling phonetool-sip v0.17.0 (/opt/rustwide/workdir/crates/phonetool-sip)
[INFO] [stderr]    Compiling phonetool-baittriage v0.17.0 (/opt/rustwide/workdir/crates/phonetool-baittriage)
[INFO] [stderr]    Compiling phonetool-gnss v0.17.0 (/opt/rustwide/workdir/crates/phonetool-gnss)
[INFO] [stderr]    Compiling phonetool-cli v0.17.0 (/opt/rustwide/workdir/crates/phonetool-cli)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 33.81s
[INFO] running `Command { std: "docker" "inspect" "74002129db6729eedd68bcb72c81640d97c5c65684cfb1be117fee5b01f9e2fe", 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" "74002129db6729eedd68bcb72c81640d97c5c65684cfb1be117fee5b01f9e2fe" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] warning: unused workspace dependency `anyhow`
[INFO] [stderr]   --> Cargo.toml:10:1
[INFO] [stderr]    |
[INFO] [stderr] 10 | anyhow = "1"
[INFO] [stderr]    | ^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::unused_workspace_dependencies` is set to `warn` by default
[INFO] [stderr] help: consider removing the workspace dependency `anyhow`
[INFO] [stderr] warning: unused workspace dependency `phonetool-subprocess`
[INFO] [stderr]   --> Cargo.toml:58:25
[INFO] [stderr]    |
[INFO] [stderr] 58 | [workspace.dependencies.phonetool-subprocess]
[INFO] [stderr]    |                         ^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr] help: consider removing the workspace dependency `phonetool-subprocess`
[INFO] [stderr] warning: workspace (manifest) generated 2 warnings
[INFO] [stderr]    Compiling bitflags v2.13.0
[INFO] [stderr]    Compiling libc v0.2.186
[INFO] [stderr]    Compiling fastrand v2.4.1
[INFO] [stderr]    Compiling phonetool-authgate v0.17.0 (/opt/rustwide/workdir/crates/phonetool-authgate)
[INFO] [stderr]    Compiling rusqlite v0.32.1
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling phonetool-core v0.17.0 (/opt/rustwide/workdir/crates/phonetool-core)
[INFO] [stderr]    Compiling phonetool-numintel v0.17.0 (/opt/rustwide/workdir/crates/phonetool-numintel)
[INFO] [stderr]    Compiling phonetool-sdr-rx v0.17.0 (/opt/rustwide/workdir/crates/phonetool-sdr-rx)
[INFO] [stderr]    Compiling phonetool-subprocess v0.17.0 (/opt/rustwide/workdir/crates/phonetool-subprocess)
[INFO] [stderr]    Compiling phonetool-sip v0.17.0 (/opt/rustwide/workdir/crates/phonetool-sip)
[INFO] [stderr]    Compiling phonetool-cell-survey v0.17.0 (/opt/rustwide/workdir/crates/phonetool-cell-survey)
[INFO] [stderr]    Compiling phonetool-legacy-hw v0.17.0 (/opt/rustwide/workdir/crates/phonetool-legacy-hw)
[INFO] [stderr]    Compiling phonetool-ss7 v0.17.0 (/opt/rustwide/workdir/crates/phonetool-ss7)
[INFO] [stderr]    Compiling phonetool-attest v0.17.0 (/opt/rustwide/workdir/crates/phonetool-attest)
[INFO] [stderr]    Compiling phonetool-rf-tx v0.17.0 (/opt/rustwide/workdir/crates/phonetool-rf-tx)
[INFO] [stderr]    Compiling phonetool-wardial v0.17.0 (/opt/rustwide/workdir/crates/phonetool-wardial)
[INFO] [stderr]    Compiling phonetool-baittriage v0.17.0 (/opt/rustwide/workdir/crates/phonetool-baittriage)
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling phonetool-gnss v0.17.0 (/opt/rustwide/workdir/crates/phonetool-gnss)
[INFO] [stderr]    Compiling phonetool-cli v0.17.0 (/opt/rustwide/workdir/crates/phonetool-cli)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 18.36s
[INFO] running `Command { std: "docker" "inspect" "74002129db6729eedd68bcb72c81640d97c5c65684cfb1be117fee5b01f9e2fe", 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" "74002129db6729eedd68bcb72c81640d97c5c65684cfb1be117fee5b01f9e2fe" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] warning: unused workspace dependency `anyhow`
[INFO] [stderr]   --> Cargo.toml:10:1
[INFO] [stderr]    |
[INFO] [stderr] 10 | anyhow = "1"
[INFO] [stderr]    | ^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::unused_workspace_dependencies` is set to `warn` by default
[INFO] [stderr] help: consider removing the workspace dependency `anyhow`
[INFO] [stderr] warning: unused workspace dependency `phonetool-subprocess`
[INFO] [stderr]   --> Cargo.toml:58:25
[INFO] [stderr]    |
[INFO] [stderr] 58 | [workspace.dependencies.phonetool-subprocess]
[INFO] [stderr]    |                         ^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr] help: consider removing the workspace dependency `phonetool-subprocess`
[INFO] [stderr] warning: workspace (manifest) generated 2 warnings
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.24s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/phonetool-attest/890ed0ed06d0d7a7/out/phonetool_attest-890ed0ed06d0d7a7)
[INFO] [stdout] 
[INFO] [stdout] running 24 tests
[INFO] [stdout] test passport::tests::decode_round_trips ... ok
[INFO] [stderr]      Running tests/inspect.rs (/opt/rustwide/target/debug/build/phonetool-attest/92c356b3c89763ce/out/inspect-92c356b3c89763ce)
[INFO] [stdout] test passport::tests::empty_input_errors ... ok
[INFO] [stdout] test passport::tests::classify_levels ... ok
[INFO] [stdout] test passport::tests::alg_none_confusion_recorded_not_trusted ... ok
[INFO] [stdout] test passport::tests::base64url_single_leftover_char_rejected ... ok
[INFO] [stdout] test passport::tests::base64url_decoding_to_non_json_errors ... ok
[INFO] [stdout] test passport::tests::missing_attest_is_none_with_finding ... ok
[INFO] [stdout] test passport::tests::oversized_header_rejected_before_decode ... ok
[INFO] [stdout] test passport::tests::non_utf8_bytes_do_not_panic ... ok
[INFO] [stdout] test passport::tests::non_base64url_segment_errors ... ok
[INFO] [stdout] test passport::tests::parses_full_attestation ... ok
[INFO] [stdout] test passport::tests::strips_header_parameters ... ok
[INFO] [stdout] test sipmsg::tests::line_folding_joined ... ok
[INFO] [stdout] test passport::tests::two_segment_token_malformed ... ok
[INFO] [stdout] test sipmsg::tests::looks_like_sip_detects_message_and_headers ... ok
[INFO] [stdout] test sipmsg::tests::extracts_single_identity ... ok
[INFO] [stdout] test sipmsg::tests::bare_lf_tolerated ... ok
[INFO] [stdout] test passport::tests::unexpected_alg_finding_no_coercion ... ok
[INFO] [stdout] test sipmsg::tests::case_insensitive_header_name ... ok
[INFO] [stdout] test sipmsg::tests::no_identity_header_is_empty_not_error ... ok
[INFO] [stdout] test sipmsg::tests::non_utf8_does_not_panic ... ok
[INFO] [stdout] test passport::tests::unexpected_ppt_finding ... ok
[INFO] [stdout] test passport::tests::unknown_attest_not_coerced ... ok
[INFO] [stdout] test passport::tests::oversized_segment_rejected ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test garbage_non_sip_non_token_is_invalid_input ... ok
[INFO] [stdout] test inline_and_file_sources_are_equivalent ... ok
[INFO] [stdout] test empty_arg_is_empty_error ... ok
[INFO] [stdout] test unknown_attest_value_not_coerced ... ok
[INFO] [stdout] test unsupported_verb_rejected ... ok
[INFO] [stdout] test sip_message_with_identity_parses ... ok
[INFO] [stdout] test sip_message_without_identity_is_unsigned_finding ... ok
[INFO] [stdout] test inline_token_reports_full_structural_only ... ok
[INFO] [stdout] test manifest_is_passive_ip ... ok
[INFO] [stdout] test missing_file_is_backend_error ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/phonetool-authgate/153b3378d6baa92f/out/phonetool_authgate-153b3378d6baa92f)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/gate_behavior.rs (/opt/rustwide/target/debug/build/phonetool-authgate/08aea26a1e82be37/out/gate_behavior-08aea26a1e82be37)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test wire_request_fails_closed_on_empty_line_id ... ok
[INFO] [stdout] test ip_request_fails_closed_on_empty_target ... ok
[INFO] [stdout] test ip_grant_succeeds_with_target_and_basis ... ok
[INFO] [stdout] test tx_grant_carries_regulatory_basis ... ok
[INFO] [stdout] test ip_request_fails_closed_on_empty_basis ... ok
[INFO] [stdout] test wire_request_fails_closed_on_empty_plant_basis ... ok
[INFO] [stdout] test wire_grant_succeeds_with_line_and_basis ... ok
[INFO] [stdout] test tx_request_fails_closed_on_nonfinite_power ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/phonetool-baittriage/12a0c9a6e115d57d/out/phonetool_baittriage-12a0c9a6e115d57d)
[INFO] [stdout] 
[INFO] [stdout] running 35 tests
[INFO] [stdout] test correlate::tests::bait_hash_is_stable_and_order_independent_of_input_repeats ... ok
[INFO] [stdout] test extract::tests::transcript_does_not_invent_phone_from_prose ... ok
[INFO] [stdout] test extract::tests::bad_phone_is_skipped_not_fatal ... ok
[INFO] [stdout] test extract::tests::email_domain_lowercased_local_preserved ... ok
[INFO] [stdout] test extract::tests::empty_bundle_yields_nothing ... ok
[INFO] [stdout] test ingest::tests::a_url_only_bundle_parses_but_nothing_is_fetched ... ok
[INFO] [stdout] test extract::tests::ioc_count_bounded_by_max ... ok
[INFO] [stdout] test extract::tests::phone_normalizes_to_one_e164_across_formats ... ok
[INFO] [stdout] test ingest::tests::malformed_json_is_malformed_not_panic ... ok
[INFO] [stdout] test ingest::tests::empty_object_parses_to_all_none ... ok
[INFO] [stdout] test correlate::tests::prior_case_from_different_bait ... ok
[INFO] [stdout] test extract::tests::url_host_lowercased_path_preserved ... ok
[INFO] [stdout] test correlate::tests::reuse_write_is_idempotent ... ok
[INFO] [stdout] test correlate::tests::known_bad_hit_is_correlation_and_counts ... ok
[INFO] [stdout] test correlate::tests::cutoffs_grade_above_low_when_injected ... ok
[INFO] [stdout] test ingest::tests::well_formed_bundle_parses ... ok
[INFO] [stdout] test ingest::tests::oversize_arg_rejected_before_parse ... ok
[INFO] [stdout] test correlate::tests::empty_signature_store_is_unknown ... ok
[INFO] [stdout] test correlate::tests::no_correlation_is_low_and_marked ... ok
[INFO] [stdout] test ingest::tests::oversize_field_rejected ... ok
[INFO] [stdout] test extract::tests::transcript_lifts_url_and_email ... ok
[INFO] [stdout] test extract::tests::duplicate_indicators_deduped ... ok
[INFO] [stdout] test ingest::tests::unknown_field_is_rejected ... ok
[INFO] [stdout] test tests::empty_arg_is_invalid_input ... ok
[INFO] [stdout] test tests::malformed_bundle_is_invalid_input ... ok
[INFO] [stdout] test correlate::tests::signature_classifies_and_unrecognized_does_not ... ok
[INFO] [stdout] test ingest::tests::empty_and_whitespace_are_empty ... ok
[INFO] [stdout] test correlate::tests::without_cutoffs_confidence_stays_low_even_with_corroboration ... ok
[INFO] [stdout] test correlate::tests::own_reuse_write_is_not_a_prior_case ... ok
[INFO] [stdout] test tests::zero_iocs_is_empty_degenerate ... ok
[INFO] [stdout] test tests::unsupported_verb_rejected ... ok
[INFO] [stdout] test tests::empty_object_is_empty_degenerate ... ok
[INFO] [stdout] test tests::provenance_carried_by_path_never_read ... ok
[INFO] [stdout] test tests::thin_result_is_ok_low_no_correlation ... ok
[INFO] [stdout] test extract::tests::wallet_is_opaque_lowercased ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 35 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/assess.rs (/opt/rustwide/target/debug/build/phonetool-baittriage/24a3749502772930/out/assess-24a3749502772930)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test thin_result_is_low_without_corroboration ... ok
[INFO] [stdout] test store_backend_failure_surfaces_as_backend_error ... ok
[INFO] [stdout] test prior_case_reuse_hit_correlates ... ok
[INFO] [stdout] test known_bad_hit_correlates ... ok
[INFO] [stdout] test injected_cutoffs_grade_above_low ... ok
[INFO] [stdout] test signature_seed_classifies_pattern ... ok
[INFO] [stdout] test reuse_write_back_is_idempotent_across_retriage ... ok
[INFO] [stdout] test zero_iocs_is_empty_error ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/extract.rs (/opt/rustwide/target/debug/build/phonetool-baittriage/6f2695956747c09e/out/extract-6f2695956747c09e)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test duplicate_indicator_across_fields_deduped ... ok
[INFO] [stdout] test bad_artifact_skipped_rest_extracted ... ok
[INFO] [stdout] test phone_three_ways_normalizes_to_one_e164 ... ok
[INFO] [stdout] test transcript_lifts_url_and_email_but_not_prose_numbers ... ok
[INFO] [stderr]      Running tests/ingest.rs (/opt/rustwide/target/debug/build/phonetool-baittriage/1c8c12d08b8e1ab3/out/ingest-1c8c12d08b8e1ab3)
[INFO] [stdout] test many_indicators_bounded ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test non_utf8_bytes_do_not_panic ... ok
[INFO] [stdout] test oversize_bundle_rejected ... ok
[INFO] [stdout] test hostile_inputs_map_to_typed_errors_never_panic ... ok
[INFO] [stdout] test artifact_url_is_never_contacted ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/phonetool-cell-survey/287f6c3538fe6acd/out/phonetool_cell_survey-287f6c3538fe6acd)
[INFO] [stdout] 
[INFO] [stdout] running 44 tests
[INFO] [stdout] test cellmap::tests::aggregates_distinct_cells ... ok
[INFO] [stdout] test cellmap::tests::deduplicates_identical_observations ... ok
[INFO] [stdout] test cellmap::tests::retains_conflicting_observations_of_one_identity ... ok
[INFO] [stdout] test cellmap::tests::undecoded_neighbour_list_is_not_recorded_as_no_neighbours ... ok
[INFO] [stdout] test decode_gsm::tests::empty_si2_bitmap0_yields_no_neighbours_not_undecoded ... ok
[INFO] [stdout] test decode_gsm::tests::decodes_three_digit_mnc ... ok
[INFO] [stdout] test cellmap::tests::builds_neighbour_edges_from_gsm ... ok
[INFO] [stdout] test decode_gsm::tests::decodes_si2_bitmap0_neighbours ... ok
[INFO] [stdout] test decode_gsm::tests::si2_range_format_is_flagged_undecoded_not_fabricated ... ok
[INFO] [stdout] test decode_gsm::tests::truncated_si2_neighbour_ie_is_flagged_undecoded ... ok
[INFO] [stdout] test detect::tests::clean_map_against_matching_baseline_yields_no_flags ... ok
[INFO] [stdout] test decode_gsm::tests::decodes_si3_identity ... ok
[INFO] [stdout] test decode_gsm::tests::unknown_message_type_is_a_decode_miss ... ok
[INFO] [stdout] test detect::tests::flags_duplicate_identity_on_parameter_flip ... ok
[INFO] [stdout] test detect::tests::signal_geometry_flags_when_threshold_injected ... ok
[INFO] [stdout] test detect::tests::signal_geometry_skipped_without_threshold ... ok
[INFO] [stdout] test source::tests::empty_but_valid_pcap_yields_no_segments ... ok
[INFO] [stdout] test detect::tests::undecoded_neighbours_do_not_trigger_missing ... ok
[INFO] [stdout] test source::tests::parses_a_well_formed_gsmtap_frame ... ok
[INFO] [stdout] test source::tests::rejects_a_non_pcap_file ... ok
[INFO] [stdout] test source::tests::skips_a_non_um_gsmtap_frame_without_failing ... ok
[INFO] [stdout] test detect::tests::flags_forced_reregistration ... ok
[INFO] [stdout] test source::tests::big_endian_pcap_is_read ... ok
[INFO] [stdout] test decode_gsm::tests::hostile_inputs_never_panic ... ok
[INFO] [stdout] test source::tests::rejects_a_wrong_link_type ... ok
[INFO] [stdout] test source::tests::tolerates_a_truncated_final_record ... ok
[INFO] [stdout] test detect::tests::flags_missing_neighbours ... ok
[INFO] [stdout] test tests::empty_arg_is_invalid_input ... ok
[INFO] [stdout] test source::tests::live_source_is_unavailable ... ok
[INFO] [stdout] test tests::lte_nr_segments_are_decode_misses_today ... ok
[INFO] [stdout] test tests::manifest_is_passive_rfrx ... ok
[INFO] [stdout] test decode_gsm::tests::invalid_bcd_nibble_leaves_plmn_absent ... ok
[INFO] [stdout] test decode_gsm::tests::non_rr_message_is_a_decode_miss ... ok
[INFO] [stdout] test tests::event_carries_no_raw_samples ... ok
[INFO] [stdout] test source::tests::tolerates_a_gsmtap_frame_shorter_than_its_header ... ok
[INFO] [stdout] test source::tests::strips_pcs_and_uplink_flag_bits_from_arfcn ... ok
[INFO] [stdout] test tests::unsupported_verb_is_rejected ... ok
[INFO] [stdout] test tests::zero_decoded_cells_is_empty_failure ... ok
[INFO] [stdout] test decode_gsm::tests::truncated_si3_does_not_panic ... ok
[INFO] [stdout] test tests::one_decoded_cell_is_ok_event ... ok
[INFO] [stdout] test tests::missing_file_is_invalid_input ... ok
[INFO] [stdout] test detect::tests::flags_unexpected_plmn ... ok
[INFO] [stdout] test detect::tests::confidence_is_none_without_injected_weight_and_set_with_it ... ok
[INFO] [stdout] test detect::tests::empty_baseline_does_not_flag_unexpected_plmn ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 44 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/survey.rs (/opt/rustwide/target/debug/build/phonetool-cell-survey/7411dc841d2a1eb1/out/survey-7411dc841d2a1eb1)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test a_capture_that_decodes_nothing_is_empty_failure ... ok
[INFO] [stdout] test garbage_file_is_invalid_input ... ok
[INFO] [stdout] test event_data_carries_decoded_cells_not_raw_samples ... ok
[INFO] [stdout] test manifest_lists_as_passive_rfrx ... ok
[INFO] [stdout] test decodes_a_recorded_capture_end_to_end ... ok
[INFO] [stdout] test missing_file_is_invalid_input_not_a_panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/build/phonetool-cli/8e294f9b5bc9149a/out/phonetool-8e294f9b5bc9149a)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/phonetool-core/dd25973ef6d2b8cd/out/phonetool_core-dd25973ef6d2b8cd)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test capture::tests::file_sink_persists_records_as_jsonl ... ok
[INFO] [stdout] test capture::tests::record_capture_appends_a_reference_not_the_samples ... ok
[INFO] [stdout] test capture::tests::bulk_references_share_the_timeline_with_events_in_order ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/registry_arbitration.rs (/opt/rustwide/target/debug/build/phonetool-core/35c7fd2d2fa18c39/out/registry_arbitration-35c7fd2d2fa18c39)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test dispatch_tx_rejects_an_unknown_plugin ... ok
[INFO] [stdout] test ip_transducer_is_shareable ... ok
[INFO] [stdout] test dispatch_wire_carries_the_wiregrant_to_the_plugin ... ok
[INFO] [stdout] test dispatch_paths_are_isolated_by_class ... ok
[INFO] [stdout] test dispatch_tx_carries_the_txgrant_to_the_plugin ... ok
[INFO] [stdout] test a_wire_grant_cannot_reach_a_tx_plugin_and_vice_versa ... ok
[INFO] [stdout] test a_wire_plugin_holds_the_exclusive_wireline_port ... ok
[INFO] [stdout] test store_transducer_is_shareable ... ok
[INFO] [stdout] test two_plugins_cannot_both_claim_rftx ... ok
[INFO] [stdout] test two_plugins_cannot_both_claim_wireline ... ok
[INFO] [stdout] test rfrx_transducer_is_shareable ... ok
[INFO] [stdout] test register_tx_shares_the_name_namespace_and_the_rftx_port ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/phonetool-gnss/6177f6bde048fdb1/out/phonetool_gnss-6177f6bde048fdb1)
[INFO] [stdout] 
[INFO] [stdout] running 30 tests
[INFO] [stdout] test gold::tests::code_values_are_plus_minus_one ... ok
[INFO] [stdout] test navmsg::tests::complemented_word_de_complements_to_source ... ok
[INFO] [stdout] test navmsg::tests::wrong_prior_state_fails_parity ... ok
[INFO] [stdout] test navsync::tests::frame_sync_finds_inverted_preamble ... ok
[INFO] [stdout] test navmsg::tests::short_subframe_is_total_no_panic ... ok
[INFO] [stdout] test navmsg::tests::subframe2_3_decode_recovers_orbital_elements ... ok
[INFO] [stdout] test navsync::tests::bit_phase_recovers_known_offset ... ok
[INFO] [stdout] test navsync::tests::correlate_prompts_invalid_prn_empty ... ok
[INFO] [stdout] test navsync::tests::short_stream_frame_sync_empty ... ok
[INFO] [stdout] test navsync::tests::subframe_bits_de_inverts ... ok
[INFO] [stdout] test pvt::tests::file_path_solve_is_honest_none ... ok
[INFO] [stdout] test navmsg::tests::valid_word_passes_parity_and_recovers_source ... ok
[INFO] [stdout] test navsync::tests::insufficient_prompts_no_phase ... ok
[INFO] [stdout] test navsync::tests::no_preamble_in_zero_stream_is_empty ... ok
[INFO] [stdout] test navmsg::tests::single_bit_flip_fails_parity ... ok
[INFO] [stdout] test gold::tests::different_prns_produce_different_codes ... ok
[INFO] [stdout] test navmsg::tests::all_parity_fail_yields_no_ephemeris ... ok
[INFO] [stdout] test gold::tests::invalid_prn_returns_none ... ok
[INFO] [stdout] test navsync::tests::frame_sync_finds_confirmed_preamble ... ok
[INFO] [stdout] test navsync::tests::demod_recovers_bits_up_to_polarity ... ok
[INFO] [stdout] test pvt::tests::invert4_identity_round_trips ... ok
[INFO] [stdout] test pvt::tests::invert4_singular_is_none ... ok
[INFO] [stdout] test navmsg::tests::partial_ephemeris_yields_no_orbital_elements ... ok
[INFO] [stdout] test gold::tests::code_length_is_1023 ... ok
[INFO] [stdout] test pvt::tests::insufficient_geometry_is_none ... ok
[INFO] [stdout] test pvt::tests::kepler_does_not_diverge_on_hostile_eccentricity ... ok
[INFO] [stdout] test pvt::tests::recovers_a_known_receiver_position ... ok
[INFO] [stdout] test pvt::tests::sv_position_is_finite_and_orbital ... ok
[INFO] [stdout] test navsync::tests::correlate_prompts_recovers_bit_signs_from_iq ... ok
[INFO] [stdout] test navsync::tests::correlate_prompts_wrong_prn_is_uncorrelated ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/gnss_pipeline.rs (/opt/rustwide/target/debug/build/phonetool-gnss/bbb83d15a836ae42/out/gnss_pipeline-bbb83d15a836ae42)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test empty_arg_is_invalid_input ... ok
[INFO] [stdout] test manifest_is_passive_rfrx ... ok
[INFO] [stdout] test missing_file_is_backend_error ... ok
[INFO] [stdout] test zero_samples_is_empty ... ok
[INFO] [stdout] test unsupported_verb_rejected ... ok
[INFO] [stdout] test agc_unavailable_on_file_source ... ok
[INFO] [stdout] test single_source_geometry_always_unavailable ... ok
[INFO] [stdout] test integrity_flags_always_present ... ok
[INFO] [stdout] test acquires_a_synthetic_prn_signal ... ok
[INFO] [stdout] test power_anomaly_fires_on_uniform_cn0 ... ok
[INFO] [stdout] test noise_only_is_empty_degenerate ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.19s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/phonetool-legacy-hw/98bde9075fd76a9c/out/phonetool_legacy_hw-98bde9075fd76a9c)
[INFO] [stdout] 
[INFO] [stdout] running 29 tests
[INFO] [stdout] test dsp::tests::cid_no_burst_is_no_frame ... ok
[INFO] [stdout] test dsp::tests::goertzel_peaks_at_target ... ok
[INFO] [stdout] test dsp::tests::sf2600_synth_and_detect ... ok
[INFO] [stdout] test dsp::tests::synth_empty_is_error ... ok
[INFO] [stdout] test dsp::tests::cid_round_trips_a_number ... ok
[INFO] [stdout] test dsp::tests::to_wav_is_valid_riff ... ok
[INFO] [stdout] test dsp::tests::decode_silence_yields_nothing ... ok
[INFO] [stdout] test dsp::tests::synth_then_decode_round_trips_dtmf ... ok
[INFO] [stdout] test sense::tests::non_sense_block_is_none ... ok
[INFO] [stdout] test sense::tests::idle_line_classified_onhook ... ok
[INFO] [stdout] test sense::tests::offhook_line_low_voltage ... ok
[INFO] [stdout] test source::tests::sense_trace_empty_is_error ... ok
[INFO] [stdout] test sense::tests::ringing_detected_by_swing ... ok
[INFO] [stdout] test dsp::tests::synth_rejects_non_dtmf ... ok
[INFO] [stdout] test dsp::tests::decode_noise_yields_nothing_no_fabrication ... ok
[INFO] [stdout] test dsp::tests::cid_corrupt_checksum_reported_not_trusted ... ok
[INFO] [stdout] test source::tests::sense_trace_non_numeric_is_malformed ... ok
[INFO] [stdout] test tests::decode_missing_file_is_invalid_input ... ok
[INFO] [stdout] test source::tests::sense_trace_parses_integers ... ok
[INFO] [stdout] test tests::sense_idle_line_is_ok ... ok
[INFO] [stdout] test source::tests::wav_round_trips_a_tone ... ok
[INFO] [stdout] test source::tests::wav_declared_data_size_overrun_does_not_panic ... ok
[INFO] [stdout] test source::tests::wav_empty_is_empty_error ... ok
[INFO] [stdout] test source::tests::wav_truncates_at_cap_never_overallocates ... ok
[INFO] [stdout] test tests::synth_unencodable_is_invalid_input ... ok
[INFO] [stdout] test tests::sense_empty_trace_is_empty ... ok
[INFO] [stdout] test tests::unsupported_verb_rejected ... ok
[INFO] [stdout] test source::tests::wav_rejects_non_riff ... ok
[INFO] [stderr]      Running tests/line.rs (/opt/rustwide/target/debug/build/phonetool-legacy-hw/dab1300d9ebdec17/out/line-dab1300d9ebdec17)
[INFO] [stdout] test tests::synth_then_decode_via_files ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test unsupported_verb_rejected ... ok
[INFO] [stdout] test sense_empty_trace_is_empty ... ok
[INFO] [stdout] test decode_missing_file_is_invalid_input ... ok
[INFO] [stdout] test sense_idle_vs_offhook ... ok
[INFO] [stdout] test synth_2600_and_decode_detects_sf ... ok
[INFO] [stdout] test synth_unencodable_char_rejected ... ok
[INFO] [stdout] test decode_clean_but_toneless_is_ok_zero ... ok
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/phonetool-numintel/82fe2ca3e17c04c5/out/phonetool_numintel-82fe2ca3e17c04c5)
[INFO] [stdout] test synth_decode_round_trip_via_files ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/degenerate_cases.rs (/opt/rustwide/target/debug/build/phonetool-numintel/0dcc5e24332da40f/out/degenerate_cases-0dcc5e24332da40f)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test unsupported_verb_rejected ... ok
[INFO] [stdout] test registry_loads_and_dispatches_one_plugin ... ok
[INFO] [stdout] test empty_lookup_fails_not_silently_ok ... ok
[INFO] [stdout] test numintel_is_passive_and_registers_on_ip_transducer ... ok
[INFO] [stdout] test malformed_number_rejected_at_boundary ... ok
[INFO] [stdout] test registry_rejects_duplicate_registration ... ok
[INFO] [stdout] test cache_hit_returns_offline_with_no_egress ... ok
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/phonetool-rf-tx/daa5cc02f4c16826/out/phonetool_rf_tx-daa5cc02f4c16826)
[INFO] [stdout] test oversized_number_rejected ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 41 tests
[INFO] [stdout] test bandplan::tests::over_power_refused ... ok
[INFO] [stdout] test bandplan::tests::unknown_band_fails_closed ... ok
[INFO] [stdout] test bandplan::tests::freq_in_wrong_band_refused ... ok
[INFO] [stdout] test bandplan::tests::non_finite_power_fails_closed ... ok
[INFO] [stdout] test payload::tests::callsign_rejects_bad ... ok
[INFO] [stdout] test bandplan::tests::band_edges_inclusive ... ok
[INFO] [stdout] test payload::tests::address_encoding_shifts_left ... ok
[INFO] [stdout] test payload::tests::ax25_frame_rejects_bad_callsign ... ok
[INFO] [stdout] test payload::tests::crc_x25_known_vector ... ok
[INFO] [stdout] test modulate::tests::cw_respects_sample_cap ... ok
[INFO] [stdout] test modulate::tests::cw_zero_wpm_is_bad_config ... ok
[INFO] [stdout] test modulate::tests::fm_ssb_are_declared_seams ... ok
[INFO] [stdout] test payload::tests::cw_case_insensitive ... ok
[INFO] [stdout] test sink::tests::empty_waveform_detected ... ok
[INFO] [stdout] test modulate::tests::cw_single_dit_has_expected_length ... ok
[INFO] [stdout] test bandplan::tests::in_band_passes ... ok
[INFO] [stdout] test sink::tests::audio_len_is_sample_count ... ok
[INFO] [stdout] test modulate::tests::afsk_frame_renders_at_1200_baud ... ok
[INFO] [stdout] test modulate::tests::cw_wpm_scales_inversely ... ok
[INFO] [stdout] test payload::tests::ui_frame_bits_are_flag_delimited ... ok
[INFO] [stdout] test payload::tests::cw_unencodable_char_rejected ... ok
[INFO] [stdout] test sink::tests::file_sink_kind_is_file ... ok
[INFO] [stdout] test bandplan::tests::verbose_band_name_resolves ... ok
[INFO] [stdout] test payload::tests::bit_stuffing_inserts_zero_after_five_ones ... ok
[INFO] [stdout] test payload::tests::cw_empty_yields_no_elements ... ok
[INFO] [stdout] test payload::tests::callsign_parse_with_ssid ... ok
[INFO] [stdout] test payload::tests::cw_word_gap_between_words ... ok
[INFO] [stdout] test payload::tests::cw_encodes_sos ... ok
[INFO] [stdout] test tests::malformed_json_arg_rejected ... ok
[INFO] [stdout] test tests::fm_ssb_are_declared_seams ... ok
[INFO] [stdout] test tests::over_power_refused ... ok
[INFO] [stdout] test tests::freq_out_of_band_refused_before_render ... ok
[INFO] [stdout] test sink::tests::file_sink_writes_le_f32 ... ok
[INFO] [stdout] test sink::tests::iq_len_is_half_sample_count ... ok
[INFO] [stdout] test tests::afsk_render_ok ... ok
[INFO] [stdout] test tests::unencodable_cw_char_rejected ... ok
[INFO] [stdout] test tests::empty_cw_text_is_degenerate ... ok
[INFO] [stdout] test tests::unsupported_scheme_rejected ... ok
[INFO] [stdout] test tests::unknown_band_fails_closed ... ok
[INFO] [stdout] test modulate::tests::afsk_respects_sample_cap ... ok
[INFO] [stdout] test tests::cw_render_writes_file_and_event ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 41 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/transmit.rs (/opt/rustwide/target/debug/build/phonetool-rf-tx/7f7c0a8c0a7e5e89/out/transmit-7f7c0a8c0a7e5e89)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test empty_band_is_fail_closed_refusal_no_grant ... ok
[INFO] [stdout] test empty_license_is_fail_closed_refusal ... ok
[INFO] [stdout] test empty_payload_never_keys_sink ... ok
[INFO] [stdout] test wrong_band_frequency_refused_before_sink ... ok
[INFO] [stdout] test afsk_end_to_end_via_gate ... ok
[INFO] [stdout] test gate_grant_then_render_writes_file_and_logs_grant ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/phonetool-sdr-rx/50f4e6da22297d3e/out/phonetool_sdr_rx-50f4e6da22297d3e)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stderr]      Running tests/offline_pipeline.rs (/opt/rustwide/target/debug/build/phonetool-sdr-rx/9b7425d82cfb3ad0/out/offline_pipeline-9b7425d82cfb3ad0)
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test iq_file_source_empty_file_yields_zero_samples ... ok
[INFO] [stdout] test empty_arg_is_invalid_input ... ok
[INFO] [stdout] test iq_file_source_missing_file_is_backend_error ... ok
[INFO] [stdout] test manifest_is_passive_rfrx ... ok
[INFO] [stdout] test zero_samples_is_empty_not_success ... ok
[INFO] [stdout] test demod_unsupported_mode_rejected ... ok
[INFO] [stdout] test iq_file_source_truncates_beyond_sample_cap ... ok
[INFO] [stdout] test unsupported_verb_rejected ... ok
[INFO] [stdout] test iq_file_source_truncated_bytes_are_discarded ... ok
[INFO] [stdout] test iq_file_source_reads_a_synthesized_tone ... ok
[INFO] [stdout] test demod_fm_produces_audio ... ok
[INFO] [stdout] test identify_on_silence_returns_zero_detections ... ok
[INFO] [stdout] test demod_digital_produces_bits ... ok
[INFO] [stdout] test sweep_finds_power_in_the_tone_bin ... ok
[INFO] [stdout] test identify_detects_a_tone ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/phonetool-sip/2baf74d242bd2618/out/phonetool_sip-2baf74d242bd2618)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/active_enum.rs (/opt/rustwide/target/debug/build/phonetool-sip/405181ca24bd9c8c/out/active_enum-405181ca24bd9c8c)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test illegal_extension_is_rejected_at_the_boundary_before_any_packet ... ok
[INFO] [stdout] test unsupported_verb_is_rejected ... ok
[INFO] [stdout] test empty_extension_list_is_invalid_input ... ok
[INFO] [stdout] test gate_refuses_empty_basis_and_records_it_on_the_production_bus ... ok
[INFO] [stdout] test enumerates_against_a_loopback_responder_via_a_minted_grant ... ok
[INFO] [stdout] test no_listener_is_an_empty_failure_not_an_empty_success ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.62s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/message_parse.rs (/opt/rustwide/target/debug/build/phonetool-sip/967e277ca53d44ea/out/message_parse-967e277ca53d44ea)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test hostile_inputs_error_and_never_panic ... ok
[INFO] [stdout] test accepts_well_formed_responses_with_crlf_and_bare_lf ... ok
[INFO] [stdout] test classify_maps_status_codes_to_enumeration_verdicts ... ok
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/phonetool-ss7/f0f699cd2db64009/out/phonetool_ss7-f0f699cd2db64009)
[INFO] [stdout] test non_utf8_and_giant_inputs_do_not_panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 55 tests
[INFO] [stdout] test ber::tests::empty_buffer_truncated ... ok
[INFO] [stdout] test ber::tests::multi_byte_tag_refused ... ok
[INFO] [stdout] test ber::tests::descending_constructed_value_is_bounded ... ok
[INFO] [stdout] test ber::tests::short_form_primitive ... ok
[INFO] [stdout] test ber::tests::indefinite_length_refused ... ok
[INFO] [stdout] test classify::tests::unknown_map_opcode_is_unknown_class ... ok
[INFO] [stdout] test ber::tests::long_form_length_two_bytes ... ok
[INFO] [stdout] test classify::tests::ati_is_location_disclosure ... ok
[INFO] [stdout] test ber::tests::read_children_flat_sequence ... ok
[INFO] [stdout] test diameter::tests::avp_length_overrun_marks_truncated_no_panic ... ok
[INFO] [stdout] test ber::tests::long_form_over_four_bytes_refused ... ok
[INFO] [stdout] test classify::tests::ulr_is_location_disclosure ... ok
[INFO] [stdout] test ber::tests::read_children_partial_on_error ... ok
[INFO] [stdout] test ber::tests::constructed_bit_detected ... ok
[INFO] [stdout] test classify::tests::send_auth_info_is_intercept_enabling ... ok
[INFO] [stdout] test ber::tests::truncated_before_length ... ok
[INFO] [stdout] test classify::tests::unknown_diameter_cmd_is_unknown_class ... ok
[INFO] [stdout] test diameter::tests::decodes_air_request ... ok
[INFO] [stdout] test source::tests::pcap_chunk_length_overrun_does_not_overread ... ok
[INFO] [stdout] test source::tests::pcap_empty_but_valid_yields_nothing ... ok
[INFO] [stdout] test source::tests::pcap_rejects_non_pcap ... ok
[INFO] [stdout] test source::tests::pcap_extracts_one_pdu_per_data_chunk ... ok
[INFO] [stdout] test source::tests::hex_dump_empty_is_empty_error ... ok
[INFO] [stdout] test source::tests::hex_dump_tolerates_grouped_hex ... ok
[INFO] [stdout] test source::tests::pcap_skips_non_data_chunk ... ok
[INFO] [stdout] test ber::tests::depth_cap_enforced ... ok
[INFO] [stdout] test diameter::tests::decodes_ulr_with_imsi ... ok
[INFO] [stdout] test diameter::tests::unknown_command_reported ... ok
[INFO] [stdout] test classify::tests::is_flagged_only_for_sensitive ... ok
[INFO] [stdout] test diameter::tests::answer_bit_distinguished ... ok
[INFO] [stdout] test classify::tests::air_is_intercept_enabling ... ok
[INFO] [stdout] test source::tests::hex_dump_one_pdu_per_line ... ok
[INFO] [stdout] test classify::tests::known_benign_map_op ... ok
[INFO] [stdout] test diameter::tests::not_diameter_rejected ... ok
[INFO] [stdout] test source::tests::pcap_tolerates_truncated_final_record ... ok
[INFO] [stdout] test ss7::tests::ber_integer_decodes_signed ... ok
[INFO] [stdout] test diameter::tests::short_message_length_field_rejected ... ok
[INFO] [stdout] test ss7::tests::truncated_tcap_is_error_not_panic ... ok
[INFO] [stdout] test source::tests::hex_dump_bad_hex_rejected ... ok
[INFO] [stdout] test ss7::tests::unknown_opcode_reported_not_dropped ... ok
[INFO] [stdout] test ss7::tests::sccp_with_unparseable_inner_keeps_addressing ... ok
[INFO] [stdout] test ss7::tests::tbcd_decode_with_filler ... ok
[INFO] [stdout] test tests::all_undecodable_is_empty ... ok
[INFO] [stdout] test tests::ati_flagged_location_disclosure ... ok
[INFO] [stdout] test tests::clean_but_benign_is_ok ... ok
[INFO] [stdout] test tests::missing_file_is_invalid_input ... ok
[INFO] [stdout] test tests::empty_arg_invalid ... ok
[INFO] [stdout] test tests::unsupported_verb ... ok
[INFO] [stdout] test source::tests::pcap_rejects_wrong_link_type ... ok
[INFO] [stdout] test ss7::tests::decodes_ati_invoke ... ok
[INFO] [stdout] test ss7::tests::decodes_sri_sm_invoke ... ok
[INFO] [stdout] test ss7::tests::not_ss7_rejected ... ok
[INFO] [stdout] test ss7::tests::sccp_udt_wraps_tcap ... ok
[INFO] [stdout] test ss7::tests::tcap_end_message_type ... ok
[INFO] [stdout] test ber::tests::length_overrun_is_error_not_panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 55 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/analyze.rs (/opt/rustwide/target/debug/build/phonetool-ss7/06496bcbfed0a36d/out/analyze-06496bcbfed0a36d)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test diameter_air_and_ulr_flagged ... ok
[INFO] [stdout] test benign_control_is_ok_zero_flagged ... ok
[INFO] [stdout] test fixture_corpus_flags_every_sensitive_op ... ok
[INFO] [stdout] test pcap_roundtrip_via_tempfile ... ok
[INFO] [stdout] test hostile_inputs_never_panic ... ok
[INFO] [stdout] test missing_pcap_file_is_invalid_input ... ok
[INFO] [stdout] test mixed_capture_counts_correctly ... ok
[INFO] [stdout] test pathological_ber_body_returns_a_result_never_panics ... ok
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/phonetool-subprocess/6a63b29e0f40a8c0/out/phonetool_subprocess-6a63b29e0f40a8c0)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test frame::tests::rejects_oversized_frame_on_read ... ok
[INFO] [stdout] test frame::tests::rejects_oversized_frame_on_write ... ok
[INFO] [stdout] test frame::tests::round_trips_a_frame ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/echo_child.rs (/opt/rustwide/target/debug/build/phonetool-subprocess/649c143d23c3c2f8/out/echo_child-649c143d23c3c2f8)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/tier_b_integration.rs (/opt/rustwide/target/debug/build/phonetool-subprocess/b6ae9c58680a3d43/out/tier_b_integration-b6ae9c58680a3d43)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test manifest_is_served_from_config ... ok
[INFO] [stdout] test nonexistent_program_is_backend_error ... ok
[INFO] [stdout] test child_error_maps_to_plugin_error ... FAILED
[INFO] [stdout] test multiple_dispatches_on_one_child ... FAILED
[INFO] [stdout] test dispatches_a_command_and_receives_an_event ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- child_error_maps_to_plugin_error stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'child_error_maps_to_plugin_error' (2484) panicked at crates/phonetool-subprocess/tests/tier_b_integration.rs:74:5:
[INFO] [stdout] assertion failed: msg.contains("something broke")
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x641114473e41 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x641114473e41 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x641114473e41 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x641114473e41 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x6411144889ca - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stderr] error: test failed, to rerun pass `-p phonetool-subprocess --test tier_b_integration`
[INFO] [stdout]    5:     0x6411144889ca - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x64111447815c - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x64111447815c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x64111444fca6 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x64111444fca6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x64111446c349 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x6411143b57f0 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x6411143b57f0 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x64111446c502 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x64111446c502 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x64111444fd84 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:678:13
[INFO] [stdout]   16:     0x641114448a69 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x64111445095d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x6411144891ec - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x6411144891b2 - core[a373ad73a504971]::panicking::panic
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:150:5
[INFO] [stdout]   20:     0x6411143a5a5d - tier_b_integration[d84c75f8fc8d5907]::child_error_maps_to_plugin_error
[INFO] [stdout]                                at /opt/rustwide/workdir/crates/phonetool-subprocess/tests/tier_b_integration.rs:74:5
[INFO] [stdout]   21:     0x6411143a50b7 - tier_b_integration[d84c75f8fc8d5907]::child_error_maps_to_plugin_error::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/crates/phonetool-subprocess/tests/tier_b_integration.rs:65:38
[INFO] [stdout]   22:     0x6411143a8b86 - <tier_b_integration[d84c75f8fc8d5907]::child_error_maps_to_plugin_error::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x6411143a8c3b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x6411143a8c3b - 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]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   25:     0x6411143b5e15 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   26:     0x6411143b5e15 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   27:     0x6411143b5e15 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   28:     0x6411143b5e15 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   29:     0x6411143b5e15 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   30:     0x6411143b5e15 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   31:     0x6411143b5e15 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   32:     0x6411143af704 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   33:     0x6411143af704 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   34:     0x6411143b8ea2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   35:     0x6411143b8ea2 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   36:     0x6411143b8ea2 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   37:     0x6411143b8ea2 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   38:     0x6411143b8ea2 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   39:     0x6411143b8ea2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   40:     0x6411143b8ea2 - <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]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x64111447366f - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   42:     0x64111447366f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   43:     0x7bf7c3264dfa - <unknown>
[INFO] [stdout]   44:     0x7bf7c32f83d4 - clone
[INFO] [stdout]   45:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- multiple_dispatches_on_one_child stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'multiple_dispatches_on_one_child' (2487) panicked at crates/phonetool-subprocess/tests/tier_b_integration.rs:59:43:
[INFO] [stdout] dispatch succeeds: Backend("cannot spawn child '/opt/rustwide/target/debug/build/phonetool-subprocess/b6ae9c58680a3d43/echo_child': No such file or directory (os error 2)")
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x641114473e41 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x641114473e41 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x641114473e41 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x641114473e41 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x6411144889ca - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x6411144889ca - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x64111447815c - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x64111447815c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x64111444fca6 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x64111444fca6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x64111446c349 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x6411143b57f0 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x6411143b57f0 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x64111446c502 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x64111446c502 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x64111444fd52 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x641114448a69 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x64111445095d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x6411144891ec - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x641114488f42 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1870:5
[INFO] [stdout]   20:     0x6411143a6a7c - <core[a373ad73a504971]::result::Result<phonetool_core[99f63425e0547294]::plugin::Event, phonetool_core[99f63425e0547294]::plugin::PluginError>>::expect
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1184:23
[INFO] [stdout]   21:     0x6411143a5d30 - tier_b_integration[d84c75f8fc8d5907]::multiple_dispatches_on_one_child
[INFO] [stdout]                                at /opt/rustwide/workdir/crates/phonetool-subprocess/tests/tier_b_integration.rs:59:43
[INFO] [stdout]   22:     0x6411143a50e7 - tier_b_integration[d84c75f8fc8d5907]::multiple_dispatches_on_one_child::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/crates/phonetool-subprocess/tests/tier_b_integration.rs:51:38
[INFO] [stdout]   23:     0x6411143a8ba6 - <tier_b_integration[d84c75f8fc8d5907]::multiple_dispatches_on_one_child::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x6411143a8c3b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x6411143a8c3b - 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]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   26:     0x6411143b5e15 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   27:     0x6411143b5e15 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x6411143b5e15 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   29:     0x6411143b5e15 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   30:     0x6411143b5e15 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x6411143b5e15 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   32:     0x6411143b5e15 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   33:     0x6411143af704 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   34:     0x6411143af704 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x6411143b8ea2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x6411143b8ea2 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x6411143b8ea2 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   38:     0x6411143b8ea2 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   39:     0x6411143b8ea2 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x6411143b8ea2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x6411143b8ea2 - <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]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x64111447366f - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   43:     0x64111447366f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   44:     0x7bf7c3264dfa - <unknown>
[INFO] [stdout]   45:     0x7bf7c32f83d4 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- dispatches_a_command_and_receives_an_event stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'dispatches_a_command_and_receives_an_event' (2485) panicked at crates/phonetool-subprocess/tests/tier_b_integration.rs:43:39:
[INFO] [stdout] dispatch succeeds: Backend("cannot spawn child '/opt/rustwide/target/debug/build/phonetool-subprocess/b6ae9c58680a3d43/echo_child': No such file or directory (os error 2)")
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x641114473e41 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x641114473e41 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x641114473e41 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x641114473e41 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x6411144889ca - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x6411144889ca - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x64111447815c - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x64111447815c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x64111444fca6 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x64111444fca6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x64111446c349 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x6411143b57f0 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x6411143b57f0 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x64111446c502 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x64111446c502 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x64111444fd52 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x641114448a69 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x64111445095d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x6411144891ec - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x641114488f42 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1870:5
[INFO] [stdout]   20:     0x6411143a6a7c - <core[a373ad73a504971]::result::Result<phonetool_core[99f63425e0547294]::plugin::Event, phonetool_core[99f63425e0547294]::plugin::PluginError>>::expect
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1184:23
[INFO] [stdout]   21:     0x6411143a64e0 - tier_b_integration[d84c75f8fc8d5907]::dispatches_a_command_and_receives_an_event
[INFO] [stdout]                                at /opt/rustwide/workdir/crates/phonetool-subprocess/tests/tier_b_integration.rs:43:39
[INFO] [stdout]   22:     0x6411143a5147 - tier_b_integration[d84c75f8fc8d5907]::dispatches_a_command_and_receives_an_event::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/crates/phonetool-subprocess/tests/tier_b_integration.rs:37:48
[INFO] [stdout]   23:     0x6411143a8be6 - <tier_b_integration[d84c75f8fc8d5907]::dispatches_a_command_and_receives_an_event::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x6411143a8c3b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x6411143a8c3b - 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]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   26:     0x6411143b5e15 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   27:     0x6411143b5e15 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x6411143b5e15 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   29:     0x6411143b5e15 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   30:     0x6411143b5e15 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x6411143b5e15 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   32:     0x6411143b5e15 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   33:     0x6411143af704 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   34:     0x6411143af704 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x6411143b8ea2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x6411143b8ea2 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x6411143b8ea2 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   38:     0x6411143b8ea2 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   39:     0x6411143b8ea2 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x6411143b8ea2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x6411143b8ea2 - <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]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x64111447366f - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   43:     0x64111447366f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   44:     0x7bf7c3264dfa - <unknown>
[INFO] [stdout]   45:     0x7bf7c32f83d4 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     child_error_maps_to_plugin_error
[INFO] [stdout]     dispatches_a_command_and_receives_an_event
[INFO] [stdout]     multiple_dispatches_on_one_child
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 2 passed; 3 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "74002129db6729eedd68bcb72c81640d97c5c65684cfb1be117fee5b01f9e2fe", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "74002129db6729eedd68bcb72c81640d97c5c65684cfb1be117fee5b01f9e2fe", kill_on_drop: false }`
[INFO] [stdout] 74002129db6729eedd68bcb72c81640d97c5c65684cfb1be117fee5b01f9e2fe
