[INFO] cloning repository https://github.com/edlz/pokemon-champions-engine
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/edlz/pokemon-champions-engine" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fedlz%2Fpokemon-champions-engine", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fedlz%2Fpokemon-champions-engine'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 2310cb6641ee929cc8d7828658d422e79a0dd23a
[INFO] testing edlz/pokemon-champions-engine against 1.97.0-beta.6 for beta-1.98-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fedlz%2Fpokemon-champions-engine" "/workspace/builds/worker-2-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/edlz/pokemon-champions-engine
[INFO] finished tweaking git repo https://github.com/edlz/pokemon-champions-engine
[INFO] tweaked toml for git repo https://github.com/edlz/pokemon-champions-engine written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/edlz/pokemon-champions-engine on toolchain 1.97.0-beta.6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/edlz/pokemon-champions-engine 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.97.0-beta.6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3d5ced03c013a94a2f102a4510f48a6e9184255caf5fd8244f58017bde7f5210" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] bee4f6aec2cea7ddd7fa5498cf80fa096ee6cc78265f5303c72df1d6d04aaa0a
[INFO] running `Command { std: "docker" "start" "bee4f6aec2cea7ddd7fa5498cf80fa096ee6cc78265f5303c72df1d6d04aaa0a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "bee4f6aec2cea7ddd7fa5498cf80fa096ee6cc78265f5303c72df1d6d04aaa0a", 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" "bee4f6aec2cea7ddd7fa5498cf80fa096ee6cc78265f5303c72df1d6d04aaa0a" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "bee4f6aec2cea7ddd7fa5498cf80fa096ee6cc78265f5303c72df1d6d04aaa0a", 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" "bee4f6aec2cea7ddd7fa5498cf80fa096ee6cc78265f5303c72df1d6d04aaa0a" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling libc v0.2.185
[INFO] [stderr]    Compiling quote v1.0.45
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling rustc-hash v2.1.2
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling champions-engine v1.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 22.52s
[INFO] running `Command { std: "docker" "inspect" "bee4f6aec2cea7ddd7fa5498cf80fa096ee6cc78265f5303c72df1d6d04aaa0a", 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" "bee4f6aec2cea7ddd7fa5498cf80fa096ee6cc78265f5303c72df1d6d04aaa0a" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling champions-engine v1.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 20.75s
[INFO] running `Command { std: "docker" "inspect" "bee4f6aec2cea7ddd7fa5498cf80fa096ee6cc78265f5303c72df1d6d04aaa0a", 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" "bee4f6aec2cea7ddd7fa5498cf80fa096ee6cc78265f5303c72df1d6d04aaa0a" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.07s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/champions_engine-5ed0e78d5288329a)
[INFO] [stdout] 
[INFO] [stdout] running 155 tests
[INFO] [stdout] test dex::typechart::tests::dual_type_effectiveness ... ok
[INFO] [stdout] test dex::typechart::tests::earthquake_vs_heatran ... ok
[INFO] [stdout] test dex::typechart::tests::all_immunities ... ok
[INFO] [stdout] test dex::tests::re_registering_move_keeps_stable_index ... ok
[INFO] [stdout] test dex::tests::move_index_and_id_lookup_return_same_move ... ok
[INFO] [stdout] test dex::typechart::tests::basic_effectiveness ... ok
[INFO] [stdout] test dex::typechart::tests::fairy_super_effective ... ok
[INFO] [stdout] test dex::typechart::tests::fighting_super_effective ... ok
[INFO] [stdout] test dex::typechart::tests::fire_super_effective ... ok
[INFO] [stdout] test dex::typechart::tests::grass_super_effective ... ok
[INFO] [stdout] test dex::typechart::tests::ice_beam_vs_garchomp ... ok
[INFO] [stdout] test dex::typechart::tests::stealth_rock_damage_tiers ... ok
[INFO] [stdout] test dex::typechart::tests::thunderbolt_vs_gyarados ... ok
[INFO] [stdout] test dex::typechart::tests::water_super_effective ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::bucketed_force_max_collapses_to_compressed_single_branch ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::bucketed_guaranteed_ko_returns_single_branch ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::bucketed_no_ko_zero_crit_returns_three_buckets_summing_to_one ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::bucketed_partial_ko_threshold_splits_buckets ... ok
[INFO] [stdout] test dex::typechart::tests::ground_vs_rotom_wash ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::bucketed_with_crit_adds_crit_branch ... ok
[INFO] [stdout] test dex::typechart::tests::unknown_type_is_neutral ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::full_no_ko_zero_crit_enumerates_unique_rolls ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::full_guaranteed_ko_returns_single_branch ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::full_partial_ko_collapses_killing_rolls_into_single_branch ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::full_with_crit_adds_one_crit_branch ... ok
[INFO] [stdout] test engine::core::branching::tests::pick_branch_by_unit_handles_zero_total_probability ... ok
[INFO] [stdout] test engine::core::branching::tests::pick_branch_by_unit_threshold_at_branch_boundary ... ok
[INFO] [stdout] test engine::tests::avg_damage_matches_roll_mean ... ok
[INFO] [stdout] test engine::tests::compressed_cant_ko_branches_on_crit ... ok
[INFO] [stdout] test engine::tests::compressed_guaranteed_ko_collapses_to_one_branch ... ok
[INFO] [stdout] test engine::tests::compressed_spanning_ko_branches_on_kill ... ok
[INFO] [stdout] test engine::tests::partition_rolls_no_kill_when_max_below_hp ... ok
[INFO] [stdout] test engine::tests::partition_rolls_partial_kill ... ok
[INFO] [stdout] test engine::tests::deterministic_branch_picker_prefers_ko_over_longer_survive_branch ... ok
[INFO] [stdout] test engine::tests::partition_rolls_all_kill_when_min_above_hp ... ok
[INFO] [stdout] test id::tests::empty_id ... ok
[INFO] [stdout] test engine::core::branching::tests::pick_branch_by_unit_normalizes_against_total_above_one ... ok
[INFO] [stdout] test engine::core::branching::tests::pick_branch_by_unit_empirical_distribution_matches_probabilities ... ok
[INFO] [stdout] test id::tests::normalizes_names ... ok
[INFO] [stdout] test mcts::action_codec::tests::singles_choice_round_trip_uses_move_slot ... ok
[INFO] [stdout] test mcts::action_codec::tests::slot_action_round_trip_preserves_target ... ok
[INFO] [stdout] test mcts::action_codec::tests::formats_labels_without_protocol_strings_in_keys ... ok
[INFO] [stdout] test legal_actions::tests::singles_team_preview_emits_60_actions ... ok
[INFO] [stdout] test mcts::evaluate::tests::one_mega_per_side_only_first_lead_swaps_types ... ok
[INFO] [stdout] test legal_actions::tests::enumerate_legal_actions_unaffected_by_team_preview_state ... ok
[INFO] [stdout] test mcts::evaluate::tests::pick_mega_slot_returns_none_when_no_stones ... ok
[INFO] [stdout] test engine::flow::team_preview::tests::doubles_apply_revert_roundtrip ... ok
[INFO] [stdout] test engine::flow::team_preview::tests::singles_apply_revert_roundtrip ... ok
[INFO] [stdout] test legal_actions::tests::doubles_team_preview_emits_90_actions ... ok
[INFO] [stdout] test mcts::evaluate::tests::status_penalty_affects_score ... ok
[INFO] [stdout] test legal_actions::tests::singles_emits_no_mechanic_variants_with_gates_off ... ok
[INFO] [stdout] test engine::flow::team_preview::tests::validation_rejects_unsorted ... ok
[INFO] [stdout] test mcts::telemetry::tests::recording_telemetry_captures_batched_events ... ok
[INFO] [stdout] test legal_actions::tests::doubles_drops_paired_mechanic_combos ... ok
[INFO] [stdout] test legal_actions::tests::switch_enumeration_filters_unbrought ... ok
[INFO] [stdout] test engine::flow::team_preview::tests::validation_rejects_wrong_size ... ok
[INFO] [stdout] test mcts::evaluate::tests::healthier_side_scores_above_half ... ok
[INFO] [stdout] test mcts::evaluate::tests::mega_charizard_x_reads_as_fire_dragon_for_matchup ... ok
[INFO] [stdout] test engine::flow::team_preview::tests::validation_rejects_duplicate_indices ... ok
[INFO] [stdout] test legal_actions::tests::singles_only_one_mechanic_per_battle_after_use ... ok
[INFO] [stdout] test legal_actions::tests::singles_tera_gate_emits_one_variant_per_usable_move ... ok
[INFO] [stdout] test data_loader::tests::load_format_all_includes_full_gen9_dex_and_mechanic_moves ... ok
[INFO] [stdout] test mcts::evaluate::tests::team_preview_eval_mirror_stays_near_half ... ok
[INFO] [stdout] test mcts::evaluate::tests::team_preview_eval_favors_offensive_type_advantage ... ok
[INFO] [stdout] test mcts::tests::config_policy_drives_puct_to_hot_arm ... ok
[INFO] [stdout] test mcts::tests::doubles_search_runs_and_restores_state ... ok
[INFO] [stdout] test mcts::tests::team_preview_search_runs_and_emits_team_choices ... ok
[INFO] [stdout] test mcts::tests::rollout_search_picks_a_best_action ... ok
[INFO] [stdout] test mcts::evaluate::tests::type_matchup_favors_offensive_advantage ... ok
[INFO] [stdout] test mcts::evaluate::tests::type_matchup_neutral_mirror_stays_at_half ... ok
[INFO] [stdout] test prng::tests::random_chance_1_1_always_true ... ok
[INFO] [stdout] test prng::tests::random_chance_0_1_always_false ... ok
[INFO] [stdout] test prng::tests::random_chance_217_256_skewed ... ok
[INFO] [stdout] test prng::tests::random_chance_1_2_balanced ... ok
[INFO] [stdout] test prng::tests::random_range_in_bounds ... ok
[INFO] [stdout] test prng::tests::same_seed_same_sequence ... ok
[INFO] [stdout] test prng::tests::sample_balanced_over_5 ... ok
[INFO] [stdout] test mcts::tests::puct_search_runs_and_restores_state ... ok
[INFO] [stdout] test prng::tests::random_chance_matches_random_lt ... ok
[INFO] [stdout] test prng::tests::seed_roundtrip_gen5 ... ok
[INFO] [stdout] test prng::tests::seed_roundtrip_sodium ... ok
[INFO] [stdout] test prng::tests::shuffle_is_deterministic ... ok
[INFO] [stdout] test prng::tests::shuffle_is_permutation ... ok
[INFO] [stdout] test mcts::tests::rollout_search_restores_root_state_byte_for_byte ... ok
[INFO] [stdout] test prng::tests::sample_single_item ... ok
[INFO] [stdout] test state::tests::test_battle_state_json_roundtrip ... ok
[INFO] [stdout] test state::tests::test_choice_roundtrip ... ok
[INFO] [stdout] test prng::tests::sample_empty_panics - should panic ... ok
[INFO] [stdout] test state::tests::test_effect_state_roundtrip ... ok
[INFO] [stdout] test mcts::tests::max_time_ms_caps_iterations_under_short_budget ... ok
[INFO] [stdout] test mcts::tests::duct_search_visits_every_root_action_at_least_once ... ok
[INFO] [stdout] test state::tests::test_normalize_log ... ok
[INFO] [stdout] test state::tests::test_prng_seed_roundtrip ... ok
[INFO] [stdout] test stats::tests::boost_by_should_return_false_at_max ... ok
[INFO] [stdout] test stats::tests::boost_by_should_return_true_when_stats_changed ... ok
[INFO] [stdout] test stats::tests::accuracy_multiplier_uses_base_3 ... ok
[INFO] [stdout] test stats::tests::boosts_should_clamp_to_6 ... ok
[INFO] [stdout] test stats::tests::boosts_should_clamp_to_negative_6 ... ok
[INFO] [stdout] test stats::tests::champions_hp_calculation ... ok
[INFO] [stdout] test stats::tests::adamant_should_boost_atk_lower_spa ... ok
[INFO] [stdout] test stats::tests::champions_pp_calculation ... ok
[INFO] [stdout] test stats::tests::champions_stat_with_nature ... ok
[INFO] [stdout] test stats::tests::default_ivs_are_all_31 ... ok
[INFO] [stdout] test stats::tests::modest_should_boost_spa_lower_atk ... ok
[INFO] [stdout] test stats::tests::natures_should_have_opposite_plus_and_minus ... ok
[INFO] [stdout] test stats::tests::neutral_natures_should_have_no_plus_or_minus ... ok
[INFO] [stdout] test stats::tests::shedinja_hp_should_always_be_1 ... ok
[INFO] [stdout] test stats::tests::standard_atk_calc_at_level_50 ... ok
[INFO] [stdout] test stats::tests::stat_multiplier_negative_boosts ... ok
[INFO] [stdout] test stats::tests::stat_multiplier_positive_boosts ... ok
[INFO] [stdout] test stats::tests::standard_hp_calc_at_level_50 ... ok
[INFO] [stdout] test stats::tests::stat_multiplier_zero_is_neutral ... ok
[INFO] [stdout] test stats::tests::stats_table_get_and_set ... ok
[INFO] [stdout] test stats::tests::timid_should_boost_spe_lower_atk ... ok
[INFO] [stdout] test stats::tests::trunc_16_bit ... ok
[INFO] [stdout] test stats::tests::trunc_no_bits_returns_input ... ok
[INFO] [stdout] test mcts::tests::duct_search_restores_root_state_byte_for_byte ... ok
[INFO] [stdout] test team_validator::tests::accepts_level_50_max_ivs_and_legal_evs ... ok
[INFO] [stdout] test team_validator::tests::rejects_empty_team ... ok
[INFO] [stdout] test team_validator::tests::rejects_evs_above_per_stat_limit ... ok
[INFO] [stdout] test team_validator::tests::rejects_evs_above_total_limit ... ok
[INFO] [stdout] test team_validator::tests::rejects_missing_team ... ok
[INFO] [stdout] test team_validator::tests::rejects_non_50_level ... ok
[INFO] [stdout] test teams::tests::export_hides_stats_when_requested ... ok
[INFO] [stdout] test teams::tests::export_and_import_roundtrip ... ok
[INFO] [stdout] test teams::tests::export_removes_nicknames_when_requested ... ok
[INFO] [stdout] test teams::tests::export_with_nickname ... ok
[INFO] [stdout] test teams::tests::import_frustration_sets_happiness_zero ... ok
[INFO] [stdout] test teams::tests::import_with_ivs ... ok
[INFO] [stdout] test team_validator::tests::rejects_non_max_ivs ... ok
[INFO] [stdout] test team_validator::tests::reports_multiple_set_errors ... ok
[INFO] [stdout] test teams::tests::import_packed_format_single_line ... ok
[INFO] [stdout] test teams::tests::pack_and_unpack_roundtrip ... ok
[INFO] [stdout] test teams::tests::pack_happiness ... ok
[INFO] [stdout] test teams::tests::pack_multiple_sets ... ok
[INFO] [stdout] test teams::tests::pack_name_strips_non_alnum ... ok
[INFO] [stdout] test teams::tests::pack_shiny_and_level ... ok
[INFO] [stdout] test teams::tests::unpack_empty_returns_none ... ok
[INFO] [stdout] test teams::tests::pack_tera_type ... ok
[INFO] [stdout] test teams::tests::pack_non_default_ivs ... ok
[INFO] [stdout] test mcts::tests::ucb1_concentrates_visits_on_promising_actions ... ok
[INFO] [stdout] test mcts::tests::config_policy_uniform_matches_no_policy ... ok
[INFO] [stdout] test mcts::tests::time_only_budget_runs_without_iteration_cap ... FAILED
[INFO] [stdout] test mcts::value::tests::heuristic_matches_evaluate_function ... ok
[INFO] [stdout] test mcts::tests::mega_actions_enumerated_and_mcts_round_trips_state ... ok
[INFO] [stdout] test mcts::tests::telemetry_records_search_lifecycle ... ok
[INFO] [stdout] test state::tests::test_calculate_damage_rolls ... ok
[INFO] [stdout] test mcts::value::tests::const_evaluator_returns_constant ... ok
[INFO] [stdout] test mcts::evaluate::tests::terminal_result_overrides_heuristic_score ... ok
[INFO] [stdout] test test_helpers::tests::replay_gender_n_uses_fixed_genderless_metadata_for_rotom ... ok
[INFO] [stdout] test test_helpers::tests::replay_gender_n_defaults_variable_species_to_ps_gender ... ok
[INFO] [stdout] test test_helpers::tests::team_preview_normalizes_mega_forme_declarations ... ok
[INFO] [stdout] test state::tests::test_battle_hydration_roundtrip ... ok
[INFO] [stdout] test mcts::value::tests::override_drives_root_action_means ... ok
[INFO] [stdout] test state::tests::test_doubles_battle_hydration_roundtrip ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- mcts::tests::time_only_budget_runs_without_iteration_cap stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'mcts::tests::time_only_budget_runs_without_iteration_cap' (1107) panicked at src/mcts.rs:2683:9:
[INFO] [stdout] time-only search should not be capped at the default 100 iterations
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x57b04e3692f8 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x57b04e3692f8 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::trace_unsynchronized::<std[10d71ac2c42b111e]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x57b04e3692f8 - std[10d71ac2c42b111e]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x57b04e3692f8 - <<std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x57b04e37f90a - <core[8fb95b77d25ab6c8]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x57b04e37f90a - core[8fb95b77d25ab6c8]::fmt::write
[INFO] [stdout]    6:     0x57b04e36db12 - std[10d71ac2c42b111e]::io::default_write_fmt::<alloc[a7ee25936407c584]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x57b04e36db12 - <alloc[a7ee25936407c584]::vec::Vec<u8> as std[10d71ac2c42b111e]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x57b04e347fc6 - <std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x57b04e347fc6 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x57b04e3614e9 - std[10d71ac2c42b111e]::panicking::default_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x57b04e2bcf9c - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   12:     0x57b04e2bcf9c - test[213991da798b1c03]::test_main_inner::<test[213991da798b1c03]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x57b04e3616a2 - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   14:     0x57b04e3616a2 - std[10d71ac2c42b111e]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x57b04e3480b4 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x57b04e33d139 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace::<std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x57b04e348d9d - __rustc[3be9ba60078d4c86]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x57b04e38009c - core[8fb95b77d25ab6c8]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x57b04e1ea3ea - champions_engine[2d9e11306c59a0b3]::mcts::tests::time_only_budget_runs_without_iteration_cap
[INFO] [stdout]                                at /opt/rustwide/workdir/src/mcts.rs:2683:9
[INFO] [stdout]   20:     0x57b04e1da5e7 - champions_engine[2d9e11306c59a0b3]::mcts::tests::time_only_budget_runs_without_iteration_cap::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/mcts.rs:2667:53
[INFO] [stdout]   21:     0x57b04dfea906 - <champions_engine[2d9e11306c59a0b3]::mcts::tests::time_only_budget_runs_without_iteration_cap::{closure#0} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   22:     0x57b04e2b007b - <fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x57b04e2b007b - test[213991da798b1c03]::__rust_begin_short_backtrace::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:724:18
[INFO] [stdout]   24:     0x57b04e2bd8f5 - test[213991da798b1c03]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:74
[INFO] [stdout]   25:     0x57b04e2bd8f5 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   26:     0x57b04e2bd8f5 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   27:     0x57b04e2bd8f5 - std[10d71ac2c42b111e]::panicking::catch_unwind::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   28:     0x57b04e2bd8f5 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   29:     0x57b04e2bd8f5 - test[213991da798b1c03]::run_test_in_process
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:27
[INFO] [stdout]   30:     0x57b04e2bd8f5 - test[213991da798b1c03]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:668:43
[INFO] [stdout]   31:     0x57b04e2b7204 - test[213991da798b1c03]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:698:41
[INFO] [stdout]   32:     0x57b04e2b7204 - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace::<test[213991da798b1c03]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   33:     0x57b04e2c0972 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   34:     0x57b04e2c0972 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   35:     0x57b04e2c0972 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   36:     0x57b04e2c0972 - std[10d71ac2c42b111e]::panicking::catch_unwind::<(), core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   37:     0x57b04e2c0972 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   38:     0x57b04e2c0972 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   39:     0x57b04e2c0972 - <std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x57b04e36891f - <alloc[a7ee25936407c584]::boxed::Box<dyn core[8fb95b77d25ab6c8]::ops::function::FnOnce<(), Output = ()> + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2275:9
[INFO] [stdout]   41:     0x57b04e36891f - <std[10d71ac2c42b111e]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   42:     0x78cddabb0aa4 - <unknown>
[INFO] [stdout]   43:     0x78cddac3da64 - clone
[INFO] [stdout]   44:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     mcts::tests::time_only_budget_runs_without_iteration_cap
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 154 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.82s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "bee4f6aec2cea7ddd7fa5498cf80fa096ee6cc78265f5303c72df1d6d04aaa0a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bee4f6aec2cea7ddd7fa5498cf80fa096ee6cc78265f5303c72df1d6d04aaa0a", kill_on_drop: false }`
[INFO] [stdout] bee4f6aec2cea7ddd7fa5498cf80fa096ee6cc78265f5303c72df1d6d04aaa0a
