[INFO] fetching crate rtce 0.6.0...
[INFO] testing rtce-0.6.0 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate rtce 0.6.0 into /workspace/builds/worker-6-tc2/source
[INFO] started tweaking crates.io crate rtce 0.6.0
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate rtce 0.6.0
[INFO] tweaked toml for crates.io crate rtce 0.6.0 written to /workspace/builds/worker-6-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate rtce 0.6.0 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate rtce 0.6.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" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-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:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 27f88458bd9778ce58884e0c80fd870b2a8a451822fb131114f63a196f45aa46
[INFO] running `Command { std: "docker" "start" "27f88458bd9778ce58884e0c80fd870b2a8a451822fb131114f63a196f45aa46", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "27f88458bd9778ce58884e0c80fd870b2a8a451822fb131114f63a196f45aa46", 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" "27f88458bd9778ce58884e0c80fd870b2a8a451822fb131114f63a196f45aa46" "/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" "27f88458bd9778ce58884e0c80fd870b2a8a451822fb131114f63a196f45aa46", 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" "27f88458bd9778ce58884e0c80fd870b2a8a451822fb131114f63a196f45aa46" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling memchr v2.8.3
[INFO] [stderr]    Compiling syn v3.0.2
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling rtce v0.6.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 7.20s
[INFO] running `Command { std: "docker" "inspect" "27f88458bd9778ce58884e0c80fd870b2a8a451822fb131114f63a196f45aa46", 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" "27f88458bd9778ce58884e0c80fd870b2a8a451822fb131114f63a196f45aa46" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling rtce-testkit v0.1.0
[INFO] [stderr]    Compiling rtce v0.6.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 8.74s
[INFO] running `Command { std: "docker" "inspect" "27f88458bd9778ce58884e0c80fd870b2a8a451822fb131114f63a196f45aa46", 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" "27f88458bd9778ce58884e0c80fd870b2a8a451822fb131114f63a196f45aa46" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/rtce/0fae8cd242207336/out/rtce-0fae8cd242207336)
[INFO] [stdout] 
[INFO] [stdout] running 262 tests
[INFO] [stdout] test config_keys::tests::a_key_far_from_everything_lists_the_known_fields_instead ... ok
[INFO] [stdout] test expr::compiler::tests::chained_comparison_is_a_positioned_error ... ok
[INFO] [stdout] test config_keys::tests::a_duplicate_known_field_is_still_a_serde_error_on_both_mechanisms ... ok
[INFO] [stdout] test expr::compiler::tests::depth_guard_boundary_is_exactly_max_stack ... ok
[INFO] [stdout] test expr::compiler::tests::depth_guard_boundary_63_ok_64_errors ... ok
[INFO] [stdout] test expr::compiler::tests::functions_and_unary_evaluate ... ok
[INFO] [stdout] test expr::compiler::tests::sqrt_and_pow_have_correct_postfix_depth_and_fractional_evaluation ... ok
[INFO] [stdout] test config_keys::tests::underscore_keys_pass_and_everything_else_fails ... ok
[INFO] [stdout] test config_keys::tests::the_first_offending_key_in_sorted_order_is_reported ... ok
[INFO] [stdout] test expr::compiler::tests::division_by_zero_is_infinite_not_a_panic ... ok
[INFO] [stdout] test expr::lexer::tests::comparison_tokens_lex_two_char_before_one_char ... ok
[INFO] [stdout] test build::tests::buildstate_parses_with_tags ... ok
[INFO] [stdout] test expr::compiler::tests::clamp_never_panics_on_inverted_or_nan_bounds ... ok
[INFO] [stdout] test build::tests::player_facing_gear_annotations_do_not_change_the_build ... ok
[INFO] [stdout] test expr::lexer::tests::arithmetic_identifiers_and_calls_tokenize ... ok
[INFO] [stdout] test expr::parser::tests::calls_parse_with_arity_checked ... ok
[INFO] [stdout] test expr::compiler::tests::hand_worked_d4_base_hit_shape ... ok
[INFO] [stdout] test expr::compiler::tests::sqrt_and_pow_invalid_domains_follow_ieee_semantics ... ok
[INFO] [stdout] test expr::compiler::tests::unknown_identifier_is_a_positioned_compile_error ... ok
[INFO] [stdout] test expr::lexer::tests::bad_characters_error_with_position ... ok
[INFO] [stdout] test expr::compiler::tests::depth_guard_rejects_pathological_nesting ... ok
[INFO] [stdout] test expr::compiler::tests::empty_source_is_a_positioned_error_at_zero ... ok
[INFO] [stdout] test plan::tests::branched_stage_with_zero_events_evaluates ... ok
[INFO] [stdout] test expr::lexer::tests::bare_bang_or_equals_errors_cleanly ... ok
[INFO] [stdout] test plan::tests::chance_clamps_and_zero_uptime_is_fail_closed ... ok
[INFO] [stdout] test plan::tests::condition_names_join_the_flat_namespace ... ok
[INFO] [stdout] test plan::tests::evaluate_phase_sampled_at_chance_one_equals_crit_branch_exactly ... ok
[INFO] [stdout] test gamedef::tests::specialized_stage_shapes_and_nested_keys_fail_closed ... ok
[INFO] [stdout] test expr::lexer::tests::positions_are_true_byte_offsets_even_after_multibyte_chars ... ok
[INFO] [stdout] test expr::parser::tests::precedence_and_unary ... ok
[INFO] [stdout] test expr::parser::tests::syntax_errors_carry_position ... ok
[INFO] [stdout] test gamedef::tests::gamedef_parses_from_json ... ok
[INFO] [stdout] test gamedef::tests::solve_stage_parses_and_round_trips_without_tagging_expression_stages ... ok
[INFO] [stdout] test plan::tests::event_factors_name_is_reserved ... ok
[INFO] [stdout] test plan::tests::declared_event_multiplier_shadows_the_new_readable_alias ... ok
[INFO] [stdout] test plan::tests::negative_individual_phase_weight_is_rejected ... ok
[INFO] [stdout] test plan::tests::event_multiplier_is_a_gamer_readable_alias_for_event_factors ... ok
[INFO] [stdout] test plan::tests::non_finite_contribution_value_is_rejected_not_folded ... ok
[INFO] [stdout] test plan::tests::explain_matches_evaluate_and_traces_the_hand_worked_numbers ... ok
[INFO] [stdout] test plan::tests::non_finite_build_stat_is_rejected ... ok
[INFO] [stdout] test plan::tests::evaluate_phase_sampled_at_chance_zero_equals_base_branch_exactly ... ok
[INFO] [stdout] test plan::tests::explain_scalar_only_pipeline_has_no_branches ... ok
[INFO] [stdout] test plan::tests::non_finite_inputs_are_rejected_on_the_single_phase_path_too ... ok
[INFO] [stdout] test plan::tests::event_factors_is_illegal_outside_branched_stages ... ok
[INFO] [stdout] test plan::tests::explain_with_zero_events_has_a_single_all_unfired_branch_entry ... ok
[INFO] [stdout] test plan::tests::later_stages_see_earlier_ones_but_not_vice_versa ... ok
[INFO] [stdout] test plan::tests::non_finite_phase_stat_override_is_rejected ... ok
[INFO] [stdout] test plan::tests::product_bucket_negative_contribution_flips_sign ... ok
[INFO] [stdout] test plan::tests::too_many_events_rejected ... ok
[INFO] [stdout] test plan::tests::unknown_refs_in_build_and_scenario_are_eval_errors ... ok
[INFO] [stdout] test rng::tests::different_seeds_diverge ... ok
[INFO] [stdout] test plan::tests::toy_game_hand_worked_single_phase ... ok
[INFO] [stdout] test plan::tests::uptime_clamps_at_both_edges ... ok
[INFO] [stdout] test plan::tests::toy_gamedef_compiles ... ok
[INFO] [stdout] test plan::tests::non_finite_uptime_is_rejected ... ok
[INFO] [stdout] test plan::tests::phase_blending_weights_normalize ... ok
[INFO] [stdout] test scenario::tests::a_typoed_key_on_a_phase_is_rejected_with_a_did_you_mean ... ok
[INFO] [stdout] test search::tests::baseline_is_never_mutated ... ok
[INFO] [stdout] test plan::tests::conditions_are_readable_in_expressions ... ok
[INFO] [stdout] test rng::tests::mix_seed_is_deterministic_and_index_sensitive ... ok
[INFO] [stdout] test plan::tests::three_event_enumeration_hand_worked ... ok
[INFO] [stdout] test search::tests::price_matches_fresh_evaluation ... ok
[INFO] [stdout] test search::tests::top_k_and_pareto_hand_worked ... ok
[INFO] [stdout] test sim::compile::tests::a_cast_action_effect_on_an_action_is_rejected_with_the_recursion_rationale ... ok
[INFO] [stdout] test rng::tests::same_seed_is_deterministic ... ok
[INFO] [stdout] test plan::tests::unknown_names_and_duplicates_are_compile_errors ... ok
[INFO] [stdout] test scenario::tests::scenario_parses ... ok
[INFO] [stdout] test sim::compile::tests::a_non_finite_buff_contribution_value_is_a_compile_error ... ok
[INFO] [stdout] test sim::compile::tests::a_typoed_key_on_action_damage_is_rejected_with_its_action_named ... ok
[INFO] [stdout] test sim::compile::tests::a_proc_with_no_effects_after_desugar_must_do_something ... ok
[INFO] [stdout] test plan::tests::unknown_uptime_keys_are_rejected ... ok
[INFO] [stdout] test scenario::tests::underscore_annotations_on_scenario_and_phase_parse ... ok
[INFO] [stdout] test sim::compile::tests::action_apply_buff_referencing_an_unknown_buff_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::a_typoed_key_on_a_buff_is_rejected_with_a_did_you_mean ... ok
[INFO] [stdout] test sim::compile::tests::action_name_colliding_with_a_condition_is_rejected ... ok
[INFO] [stdout] test search::tests::moves_round_trip_serde ... ok
[INFO] [stdout] test sim::compile::tests::action_scoping_resolves_to_indices_in_source_order ... ok
[INFO] [stdout] test sim::compile::tests::happy_path_compiles_and_resolves_indices ... ok
[INFO] [stdout] test sim::compile::tests::action_sugar_plus_an_explicit_effects_list_is_an_ambiguous_order_error ... ok
[INFO] [stdout] test sim::compile::tests::buff_name_colliding_with_a_stat_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::damage_objective_not_a_plan_objective_is_rejected ... ok
[INFO] [stdout] test search::tests::bad_moves_fail_closed ... ok
[INFO] [stdout] test config_keys::tests::edit_distance_hand_worked ... ok
[INFO] [stdout] test expr::compiler::tests::comparisons_and_boolean_functions ... ok
[INFO] [stdout] test expr::compiler::tests::compiles_to_postfix_and_evaluates ... ok
[INFO] [stdout] test sim::compile::tests::a_typoed_key_on_a_proc_is_rejected_with_a_did_you_mean ... ok
[INFO] [stdout] test sim::compile::tests::a_typoed_key_on_a_rotation_rule_is_rejected_with_a_did_you_mean ... ok
[INFO] [stdout] test rng::tests::output_is_in_range ... ok
[INFO] [stdout] test sim::compile::tests::resource_name_colliding_with_a_stat_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::proc_referencing_unknown_action_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::proc_actions_filter_referencing_an_unknown_action_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::rule_when_referencing_a_pipeline_stage_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::proc_with_an_empty_actions_filter_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::proc_sugar_plus_an_explicit_effects_list_is_an_ambiguous_order_error ... ok
[INFO] [stdout] test sim::compile::tests::stacking_policies_accept_a_cap_and_unbounded ... ok
[INFO] [stdout] test sim::compile::tests::tick_objective_not_a_plan_objective_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::strongest_with_a_snapshot_tick_objective_compiles ... ok
[INFO] [stdout] test sim::compile::tests::stacks_symbol_resolves_for_a_known_buff_only ... ok
[INFO] [stdout] test sim::compile::tests::strongest_without_a_snapshot_tick_objective_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::underscore_annotations_on_simdef_structs_compile_and_survive_round_trips ... ok
[INFO] [stdout] test sim::compile::tests::strongest_with_a_max_stacks_other_than_one_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::unknown_names_inside_an_effects_list_are_rejected ... ok
[INFO] [stdout] test sim::compile::tests::unknown_resource_in_cost_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::proc_referencing_unknown_buff_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::reserved_time_as_a_resource_name_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::unknown_action_in_rotation_rule_is_rejected ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::a_cast_the_filter_excludes_banks_no_ev_accumulator_mass ... ok
[INFO] [stdout] test sim::compile::tests::rule_with_no_when_is_always_eligible_and_compiles ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::a_non_finite_or_negative_proc_icd_is_a_compile_error ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::a_proc_action_filter_counts_only_the_listed_actions_casts ... ok
[INFO] [stdout] test sim::compile::tests::reserved_duration_as_an_action_name_is_rejected ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::a_proc_free_cast_applies_that_actions_own_apply_buff_under_its_own_overlay ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::a_procs_chance_sees_the_buff_the_same_cast_applied ... ok
[INFO] [stdout] test sim::compile::tests::sugar_and_explicit_effects_compile_to_identical_effect_lists ... ok
[INFO] [stdout] test sim::compile::tests::proc_with_both_apply_buff_and_cast_action_is_rejected ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::a_buff_driven_condition_uptime_is_clamped_like_the_value_that_folds ... ok
[INFO] [stdout] test sim::compile::tests::refresh_with_a_max_stacks_other_than_one_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::proc_with_neither_apply_buff_nor_cast_action_is_rejected ... ok
[INFO] [stdout] test sim::compile::tests::unknown_resource_in_gain_is_rejected ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::a_proc_action_filter_consumes_no_monte_carlo_draw_for_a_cast_it_excludes ... ok
[INFO] [stdout] test plan::tests::evaluate_phase_sampled_ten_thousand_samples_converge_to_evaluate_ev ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::a_same_list_snapshot_capture_reads_one_frozen_world ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::a_proc_action_filter_applies_to_every_trigger_not_just_on_cast ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::an_action_applied_buff_does_not_amplify_the_cast_that_applied_it ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::apply_buff_alone_drives_a_hand_worked_uptime_with_no_proc_defined ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::apply_buff_applies_the_list_in_order_and_a_repeat_applies_twice ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::an_action_applied_snapshot_captures_the_overlay_and_a_proc_applied_one_does_not ... ok
[INFO] [stdout] test sim::exec::tests::effects_list::a_repeated_apply_buff_entry_applies_twice ... ok
[INFO] [stdout] test sim::exec::tests::effects_list::mc_mode_executes_the_whole_effects_list_in_order ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::every_expression_valued_field_rejects_a_pipeline_stage ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::a_snapshot_capture_is_frozen_across_the_list_on_both_action_paths ... ok
[INFO] [stdout] test sim::exec::tests::effects_list::two_distinct_apply_buff_entries_both_apply ... ok
[INFO] [stdout] test sim::exec::tests::event_order::a_wake_coinciding_with_a_completion_is_ordering_invisible_by_construction ... ok
[INFO] [stdout] test sim::exec::tests::effects_list::proc_effects_execute_in_list_order_and_a_later_entry_sees_an_earlier_cast ... ok
[INFO] [stdout] test sim::exec::tests::event_order::a_zero_weight_final_phase_cast_flips_to_the_old_phase_under_completions_first ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::buff_duration_expr_naming_duration_reads_the_fight_length ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::two_buffs_driving_one_condition_resolve_by_buff_name_order ... ok
[INFO] [stdout] test sim::exec::tests::action_scoped::on_hit_rolls_once_per_cast_not_once_per_hit ... ok
[INFO] [stdout] test sim::exec::tests::event_order::within_the_rest_class_seq_still_decides_under_completions_first ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::expr_duration_reads_the_live_state_on_both_application_paths ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::expr_damage_stats_are_evaluated_at_cast_complete ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::expr_duration_reads_the_stat_at_application ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::expr_cost_behaves_exactly_as_the_literal ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::expr_cost_referencing_an_unknown_symbol_is_a_compile_error ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::expr_cooldown_behaves_exactly_as_the_literal ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::expr_duration_referencing_a_pipeline_stage_is_a_compile_error ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::negative_expr_damage_stat_is_allowed ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::expr_gain_behaves_exactly_as_the_literal ... ok
[INFO] [stdout] test sim::exec::tests::event_order::completions_first_lets_a_cast_measure_the_buff_it_refreshes_on_the_grid ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::expr_duration_snapshots_at_application_across_a_phase_boundary ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::negative_expr_gain_fails_closed_at_cast_complete ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::non_finite_expr_damage_stat_fails_closed_at_cast_complete ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::negative_expr_cost_fails_closed_at_the_decision_instant ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::negative_expr_duration_fails_closed_at_application ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::resource_max_expr_refolds_against_the_applying_buff ... ok
[INFO] [stdout] test sim::exec::tests::event_order::mc_same_seed_twice_is_byte_identical_under_completions_first ... ok
[INFO] [stdout] test sim::exec::tests::horizon::cast_completing_at_the_horizon_counts_even_when_a_buff_expires_there ... ok
[INFO] [stdout] test sim::exec::tests::measurement::a_snapshot_tick_capture_reads_the_cast_start_world_under_cast_start ... ok
[INFO] [stdout] test sim::exec::tests::measurement::a_free_cast_measures_live_ambient_not_the_outer_casts_snapshot ... ok
[INFO] [stdout] test sim::exec::tests::measurement::a_per_action_measure_override_coexists_with_the_default ... ok
[INFO] [stdout] test sim::exec::tests::measurement::a_per_action_override_wins_over_a_non_default_defaults_block ... ok
[INFO] [stdout] test sim::exec::tests::live_dot::a_mid_window_refold_moves_a_live_rate_and_not_a_snapshot_one_under_refresh ... ok
[INFO] [stdout] test sim::exec::tests::horizon::a_zero_weight_final_phase_takes_the_horizon_cast_by_the_seq_rule ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::p6c_starvation_pin_reproduces_from_numeric_json ... ok
[INFO] [stdout] test sim::exec::tests::live_dot::refresh_with_a_live_tick_accrues_the_blended_rate_over_both_windows ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::p6_numeric_simdef_json_parses_and_compiles_to_constants ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::non_finite_expr_duration_fails_closed_at_application ... ok
[INFO] [stdout] test sim::exec::tests::measurement::an_instant_cast_is_measured_at_the_completion_position_even_under_cast_start ... ok
[INFO] [stdout] test sim::exec::tests::live_dot::a_live_tick_under_monte_carlo_is_deterministic_and_equals_ev_exactly ... ok
[INFO] [stdout] test sim::exec::tests::measurement::the_ev_on_crit_weight_is_part_of_the_cast_start_measurement ... ok
[INFO] [stdout] test sim::exec::tests::measurement::the_cast_start_capture_is_taken_after_the_cost_is_paid ... ok
[INFO] [stdout] test sim::exec::tests::measurement::casts_self_excludes_the_in_flight_cast_under_cast_start ... ok
[INFO] [stdout] test sim::exec::tests::measurement::hits_per_use_is_measured_at_the_same_instant_as_the_overlay ... ok
[INFO] [stdout] test sim::exec::tests::measurement::measured_value_errors_name_the_cast_start_instant_under_cast_start ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::chance_is_evaluated_once_per_cast_not_once_per_hit ... ok
[INFO] [stdout] test sim::exec::tests::expr_fields::negative_expr_cooldown_fails_closed_at_cast_start ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::a_mid_cast_fire_arms_the_icd_against_the_casts_remaining_hits ... ok
[INFO] [stdout] test sim::exec::tests::measurement::the_measured_instant_moves_a_time_reading_overlay_stat ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::on_cast_rolls_per_cast_and_utility_casts_present_no_hit_roll_under_per_hit ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::zero_measured_hits_present_no_roll_under_per_hit_but_one_under_per_cast ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::ev_per_hit_feeds_the_accumulator_once_per_measured_hit ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::the_per_proc_override_wins_over_the_defaults_block_in_both_directions ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::mc_per_hit_draws_share_the_casts_one_sampled_crit_mask ... ok
[INFO] [stdout] test sim::exec::tests::procs::ev_on_crit_weight_is_measured_before_this_casts_own_procs ... ok
[INFO] [stdout] test sim::exec::tests::procs::ev_on_crit_weights_by_crit_probability ... ok
[INFO] [stdout] test sim::exec::tests::procs::ev_accumulator_fractional_chance_fires_at_hand_worked_hit_indices ... ok
[INFO] [stdout] test sim::exec::tests::procs::ev_accumulator_icd_gate_discards_hits_during_icd_is_hand_worked ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::mc_gated_hits_consume_no_draw_the_streams_collapse_at_chance_one ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::mc_per_hit_draws_once_per_measured_hit ... ok
[INFO] [stdout] test sim::exec::tests::run_entry_validation::a_finite_utility_only_rotation_still_completes ... ok
[INFO] [stdout] test sim::exec::tests::run_entry_validation::a_non_finite_contribution_value_is_rejected_at_run_entry_too ... ok
[INFO] [stdout] test sim::exec::tests::procs::proc_effect_cast_action_fires_a_free_instant_cast ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::a_fractional_hits_per_use_fails_closed_under_per_hit_only ... ok
[INFO] [stdout] test sim::exec::tests::measurement::the_damage_querys_phase_half_reads_the_snapshot_under_cast_start ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::a_hits_count_above_the_per_hit_roll_limit_fails_closed ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::ev_on_crit_weight_applies_per_hit ... ok
[INFO] [stdout] test sim::exec::tests::run_entry_validation::a_non_finite_build_stat_is_rejected_at_run_entry_with_zero_evaluations ... ok
[INFO] [stdout] test sim::exec::tests::snapshot::add_refresh_all_moves_the_expiry_but_never_the_snapshot_rate ... ok
[INFO] [stdout] test sim::exec::tests::snapshot::add_independent_refolds_the_summed_rate_when_it_evicts_at_the_cap ... ok
[INFO] [stdout] test sim::exec::tests::snapshot::a_snapshot_instance_ignores_a_later_rate_change_and_the_live_one_does_not ... ok
[INFO] [stdout] test sim::exec::tests::run_entry_validation::a_non_finite_phase_stat_override_is_rejected_at_run_entry_too ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::any_positive_icd_caps_per_hit_at_one_fire_per_cast ... ok
[INFO] [stdout] test sim::exec::tests::snapshot::a_snapshot_rate_is_captured_before_its_own_application_folds_in ... ok
[INFO] [stdout] test sim::exec::tests::snapshot::add_refresh_all_at_the_cap_discards_the_rate_and_keeps_the_old_snapshot ... ok
[INFO] [stdout] test sim::exec::tests::procs::a_procs_effect_is_visible_to_a_later_proc_in_the_same_batch ... ok
[INFO] [stdout] test sim::exec::tests::snapshot::eval_objective_reads_the_snapshot_world_when_given_one_and_the_live_one_when_not ... ok
[INFO] [stdout] test sim::exec::tests::snapshot::refresh_recaptures_the_snapshot_rate_on_every_reapplication ... ok
[INFO] [stdout] test sim::exec::tests::stacks::a_binary_buffs_avg_stacks_equals_its_uptime ... ok
[INFO] [stdout] test sim::exec::tests::stacks::add_refresh_all_expires_every_instance_together ... ok
[INFO] [stdout] test sim::exec::tests::stacks::a_stacked_dot_ticks_at_rate_times_stack_count ... ok
[INFO] [stdout] test sim::exec::tests::stacks::a_stacking_buffs_condition_is_not_scaled_by_the_stack_count ... ok
[INFO] [stdout] test sim::exec::tests::snapshot::strongest_replaces_only_on_a_strictly_higher_rate_and_a_loser_keeps_nothing ... ok
[INFO] [stdout] test sim::exec::tests::stacks::add_independent_evicts_the_earliest_expiring_at_the_cap ... ok
[INFO] [stdout] test sim::exec::tests::stacks::stacks_symbol_gates_a_rotation_rule_until_the_third_instance ... ok
[INFO] [stdout] test sim::exec::tests::snapshot::a_snapshot_dot_accrues_74_instance_seconds_of_its_captured_rate ... ok
[INFO] [stdout] test sim::exec::tests::stacks::stack_trajectory_agrees_between_ev_and_monte_carlo ... ok
[INFO] [stdout] test sim::exec::tests::stacks::avg_stacks_integrates_the_span_still_open_when_the_sim_ends ... ok
[INFO] [stdout] test sim::exec::tests::stacks::buff_flag_is_binary_and_buff_remaining_is_the_longest_window ... ok
[INFO] [stdout] test sim::exec::tests::timeline::phase_boundary_blends_two_phases ... ok
[INFO] [stdout] test sim::exec::tests::timeline::resource_starvation_cadence_is_hand_worked ... ok
[INFO] [stdout] test sim::exec::tests::timeline::computed_buff_uptime_is_hand_worked ... ok
[INFO] [stdout] test sim::exec::tests::timeline::keystone_matches_level_1_exactly ... ok
[INFO] [stdout] test sim::report::tests::distribution_reports_the_sample_count_and_observed_range ... ok
[INFO] [stdout] test sim::exec::tests::timeline::condition_precedence_buff_wins_while_active ... ok
[INFO] [stdout] test sim::exec::tests::timeline::waiting_is_modeled_and_terminates ... ok
[INFO] [stdout] test simdef::tests::a_defaults_block_holding_only_annotations_survives_round_trips ... ok
[INFO] [stdout] test simdef::tests::a_malformed_proc_rolls_value_names_the_two_variants ... ok
[INFO] [stdout] test simdef::tests::a_malformed_num_or_expr_names_what_was_expected ... ok
[INFO] [stdout] test sim::exec::tests::stacks::add_refresh_all_stacks_to_the_cap_on_one_shared_clock ... ok
[INFO] [stdout] test simdef::tests::a_typoed_key_inside_an_effect_entry_is_rejected_with_a_did_you_mean ... ok
[INFO] [stdout] test simdef::tests::an_omitted_defaults_block_means_cast_complete_and_never_reappears ... ok
[INFO] [stdout] test simdef::tests::an_effect_entry_takes_exactly_one_effect_key ... ok
[INFO] [stdout] test sim::exec::tests::procs::monte_carlo_same_seed_twice_is_byte_identical ... ok
[INFO] [stdout] test simdef::tests::action_scoping_fields_parse_and_round_trip ... ok
[INFO] [stdout] test simdef::tests::action_def_serde_defaults_and_derived_default_agree_field_for_field ... ok
[INFO] [stdout] test simdef::tests::a_malformed_event_order_value_names_the_two_variants ... ok
[INFO] [stdout] test simdef::tests::a_malformed_measure_value_names_the_two_variants ... ok
[INFO] [stdout] test simdef::tests::an_underscore_key_inside_the_tick_objective_object_is_accepted ... ok
[INFO] [stdout] test simdef::tests::effects_lists_parse_and_round_trip_the_spec_json ... ok
[INFO] [stdout] test simdef::tests::omitted_action_scoping_fields_default_to_the_020_behavior ... ok
[INFO] [stdout] test simdef::tests::omitted_stack_fields_default_to_one_instance_and_refresh ... ok
[INFO] [stdout] test simdef::tests::expression_valued_fields_deserialize_and_round_trip ... ok
[INFO] [stdout] test simdef::tests::event_order_parses_and_naming_it_leaves_measure_at_its_default ... ok
[INFO] [stdout] test simdef::tests::proc_rolls_and_the_per_proc_override_parse_and_round_trip ... ok
[INFO] [stdout] test simdef::tests::rotation_round_trips_the_spec_example_verbatim ... ok
[INFO] [stdout] test simdef::tests::serde_defaults_and_impl_default_agree_field_for_field ... ok
[INFO] [stdout] test simdef::tests::the_defaults_block_and_per_action_measure_parse_and_round_trip ... ok
[INFO] [stdout] test simdef::tests::tick_objective_parses_both_the_bare_name_and_the_object_form ... ok
[INFO] [stdout] test simdef::tests::omitted_cooldown_defaults_to_zero ... ok
[INFO] [stdout] test simdef::tests::an_unknown_key_inside_the_tick_objective_object_is_rejected ... ok
[INFO] [stdout] test simdef::tests::an_underscore_key_inside_an_effect_entry_is_accepted ... ok
[INFO] [stdout] test simdef::tests::simdef_round_trips_the_spec_example_verbatim ... ok
[INFO] [stdout] test simdef::tests::stack_fields_parse_and_round_trip_in_snake_case ... ok
[INFO] [stdout] test sim::exec::tests::timeline::instant_cast_livelock_fails_closed ... ok
[INFO] [stdout] test sim::exec::tests::procs::monte_carlo_proc_count_is_near_ev_accumulator_count ... ok
[INFO] [stdout] test sim::exec::tests::horizon::too_many_zero_weight_phases_at_the_horizon_fails_closed ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::ev_and_mc_agree_under_per_hit_on_crit_regression ... ok
[INFO] [stdout] test sim::exec::tests::stacks::steady_state_stack_count_converges_between_ev_and_monte_carlo ... ok
[INFO] [stdout] test sim::exec::tests::proc_rolls::ev_procs_match_mc_in_the_per_hit_icd_bound_regime_regression ... ok
[INFO] [stdout] test sim::exec::tests::snapshot::snapshot_dot_totals_agree_between_ev_and_monte_carlo ... ok
[INFO] [stdout] test sim::exec::tests::procs::monte_carlo_converges_to_ev_on_crit_only_case ... ok
[INFO] [stdout] test sim::exec::tests::procs::ev_procs_match_mc_in_icd_bound_regime_regression ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 262 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.48s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/applied_dot.rs (/opt/rustwide/target/debug/build/rtce/525a557bf1c67efc/out/applied_dot-525a557bf1c67efc)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test resistance_penetration_and_taken_categories_each_apply_once ... ok
[INFO] [stderr]      Running tests/bounded_recurrence.rs (/opt/rustwide/target/debug/build/rtce/bb53af69f5082204/out/bounded_recurrence-bb53af69f5082204)
[INFO] [stdout] test physical_and_chaos_source_damage_contribute_but_other_damage_does_not ... ok
[INFO] [stdout] test target_damage_taken_is_owned_once_by_the_effective_multiplier ... ok
[INFO] [stdout] test duration_and_magnitude_modifiers_change_their_own_outputs ... ok
[INFO] [stdout] test chance_duration_rate_and_additive_stack_cap_are_independent_inputs ... ok
[INFO] [stdout] test neutral_one_stack_poison_exposes_the_full_breakdown ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test pinned_pob_delayed_loss_oracle_is_entirely_config_driven ... ok
[INFO] [stdout] test all_state_updates_read_the_same_previous_state ... ok
[INFO] [stdout] test linear_pool_terminates_with_fractional_final_step_accounting ... ok
[INFO] [stdout] test recurrence_schema_round_trips_and_rejects_typoed_keys_or_branched_mode ... ok
[INFO] [stdout] test non_terminating_recurrence_exhausts_its_budget ... ok
[INFO] [stdout] test recurrence_identifiers_dependencies_and_bounds_fail_at_compile_time ... ok
[INFO] [stderr]      Running tests/bounded_solve.rs (/opt/rustwide/target/debug/build/rtce/fa9a07eeddd696b1/out/bounded_solve-fa9a07eeddd696b1)
[INFO] [stdout] test recurrence_runtime_errors_name_stage_state_and_iteration ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test exhausted_iteration_budget_is_a_defined_error ... ok
[INFO] [stdout] test two_component_rational_solve_reads_stats_bucket_and_prior_stage ... ok
[INFO] [stdout] test solver_configuration_and_dependencies_fail_at_compile_time ... ok
[INFO] [stdout] test inverted_unbracketed_and_non_finite_evaluations_are_errors ... ok
[INFO] [stdout] test solve_stage_finds_sqrt_two_as_a_repeatable_conservative_lower_bound ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/d4_gamedef.rs (/opt/rustwide/target/debug/build/rtce/ed2554de9bf7cd00/out/d4_gamedef-ed2554de9bf7cd00)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test t9_dot_is_crit_immune ... ok
[INFO] [stdout] test t_cases_reproduce_diablo4_calc_numbers ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/expression_math.rs (/opt/rustwide/target/debug/build/rtce/e2533c47c524ab94/out/expression_math-e2533c47c524ab94)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test arity_and_domain_behavior_are_public_contracts ... ok
[INFO] [stdout] test non_finite_math_is_returned_by_plan_but_rejected_for_sim_quantities ... ok
[INFO] [stdout] test sqrt_pow_and_the_strongest_roll_formula_evaluate_through_plan ... ok
[INFO] [stdout] test sqrt_and_pow_compile_in_sim_expression_fields_too ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/golden.rs (/opt/rustwide/target/debug/build/rtce/08a4d84cc5e9c74d/out/golden-08a4d84cc5e9c74d)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test golden_fixtures_reproduce_pinned_values ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/guide.rs (/opt/rustwide/target/debug/build/rtce/fc5cee4fe9e42522/out/guide-fc5cee4fe9e42522)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test every_config_is_used_by_an_example ... ok
[INFO] [stdout] test no_example_includes_from_outside_the_crate ... ok
[INFO] [stderr] error: test failed, to rerun pass `--test guide`
[INFO] [stdout] test every_titled_block_matches_its_config_file ... FAILED
[INFO] [stdout] test every_json_block_is_titled ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- every_titled_block_matches_its_config_file stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'every_titled_block_matches_its_config_file' (1326) panicked at tests/guide.rs:45:10:
[INFO] [stdout] docs/guide exists: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x624af35098d1 - 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:     0x624af35098d1 - 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:     0x624af35098d1 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x624af35098d1 - <<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:     0x624af351dbba - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x624af351dbba - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x624af350ddbc - 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:     0x624af350ddbc - <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:     0x624af34e5086 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x624af34e5086 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x624af35019f9 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x624af349d310 - <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:     0x624af349d310 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x624af3501bb2 - <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:     0x624af3501bb2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x624af34e5132 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x624af34ddc19 - 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:     0x624af34e5d3d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x624af351e2ec - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x624af351e0c2 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1870:5
[INFO] [stdout]   20:     0x624af348ef58 - <core[a373ad73a504971]::result::Result<std[617be2ca0a6fd877]::fs::ReadDir, core[a373ad73a504971]::io::error::Error>>::expect
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1184:23
[INFO] [stdout]   21:     0x624af3484900 - guide[5ebc5a1bd505bfa0]::chapters
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/guide.rs:45:10
[INFO] [stdout]   22:     0x624af3485990 - guide[5ebc5a1bd505bfa0]::every_titled_block_matches_its_config_file
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/guide.rs:101:20
[INFO] [stdout]   23:     0x624af3483de7 - guide[5ebc5a1bd505bfa0]::every_titled_block_matches_its_config_file::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/guide.rs:98:48
[INFO] [stdout]   24:     0x624af3487fd6 - <guide[5ebc5a1bd505bfa0]::every_titled_block_matches_its_config_file::{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]   25:     0x624af349075b - <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]   26:     0x624af349075b - 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]   27:     0x624af349d935 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   28:     0x624af349d935 - <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]   29:     0x624af349d935 - 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]   30:     0x624af349d935 - 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]   31:     0x624af349d935 - 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]   32:     0x624af349d935 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   33:     0x624af349d935 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   34:     0x624af3497224 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   35:     0x624af3497224 - 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]   36:     0x624af34a09c2 - 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]   37:     0x624af34a09c2 - <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]   38:     0x624af34a09c2 - 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]   39:     0x624af34a09c2 - 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]   40:     0x624af34a09c2 - 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]   41:     0x624af34a09c2 - 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]   42:     0x624af34a09c2 - <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]   43:     0x624af3508dcf - <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]   44:     0x624af3508dcf - <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]   45:     0x70eb9bfa3dfa - <unknown>
[INFO] [stdout]   46:     0x70eb9c0373d4 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- every_json_block_is_titled stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'every_json_block_is_titled' (1325) panicked at tests/guide.rs:45:10:
[INFO] [stdout] docs/guide exists: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x624af35098d1 - 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:     0x624af35098d1 - 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:     0x624af35098d1 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x624af35098d1 - <<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:     0x624af351dbba - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x624af351dbba - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x624af350ddbc - 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:     0x624af350ddbc - <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:     0x624af34e5086 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x624af34e5086 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x624af35019f9 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x624af349d310 - <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:     0x624af349d310 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x624af3501bb2 - <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:     0x624af3501bb2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x624af34e5132 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x624af34ddc19 - 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:     0x624af34e5d3d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x624af351e2ec - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x624af351e0c2 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1870:5
[INFO] [stdout]   20:     0x624af348ef58 - <core[a373ad73a504971]::result::Result<std[617be2ca0a6fd877]::fs::ReadDir, core[a373ad73a504971]::io::error::Error>>::expect
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1184:23
[INFO] [stdout]   21:     0x624af3484900 - guide[5ebc5a1bd505bfa0]::chapters
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/guide.rs:45:10
[INFO] [stdout]   22:     0x624af3484a24 - guide[5ebc5a1bd505bfa0]::every_json_block_is_titled
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/guide.rs:142:20
[INFO] [stdout]   23:     0x624af3483d87 - guide[5ebc5a1bd505bfa0]::every_json_block_is_titled::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/guide.rs:141:32
[INFO] [stdout]   24:     0x624af3487f96 - <guide[5ebc5a1bd505bfa0]::every_json_block_is_titled::{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]   25:     0x624af349075b - <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]   26:     0x624af349075b - 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]   27:     0x624af349d935 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   28:     0x624af349d935 - <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]   29:     0x624af349d935 - 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]   30:     0x624af349d935 - 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]   31:     0x624af349d935 - 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]   32:     0x624af349d935 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   33:     0x624af349d935 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   34:     0x624af3497224 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   35:     0x624af3497224 - 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]   36:     0x624af34a09c2 - 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]   37:     0x624af34a09c2 - <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]   38:     0x624af34a09c2 - 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]   39:     0x624af34a09c2 - 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]   40:     0x624af34a09c2 - 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]   41:     0x624af34a09c2 - 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]   42:     0x624af34a09c2 - <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]   43:     0x624af3508dcf - <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]   44:     0x624af3508dcf - <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]   45:     0x70eb9bfa3dfa - <unknown>
[INFO] [stdout]   46:     0x70eb9c0373d4 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     every_json_block_is_titled
[INFO] [stdout]     every_titled_block_matches_its_config_file
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 2 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "27f88458bd9778ce58884e0c80fd870b2a8a451822fb131114f63a196f45aa46", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "27f88458bd9778ce58884e0c80fd870b2a8a451822fb131114f63a196f45aa46", kill_on_drop: false }`
[INFO] [stdout] 27f88458bd9778ce58884e0c80fd870b2a8a451822fb131114f63a196f45aa46
