[INFO] fetching crate wavepeek 0.4.0...
[INFO] testing wavepeek-0.4.0 against beta-2026-04-21 for beta-1.96-2
[INFO] extracting crate wavepeek 0.4.0 into /workspace/builds/worker-1-tc2/source
[INFO] started tweaking crates.io crate wavepeek 0.4.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate wavepeek 0.4.0
[INFO] tweaked toml for crates.io crate wavepeek 0.4.0 written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate wavepeek 0.4.0 on toolchain beta-2026-04-21
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2026-04-21" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate wavepeek 0.4.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2026-04-21" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-04-21" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 5b20237ce35d0f0ba76dcca27b9023b1986b47c66e67a6c05c5e7a6678ea2503
[INFO] running `Command { std: "docker" "start" "-a" "5b20237ce35d0f0ba76dcca27b9023b1986b47c66e67a6c05c5e7a6678ea2503", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5b20237ce35d0f0ba76dcca27b9023b1986b47c66e67a6c05c5e7a6678ea2503", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5b20237ce35d0f0ba76dcca27b9023b1986b47c66e67a6c05c5e7a6678ea2503", kill_on_drop: false }`
[INFO] [stdout] 5b20237ce35d0f0ba76dcca27b9023b1986b47c66e67a6c05c5e7a6678ea2503
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-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" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-04-21" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] fa0877b2467e788399537284e189302d4b5674ecae83744f2d3a96ccf3fec5c0
[INFO] running `Command { std: "docker" "start" "-a" "fa0877b2467e788399537284e189302d4b5674ecae83744f2d3a96ccf3fec5c0", kill_on_drop: false }`
[INFO] [stderr]    Compiling twox-hash v2.1.2
[INFO] [stderr]    Compiling toml_edit v0.23.10+spec-1.0.0
[INFO] [stderr]    Compiling zmij v1.0.19
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling miniz_oxide v0.8.9
[INFO] [stderr]    Compiling memmap2 v0.9.9
[INFO] [stderr]    Compiling miniz_oxide v0.9.0
[INFO] [stderr]    Compiling leb128 v0.2.5
[INFO] [stderr]    Compiling rustc-hash v2.1.1
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling clap_derive v4.5.55
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling lz4_flex v0.12.0
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling proc-macro-crate v3.4.0
[INFO] [stderr]    Compiling num_enum_derive v0.7.5
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling clap v4.5.57
[INFO] [stderr]    Compiling num_enum v0.7.5
[INFO] [stderr]    Compiling fst-reader v0.14.3
[INFO] [stderr]    Compiling wellen v0.20.2
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling wavepeek v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 20.43s
[INFO] running `Command { std: "docker" "inspect" "fa0877b2467e788399537284e189302d4b5674ecae83744f2d3a96ccf3fec5c0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fa0877b2467e788399537284e189302d4b5674ecae83744f2d3a96ccf3fec5c0", kill_on_drop: false }`
[INFO] [stdout] fa0877b2467e788399537284e189302d4b5674ecae83744f2d3a96ccf3fec5c0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-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" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-04-21" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 65814f4f1b5ee13ce8eff3371796c67e06ec75de9483362b8fd879dc2baa571b
[INFO] running `Command { std: "docker" "start" "-a" "65814f4f1b5ee13ce8eff3371796c67e06ec75de9483362b8fd879dc2baa571b", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling zerocopy-derive v0.8.42
[INFO] [stderr]    Compiling cc v1.2.56
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling predicates-core v1.0.9
[INFO] [stderr]    Compiling rayon v1.11.0
[INFO] [stderr]    Compiling plotters-backend v0.3.7
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling csv-core v0.1.13
[INFO] [stderr]    Compiling termtree v0.5.1
[INFO] [stderr]    Compiling assert_cmd v2.1.2
[INFO] [stderr]    Compiling difflib v0.4.0
[INFO] [stderr]    Compiling normalize-line-endings v0.3.0
[INFO] [stderr]    Compiling criterion-plot v0.8.2
[INFO] [stderr]    Compiling console v0.15.11
[INFO] [stderr]    Compiling predicates-tree v1.0.12
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling plotters-svg v0.3.7
[INFO] [stderr]    Compiling page_size v0.6.0
[INFO] [stderr]    Compiling similar v2.7.0
[INFO] [stderr]    Compiling float-cmp v0.10.0
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling alloca v0.4.0
[INFO] [stderr]    Compiling zerocopy v0.8.42
[INFO] [stderr]    Compiling wellen v0.20.2
[INFO] [stderr]    Compiling tempfile v3.24.0
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling bstr v1.12.1
[INFO] [stderr]    Compiling predicates v3.1.3
[INFO] [stderr]    Compiling insta v1.46.3
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling csv v1.4.0
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling wavepeek v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling criterion v0.8.2
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 52.07s
[INFO] running `Command { std: "docker" "inspect" "65814f4f1b5ee13ce8eff3371796c67e06ec75de9483362b8fd879dc2baa571b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "65814f4f1b5ee13ce8eff3371796c67e06ec75de9483362b8fd879dc2baa571b", kill_on_drop: false }`
[INFO] [stdout] 65814f4f1b5ee13ce8eff3371796c67e06ec75de9483362b8fd879dc2baa571b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-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" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-04-21" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 0d4c2fb407a5989c54982d386fd63a1d3ff07693c520bdb4646a1ce9348fb2e1
[INFO] running `Command { std: "docker" "start" "-a" "0d4c2fb407a5989c54982d386fd63a1d3ff07693c520bdb4646a1ce9348fb2e1", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.24s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/wavepeek-80d3554555a02747)
[INFO] [stdout] 
[INFO] [stdout] running 95 tests
[INFO] [stdout] test cli::limits::tests::limit_arg_parses_unlimited_literal ... ok
[INFO] [stdout] test cli::limits::tests::limit_arg_rejects_invalid_literals ... ok
[INFO] [stdout] test cli::tests::clap_error_detail_preserves_missing_argument_names ... ok
[INFO] [stdout] test cli::tests::help_hint_uses_global_help_for_top_level_parse_failures ... ok
[INFO] [stdout] test cli::tests::help_hint_uses_subcommand_help_for_subcommand_parse_failures ... ok
[INFO] [stdout] test cli::tests::info_dispatch_keeps_json_and_waves_args ... ok
[INFO] [stdout] test engine::change::tests::auto_engine_mode_keeps_baseline_for_low_signal_count_edge_only_terms ... ok
[INFO] [stdout] test engine::change::tests::auto_engine_mode_uses_fused_for_mid_any_tracked_only ... ok
[INFO] [stdout] test cli::tests::change_dispatch_keeps_on_abs_and_limits ... ok
[INFO] [stdout] test engine::change::tests::auto_engine_mode_keeps_baseline_for_low_work_any_tracked_only ... ok
[INFO] [stdout] test engine::change::tests::auto_engine_mode_keeps_baseline_for_narrow_selective_edge_events ... ok
[INFO] [stdout] test engine::change::tests::auto_engine_mode_uses_fused_for_mid_edge_only_terms ... ok
[INFO] [stdout] test cli::tests::scope_dispatch_accepts_unlimited_limit_literals ... ok
[INFO] [stdout] test cli::tests::clap_errors_are_normalized_to_single_line_message ... ok
[INFO] [stdout] test cli::tests::signal_dispatch_keeps_recursive_and_max_depth_args ... ok
[INFO] [stdout] test cli::limits::tests::limit_arg_parses_numeric_values ... ok
[INFO] [stdout] test engine::expr_runtime::tests::bound_handle_helpers_preserve_unique_signal_order ... ok
[INFO] [stdout] test engine::change::tests::auto_engine_mode_uses_edge_fast_for_ultra_wide_selective_edge_events ... ok
[INFO] [stdout] test engine::change::tests::auto_engine_mode_uses_fused_at_threshold_for_any_tracked ... ok
[INFO] [stdout] test engine::change::tests::auto_engine_mode_uses_fused_for_wide_any_tracked_only ... ok
[INFO] [stdout] test engine::change::tests::auto_engine_mode_keeps_baseline_below_fused_threshold ... ok
[INFO] [stdout] test engine::expr_runtime::tests::scoped_host_rejects_dotted_names_when_scope_is_active ... ok
[INFO] [stdout] test cli::tests::scope_dispatch_keeps_bounded_query_args ... ok
[INFO] [stdout] test engine::time::tests::dump_tick_must_be_non_zero ... ok
[INFO] [stdout] test engine::time::tests::raw_timestamp_formatting_uses_dump_time_unit ... ok
[INFO] [stdout] test engine::time::tests::parse_dump_time_context_extracts_dump_bounds_and_tick ... ok
[INFO] [stdout] test engine::time::tests::validate_time_token_to_raw_rejects_raw_range_overflow ... ok
[INFO] [stdout] test engine::time::tests::validate_time_token_to_raw_rejects_too_large_bounds_and_misalignment ... ok
[INFO] [stdout] test cli::tests::value_dispatch_keeps_scope_signals_abs_and_json_args ... ok
[INFO] [stdout] test engine::time::tests::zeptoseconds_conversion_supports_cross_unit_comparison ... ok
[INFO] [stdout] test engine::change::tests::auto_engine_mode_uses_fused_for_wide_selective_edge_events ... ok
[INFO] [stdout] test engine::value_format::tests::nibble_conversion_prefers_binary_then_z_then_x ... ok
[INFO] [stdout] test engine::value_format::tests::verilog_literal_formatter_emits_lowercase_hex_and_unknowns ... ok
[INFO] [stdout] test engine::time::tests::validate_time_token_to_raw_rejects_requires_units_and_invalid_tokens ... ok
[INFO] [stdout] test error::tests::scope_and_signal_errors_use_exit_code_one ... ok
[INFO] [stdout] test error::tests::file_errors_use_exit_code_two ... ok
[INFO] [stdout] test expr::lexer::tests::lex_event_expr_tracks_keywords_and_spans ... ok
[INFO] [stdout] test expr::lexer::tests::lex_logical_expr_accepts_real_and_string_literals ... ok
[INFO] [stdout] test expr::eval::tests::wildcard_equality_preserves_unknown_from_lhs ... ok
[INFO] [stdout] test expr::lexer::tests::lex_logical_expr_keeps_triggered_signal_base_for_selection ... ok
[INFO] [stdout] test expr::lexer::tests::lex_logical_expr_keeps_triggered_suffix_inside_identifier_without_call ... ok
[INFO] [stdout] test expr::lexer::tests::lex_logical_expr_accepts_integral_boolean_operators ... ok
[INFO] [stdout] test expr::lexer::tests::lex_logical_expr_splits_triggered_call_suffix ... ok
[INFO] [stdout] test expr::lexer::tests::lex_logical_expr_splits_triggered_call_before_arguments ... ok
[INFO] [stdout] test engine::time::tests::parse_time_token_requires_integer_and_unit ... ok
[INFO] [stdout] test expr::parser::tests::logical_parser_accepts_triggered_call_with_optional_space_before_parens ... ok
[INFO] [stdout] test expr::parser::tests::typed_parser_rejects_broken_union_segmentation ... ok
[INFO] [stdout] test expr::parser::tests::logical_parser_keeps_unary_minus_separate_from_integral_literals ... ok
[INFO] [stdout] test expr::parser::tests::typed_parser_preserves_iff_binding_to_single_term ... ok
[INFO] [stdout] test expr::parser::tests::logical_parser_keeps_triggered_suffix_signal_names_as_operand_refs ... ok
[INFO] [stdout] test expr::parser::tests::typed_parser_rejects_unmatched_open_parenthesis ... ok
[INFO] [stdout] test expr::sema::tests::binder_preserves_enum_identity_in_conditional_arms ... ok
[INFO] [stdout] test expr::parser::tests::logical_parser_rejects_triggered_call_arguments_and_missing_close_paren ... ok
[INFO] [stdout] test expr::sema::tests::binder_rejects_unsized_concat_literal ... ok
[INFO] [stdout] test expr::sema::tests::binder_rejects_non_constant_replication_multiplier ... ok
[INFO] [stdout] test expr::parser::tests::logical_parser_accepts_integral_boolean_surface_sample ... ok
[INFO] [stdout] test expr::parser::tests::logical_parser_accepts_rich_type_surface_sample ... ok
[INFO] [stdout] test output::tests::change_human_render_is_single_line_per_snapshot ... ok
[INFO] [stdout] test expr::eval::tests::logical_and_short_circuits_rhs ... ok
[INFO] [stdout] test waveform::tests::duplicate_projection_deduplicates_paths_and_tracks_requested_order ... ok
[INFO] [stdout] test output::tests::json_envelope_has_required_shape_for_info ... ok
[INFO] [stdout] test output::tests::json_envelope_preserves_warnings_for_scope ... ok
[INFO] [stdout] test output::tests::property_rows_render_as_time_and_kind_lines ... ok
[INFO] [stdout] test output::tests::value_human_render_is_deterministic_and_compact ... ok
[INFO] [stdout] test waveform::tests::delta_filter_mixed_prior_state_emits_on_comparable_change ... ok
[INFO] [stdout] test output::tests::scope_tree_render_matches_linux_tree_style ... ok
[INFO] [stdout] test waveform::tests::edge_classification_ninestate_maps_to_x ... ok
[INFO] [stdout] test waveform::tests::edge_detection_uses_lsb_only ... ok
[INFO] [stdout] test waveform::tests::fst_uses_multi_thread_loader_in_shared_path ... ok
[INFO] [stdout] test cli::tests::property_dispatch_parses_capture_default ... ok
[INFO] [stdout] test waveform::tests::parse_failures_map_to_file_error ... ok
[INFO] [stdout] test error::tests::expr_errors_use_exit_code_one ... ok
[INFO] [stdout] test waveform::tests::edge_classification_sv2023_matrix ... ok
[INFO] [stdout] test waveform::tests::open_missing_file_maps_to_file_error ... ok
[INFO] [stdout] test waveform::tests::decode_signal_at_index_requires_loaded_signal_data ... ok
[INFO] [stdout] test waveform::tests::decode_signal_at_index_returns_none_when_no_prior_value_exists ... ok
[INFO] [stdout] test waveform::tests::missing_scope_returns_scope_category_error ... ok
[INFO] [stdout] test waveform::tests::delta_filter_initializes_without_prior_state ... ok
[INFO] [stdout] test waveform::tests::recursive_signals_in_scope_none_depth_includes_all_nested_levels ... ok
[INFO] [stdout] test waveform::tests::sample_signals_at_time_returns_signal_error_for_missing_path ... ok
[INFO] [stdout] test waveform::tests::sample_signals_at_time_preserves_order_and_duplicates ... ok
[INFO] [stdout] test waveform::tests::open_and_read_metadata_from_vcd ... ok
[INFO] [stdout] test waveform::expr_host::tests::waveform_expr_host_reports_missing_enum_metadata_on_vcd ... ok
[INFO] [stdout] test waveform::tests::signal_offset_at_index_compares_data_position_only ... ok
[INFO] [stdout] test waveform::tests::signal_offset_at_index_returns_none_when_signal_is_not_loaded ... ok
[INFO] [stdout] test waveform::tests::decode_signal_at_index_matches_sample_resolved_optional ... ok
[INFO] [stdout] test waveform::tests::recursive_signals_in_scope_are_deterministic_depth_first ... ok
[INFO] [stdout] test waveform::tests::sample_signals_at_time_stays_non_bit_vector_for_rich_values ... ok
[INFO] [stdout] test waveform::tests::sample_signals_at_time_uses_latest_change_before_timestamp ... ok
[INFO] [stdout] test waveform::expr_host::tests::waveform_expr_host_distinguishes_triggered_signal_suffix_from_raw_event_call ... ok
[INFO] [stdout] test waveform::tests::recursive_signals_in_scope_respect_depth_boundaries ... ok
[INFO] [stdout] test waveform::tests::scopes_depth_first_none_includes_all_nested_depths ... ok
[INFO] [stdout] test waveform::tests::signals_in_scope_are_sorted_and_preserve_parser_var_type_aliases ... ok
[INFO] [stdout] test waveform::tests::scopes_use_deterministic_depth_first_lexicographic_order_with_kind ... ok
[INFO] [stdout] test waveform::expr_host::tests::waveform_expr_host_supports_recovered_bit_vector_cast_on_vcd_and_fst ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 95 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/wavepeek-7925a5267672422b)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stderr]      Running tests/change_cli.rs (/opt/rustwide/target/debug/deps/change_cli-793e3370af315a4c)
[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] [stdout] 
[INFO] [stdout] running 45 tests
[INFO] [stdout] test change_explicit_tune_candidates_auto_still_requires_debug_mode ... ok
[INFO] [stdout] test change_explicit_tune_auto_still_requires_debug_mode ... ok
[INFO] [stdout] test change_decimal_time_token_is_rejected_as_args_error ... ok
[INFO] [stdout] test change_from_timestamp_is_baseline_only_for_emission ... ok
[INFO] [stdout] test change_empty_on_expression_reports_expr_error ... ok
[INFO] [stdout] test change_empty_iff_reports_expr_error ... ok
[INFO] [stdout] test change_equal_from_and_to_never_emits_baseline_row ... ok
[INFO] [stdout] test change_omitted_from_uses_dump_start_baseline_checkpoint ... ok
[INFO] [stdout] test change_misaligned_time_includes_help_hint ... ok
[INFO] [stdout] test change_named_non_edge_trigger_emits_expected_single_row ... ok
[INFO] [stdout] test change_default_when_matches_expected_json_payload ... ok
[INFO] [stdout] test change_edge_wiring_is_end_to_end ... ok
[INFO] [stdout] test change_broken_union_reports_expr_error ... ok
[INFO] [stdout] test change_invalid_on_reports_expr_error ... ok
[INFO] [stdout] test change_empty_result_warning_matches_between_json_and_human_modes ... ok
[INFO] [stdout] test change_rejects_zero_max_with_args_error ... ok
[INFO] [stdout] test change_accepts_inclusive_dump_time_bounds ... ok
[INFO] [stdout] test change_default_max_is_50_with_truncation_warning ... ok
[INFO] [stdout] test change_negedge_wiring_is_end_to_end ... ok
[INFO] [stdout] test change_requires_signals_flag ... ok
[INFO] [stdout] test change_preserves_duplicate_signal_order ... ok
[INFO] [stdout] test change_tune_candidate_override_requires_debug_mode ... ok
[INFO] [stdout] test change_omitted_when_matches_explicit_wildcard ... ok
[INFO] [stdout] test change_invalid_when_signal_fails_even_without_in_range_timestamps ... ok
[INFO] [stdout] test change_tune_overrides_require_debug_mode ... ok
[INFO] [stdout] test change_rejects_legacy_pre_fusion_engine_label ... ok
[INFO] [stdout] test change_tune_edge_fast_force_requires_debug_mode ... ok
[INFO] [stdout] test change_triggered_iff_payload_executes ... ok
[INFO] [stdout] test change_truncation_warning_matches_between_json_and_human_modes ... ok
[INFO] [stdout] test change_tune_overrides_succeed_with_debug_mode ... ok
[INFO] [stdout] test change_union_overlap_timestamp_is_deduplicated ... ok
[INFO] [stdout] test change_iff_executes_end_to_end ... ok
[INFO] [stdout] test change_out_of_range_from_time_is_args_error_with_bounds ... ok
[INFO] [stdout] test change_zero_delta_path_returns_empty_data_with_warning ... ok
[INFO] [stdout] test change_unmatched_close_parenthesis_reports_expr_error ... ok
[INFO] [stdout] test change_unlimited_warning_precedes_empty_result_warning_in_json_and_human_modes ... ok
[INFO] [stdout] test change_abs_only_affects_human_labels_not_json_payload ... ok
[INFO] [stdout] test change_rich_type_iff_payload_executes ... ok
[INFO] [stdout] test change_runtime_manifest_cases_pass ... ok
[INFO] [stdout] test change_rejects_legacy_internal_and_perf_change_flags ... ok
[INFO] [stdout] test change_scoped_mode_rejects_canonical_tokens_even_if_prefixed_path_exists ... ok
[INFO] [stdout] test change_union_or_and_comma_forms_are_exact_synonyms ... ok
[INFO] [stdout] test change_zero_delta_warning_matches_between_json_and_human_modes ... ok
[INFO] [stdout] test change_unlimited_max_disables_truncation_and_emits_warning_in_both_modes ... ok
[INFO] [stdout] test change_validates_error_paths_for_args_scope_and_signal_resolution ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 45 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.40s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/change_opt_equivalence.rs (/opt/rustwide/target/debug/deps/change_opt_equivalence-4643041d5e31ca59)
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test change_max_one_truncation_matches_between_modes ... ok
[INFO] [stdout] test change_redundant_same_value_dump_does_not_emit_row ... ok
[INFO] [stdout] test change_all_candidates_at_or_before_baseline_do_not_emit ... ok
[INFO] [stdout] test change_forced_edge_fast_falls_back_for_non_edge_triggers ... ok
[INFO] [stdout] test change_dense_edge_max_one_truncation_matches_all_modes ... ok
[INFO] [stdout] test change_empty_window_from_equals_to_remains_empty ... ok
[INFO] [stdout] test change_dense_posedge_sparse_delta_matches_all_modes ... ok
[INFO] [stdout] test change_from_inside_window_respects_intermediate_non_candidate_updates ... ok
[INFO] [stdout] test change_uses_strict_previous_timestamp_not_previous_candidate ... ok
[INFO] [stdout] test change_typed_iff_matches_between_modes ... ok
[INFO] [stdout] test change_auto_sparse_edge_profile_matches_baseline_output ... ok
[INFO] [stdout] test change_edge_without_requested_delta_remains_empty_in_all_modes ... ok
[INFO] [stdout] test change_anychange_trigger_detects_none_to_some_transition ... ok
[INFO] [stdout] test change_auto_sparse_any_tracked_profile_matches_baseline_output ... ok
[INFO] [stdout] test change_auto_dense_any_tracked_profile_matches_fused_output ... ok
[INFO] [stdout] test change_union_edge_trigger_dedups_same_timestamp_in_all_modes ... ok
[INFO] [stdout] test change_trigger_matrix_matches_between_baseline_and_fused ... ok
[INFO] [stdout] test change_auto_dense_edge_profile_matches_edge_fast_output ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.89s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/change_vcd_fst_parity.rs (/opt/rustwide/target/debug/deps/change_vcd_fst_parity-fcedcff654eeae6b)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test change_fst_fused_stream_candidate_path_matches_fused_random_access_path ... ok
[INFO] [stdout] test change_vcd_and_fst_payloads_match_for_default_trigger ... ok
[INFO] [stdout] test change_vcd_and_fst_payloads_match_for_typed_iff_trigger ... ok
[INFO] [stdout] test change_fst_stream_candidate_path_matches_random_access_path ... ok
[INFO] [stdout] test change_vcd_and_fst_payloads_match_for_named_and_edge_triggers ... ok
[INFO] [stderr]      Running tests/cli_contract.rs (/opt/rustwide/target/debug/deps/cli_contract-5b541275412cf47a)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.17s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 33 tests
[INFO] [stdout] test command_name_parser_ignores_wrapped_description_lines ... ok
[INFO] [stdout] test change_help_documents_on_trigger_and_does_not_expose_clk ... ok
[INFO] [stdout] test positional_arguments_are_rejected ... ok
[INFO] [stdout] test no_args_prints_top_level_help_and_exits_zero ... ok
[INFO] [stdout] test help_lists_schema_after_waveform_commands ... ok
[INFO] [stdout] test change_rejects_legacy_when_flag_without_alias ... ok
[INFO] [stdout] test schema_does_not_accept_waves_flag ... ok
[INFO] [stdout] test help_lists_expected_subcommands ... ok
[INFO] [stdout] test short_help_flag_matches_long_help_behavior ... ok
[INFO] [stdout] test schema_does_not_accept_json_flag ... ok
[INFO] [stdout] test no_args_help_matches_long_help_output ... ok
[INFO] [stdout] test top_level_help_documents_general_conventions ... ok
[INFO] [stdout] test top_level_help_describes_shipped_subcommands_without_unimplemented_markers ... ok
[INFO] [stdout] test shipped_commands_list_matches_top_level_help_surface ... ok
[INFO] [stdout] test subcommand_help_uses_extended_prd_descriptions ... ok
[INFO] [stdout] test unknown_flags_are_normalized_to_args_category ... ok
[INFO] [stdout] test top_level_short_and_long_help_are_identical ... ok
[INFO] [stdout] test signal_help_documents_recursive_and_max_depth_flags ... ok
[INFO] [stdout] test help_documents_unlimited_limit_literals_for_all_affected_commands ... ok
[INFO] [stdout] test version_flags_print_version_to_stdout ... ok
[INFO] [stdout] test unknown_top_level_flag_uses_global_help_hint ... ok
[INFO] [stdout] test waveform_commands_require_waves_flag ... ok
[INFO] [stdout] test property_accepts_capture_flag_in_cli_then_runs ... ok
[INFO] [stdout] test legacy_subcommands_are_rejected_without_alias ... ok
[INFO] [stdout] test unimplemented_subcommands_disclose_status_in_help ... ok
[INFO] [stdout] test shipped_commands_help_is_self_descriptive ... ok
[INFO] [stdout] test schema_rejects_positional_arguments ... ok
[INFO] [stdout] test waveform_help_avoids_literal_error_or_warning_message_bodies ... ok
[INFO] [stdout] test short_and_long_help_are_identical_for_shipped_commands ... ok
[INFO] [stdout] test value_rejects_legacy_time_flag_without_alias ... ok
[INFO] [stdout] test waveform_help_uses_schema_reference_without_inline_envelope_or_parse_hints ... ok
[INFO] [stdout] test subcommand_short_help_includes_long_help_contract_markers ... ok
[INFO] [stdout] test all_commands_reject_human_flag ... ok
[INFO] [stderr]      Running tests/command_fixture_contract.rs (/opt/rustwide/target/debug/deps/command_fixture_contract-08448e19f61a607f)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 33 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.26s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test command_runtime_manifests_and_snapshots_follow_shared_contract ... ok
[INFO] [stdout] test command_runtime_positive_manifest_cases_pass ... ok
[INFO] [stdout] test command_runtime_negative_manifest_cases_pass ... ok
[INFO] [stderr]      Running tests/expression_event_runtime.rs (/opt/rustwide/target/debug/deps/expression_event_runtime-c51e0eafcf0707b8)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.12s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test wildcard_tracked_set_binding_comes_from_host_context ... ok
[INFO] [stdout] test event_runtime_short_circuit_holds ... ok
[INFO] [stdout] test event_runtime_positive_manifest_matches ... ok
[INFO] [stdout] test event_runtime_negative_manifest_matches_snapshots ... ok
[INFO] [stdout] test event_runtime_shadow_parity_matches_change_cli_for_non_iff_surface ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.70s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stderr]      Running tests/expression_fixture_contract.rs (/opt/rustwide/target/debug/deps/expression_fixture_contract-202dc49571d17fed)
[INFO] [stdout] test shared_positive_manifest_contract_accepts_tagged_cases_and_rejects_legacy_shapes ... ok
[INFO] [stdout] test negative_manifest_snapshots_exist_and_no_expression_snapshots_are_orphaned ... ok
[INFO] [stdout] test shared_negative_manifest_contract_enforces_host_context_and_runtime_timestamp ... ok
[INFO] [stdout] test all_expression_manifests_deserialize_through_the_shared_contract ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/expression_integral_boolean.rs (/opt/rustwide/target/debug/deps/expression_integral_boolean-353f23175fe96666)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test integral_boolean_short_circuit_preservation_holds ... ok
[INFO] [stdout] test integral_boolean_negative_manifest_matches_snapshots ... ok
[INFO] [stdout] test integral_boolean_positive_manifest_matches ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/expression_parse.rs (/opt/rustwide/target/debug/deps/expression_parse-b66b859b54f88c07)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test parse_positive_manifest_parses ... ok
[INFO] [stdout] test parse_no_panic_corpus_holds ... ok
[INFO] [stdout] test parse_negative_manifest_matches_snapshots ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/expression_rich_types.rs (/opt/rustwide/target/debug/deps/expression_rich_types-41255478b8e3e1f8)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test rich_types_positive_manifest_matches ... ok
[INFO] [stdout] test rich_types_negative_manifest_matches_snapshots ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/info_cli.rs (/opt/rustwide/target/debug/deps/info_cli-7c7e60fce2302b1a)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test info_invalid_file_is_parse_error_with_exit_code_two ... ok
[INFO] [stdout] test info_missing_file_is_file_error_with_exit_code_two ... ok
[INFO] [stdout] test info_json_contract_for_fst_fixture ... ok
[INFO] [stdout] test info_human_output_is_default_for_vcd_fixture ... ok
[INFO] [stdout] test info_json_contract_for_vcd_fixture ... ok
[INFO] [stdout] test info_json_output_is_deterministic_across_runs ... ok
[INFO] [stderr] error: test failed, to rerun pass `--test info_cli`
[INFO] [stdout] test info_json_contract_for_external_picorv32_fixture ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- info_json_contract_for_external_picorv32_fixture stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'info_json_contract_for_external_picorv32_fixture' (2418) panicked at tests/info_cli.rs:97:5:
[INFO] [stdout] required external fixture is missing: /opt/rtl-artifacts/picorv32_test_vcd.fst
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x61b930f2d93a - std[128c3efe2914e152]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x61b930f2d93a - std[128c3efe2914e152]::backtrace_rs::backtrace::trace_unsynchronized::<std[128c3efe2914e152]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x61b930f2d93a - std[128c3efe2914e152]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x61b930f2d93a - <<std[128c3efe2914e152]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[6771d259883166e6]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x61b930f4348a - <core[6771d259883166e6]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x61b930f4348a - core[6771d259883166e6]::fmt::write
[INFO] [stdout]    6:     0x61b930f33502 - std[128c3efe2914e152]::io::default_write_fmt::<alloc[fef50e8eecedd288]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x61b930f33502 - <alloc[fef50e8eecedd288]::vec::Vec<u8> as std[128c3efe2914e152]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x61b930f0c55f - <std[128c3efe2914e152]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x61b930f0c55f - std[128c3efe2914e152]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x61b930f25c29 - std[128c3efe2914e152]::panicking::default_hook
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x61b930e6110c - <alloc[fef50e8eecedd288]::boxed::Box<dyn for<'a, 'b> core[6771d259883166e6]::ops::function::Fn<(&'a std[128c3efe2914e152]::panic::PanicHookInfo<'b>,), Output = ()> + core[6771d259883166e6]::marker::Sync + core[6771d259883166e6]::marker::Send> as core[6771d259883166e6]::ops::function::Fn<(&std[128c3efe2914e152]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/alloc/src/boxed.rs:2263:9
[INFO] [stdout]   12:     0x61b930e6110c - test[b137923399915ecf]::test_main_with_exit_callback::<test[b137923399915ecf]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x61b930f25de2 - <alloc[fef50e8eecedd288]::boxed::Box<dyn for<'a, 'b> core[6771d259883166e6]::ops::function::Fn<(&'a std[128c3efe2914e152]::panic::PanicHookInfo<'b>,), Output = ()> + core[6771d259883166e6]::marker::Sync + core[6771d259883166e6]::marker::Send> as core[6771d259883166e6]::ops::function::Fn<(&std[128c3efe2914e152]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/alloc/src/boxed.rs:2263:9
[INFO] [stdout]   14:     0x61b930f25de2 - std[128c3efe2914e152]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x61b930f0c618 - std[128c3efe2914e152]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x61b930f01779 - std[128c3efe2914e152]::sys::backtrace::__rust_end_short_backtrace::<std[128c3efe2914e152]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x61b930f0d32d - __rustc[752cc74e29381ccc]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x61b930f43c5c - core[6771d259883166e6]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x61b930e53c03 - info_cli::info_json_contract_for_external_picorv32_fixture::h40942c18cdc15ca6
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/info_cli.rs:97:5
[INFO] [stdout]   20:     0x61b930e54367 - info_cli::info_json_contract_for_external_picorv32_fixture::{{closure}}::h55fc0b9e1bc7ca72
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/info_cli.rs:95:54
[INFO] [stdout]   21:     0x61b930e4fa66 - core::ops::function::FnOnce::call_once::h1c6cb8c1f09b377c
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   22:     0x61b930e5520b - <fn() -> core[6771d259883166e6]::result::Result<(), alloc[fef50e8eecedd288]::string::String> as core[6771d259883166e6]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x61b930e5520b - test[b137923399915ecf]::__rust_begin_short_backtrace::<core[6771d259883166e6]::result::Result<(), alloc[fef50e8eecedd288]::string::String>, fn() -> core[6771d259883166e6]::result::Result<(), alloc[fef50e8eecedd288]::string::String>>
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/test/src/lib.rs:663:18
[INFO] [stdout]   24:     0x61b930e61bdb - test[b137923399915ecf]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/test/src/lib.rs:686:74
[INFO] [stdout]   25:     0x61b930e61bdb - <core[6771d259883166e6]::panic::unwind_safe::AssertUnwindSafe<test[b137923399915ecf]::run_test_in_process::{closure#0}> as core[6771d259883166e6]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   26:     0x61b930e61bdb - std[128c3efe2914e152]::panicking::catch_unwind::do_call::<core[6771d259883166e6]::panic::unwind_safe::AssertUnwindSafe<test[b137923399915ecf]::run_test_in_process::{closure#0}>, core[6771d259883166e6]::result::Result<(), alloc[fef50e8eecedd288]::string::String>>
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/panicking.rs:581:40
[INFO] [stdout]   27:     0x61b930e61bdb - std[128c3efe2914e152]::panicking::catch_unwind::<core[6771d259883166e6]::result::Result<(), alloc[fef50e8eecedd288]::string::String>, core[6771d259883166e6]::panic::unwind_safe::AssertUnwindSafe<test[b137923399915ecf]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/panicking.rs:544:19
[INFO] [stdout]   28:     0x61b930e61bdb - std[128c3efe2914e152]::panic::catch_unwind::<core[6771d259883166e6]::panic::unwind_safe::AssertUnwindSafe<test[b137923399915ecf]::run_test_in_process::{closure#0}>, core[6771d259883166e6]::result::Result<(), alloc[fef50e8eecedd288]::string::String>>
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/panic.rs:359:14
[INFO] [stdout]   29:     0x61b930e61bdb - test[b137923399915ecf]::run_test_in_process
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/test/src/lib.rs:686:27
[INFO] [stdout]   30:     0x61b930e61bdb - test[b137923399915ecf]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/test/src/lib.rs:607:43
[INFO] [stdout]   31:     0x61b930e5c034 - test[b137923399915ecf]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/test/src/lib.rs:637:41
[INFO] [stdout]   32:     0x61b930e5c034 - std[128c3efe2914e152]::sys::backtrace::__rust_begin_short_backtrace::<test[b137923399915ecf]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   33:     0x61b930e647e2 - std[128c3efe2914e152]::thread::lifecycle::spawn_unchecked::<test[b137923399915ecf]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   34:     0x61b930e647e2 - <core[6771d259883166e6]::panic::unwind_safe::AssertUnwindSafe<std[128c3efe2914e152]::thread::lifecycle::spawn_unchecked<test[b137923399915ecf]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[6771d259883166e6]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   35:     0x61b930e647e2 - std[128c3efe2914e152]::panicking::catch_unwind::do_call::<core[6771d259883166e6]::panic::unwind_safe::AssertUnwindSafe<std[128c3efe2914e152]::thread::lifecycle::spawn_unchecked<test[b137923399915ecf]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/panicking.rs:581:40
[INFO] [stdout]   36:     0x61b930e647e2 - std[128c3efe2914e152]::panicking::catch_unwind::<(), core[6771d259883166e6]::panic::unwind_safe::AssertUnwindSafe<std[128c3efe2914e152]::thread::lifecycle::spawn_unchecked<test[b137923399915ecf]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/panicking.rs:544:19
[INFO] [stdout]   37:     0x61b930e647e2 - std[128c3efe2914e152]::panic::catch_unwind::<core[6771d259883166e6]::panic::unwind_safe::AssertUnwindSafe<std[128c3efe2914e152]::thread::lifecycle::spawn_unchecked<test[b137923399915ecf]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/panic.rs:359:14
[INFO] [stdout]   38:     0x61b930e647e2 - std[128c3efe2914e152]::thread::lifecycle::spawn_unchecked::<test[b137923399915ecf]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   39:     0x61b930e647e2 - <std[128c3efe2914e152]::thread::lifecycle::spawn_unchecked<test[b137923399915ecf]::run_test::{closure#1}, ()>::{closure#1} as core[6771d259883166e6]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x61b930f2d1cf - <alloc[fef50e8eecedd288]::boxed::Box<dyn core[6771d259883166e6]::ops::function::FnOnce<(), Output = ()> + core[6771d259883166e6]::marker::Send> as core[6771d259883166e6]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/alloc/src/boxed.rs:2249:9
[INFO] [stdout]   41:     0x61b930f2d1cf - <std[128c3efe2914e152]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/8489f1adbe1c8f8921cf18b9962cf565237a5489/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   42:     0x79c88c00baa4 - <unknown>
[INFO] [stdout]   43:     0x79c88c098a64 - clone
[INFO] [stdout]   44:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     info_json_contract_for_external_picorv32_fixture
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 6 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.37s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "0d4c2fb407a5989c54982d386fd63a1d3ff07693c520bdb4646a1ce9348fb2e1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0d4c2fb407a5989c54982d386fd63a1d3ff07693c520bdb4646a1ce9348fb2e1", kill_on_drop: false }`
[INFO] [stdout] 0d4c2fb407a5989c54982d386fd63a1d3ff07693c520bdb4646a1ce9348fb2e1
