[INFO] fetching crate somatize-runtime 0.5.1...
[INFO] testing somatize-runtime-0.5.1 against 1.99.0-beta.8 for beta-1.100-2
[INFO] extracting crate somatize-runtime 0.5.1 into /workspace/builds/worker-7-tc1/source
[INFO] started tweaking crates.io crate somatize-runtime 0.5.1
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate somatize-runtime 0.5.1
[INFO] tweaked toml for crates.io crate somatize-runtime 0.5.1 written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate somatize-runtime 0.5.1 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate somatize-runtime 0.5.1 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded zerocopy-derive v0.8.47
[INFO] [stderr]   Downloaded somatize-macros v0.5.1
[INFO] [stderr]   Downloaded wasm-bindgen-macro v0.2.115
[INFO] [stderr]   Downloaded wasm-bindgen-shared v0.2.115
[INFO] [stderr]   Downloaded somatize-core v0.5.1
[INFO] [stderr]   Downloaded wasm-bindgen-macro-support v0.2.115
[INFO] [stderr]   Downloaded somatize-compiler v0.5.1
[INFO] [stderr]   Downloaded wasm-bindgen v0.2.115
[INFO] [stderr]   Downloaded js-sys v0.3.92
[INFO] [stderr]   Downloaded zerocopy v0.8.47
[INFO] [stderr]   Downloaded libc v0.2.183
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 67789ba05992592eb273433a399b142cc69143dae667e8f851521f7086f23917
[INFO] running `Command { std: "docker" "start" "67789ba05992592eb273433a399b142cc69143dae667e8f851521f7086f23917", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "67789ba05992592eb273433a399b142cc69143dae667e8f851521f7086f23917", 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" "67789ba05992592eb273433a399b142cc69143dae667e8f851521f7086f23917" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "67789ba05992592eb273433a399b142cc69143dae667e8f851521f7086f23917", 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" "67789ba05992592eb273433a399b142cc69143dae667e8f851521f7086f23917" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling typenum v1.19.0
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling zerocopy v0.8.47
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling shlex v1.3.0
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling ciborium-io v0.2.2
[INFO] [stderr]    Compiling cc v1.2.58
[INFO] [stderr]    Compiling iana-time-zone v0.1.65
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling blake3 v1.8.5
[INFO] [stderr]    Compiling crypto-common v0.1.7
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling zerocopy-derive v0.8.47
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling somatize-macros v0.5.1
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling somatize-core v0.5.1
[INFO] [stderr]    Compiling somatize-compiler v0.5.1
[INFO] [stderr]    Compiling somatize-runtime v0.5.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 52.45s
[INFO] running `Command { std: "docker" "inspect" "67789ba05992592eb273433a399b142cc69143dae667e8f851521f7086f23917", 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" "67789ba05992592eb273433a399b142cc69143dae667e8f851521f7086f23917" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.183
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling tokio-macros v2.6.1
[INFO] [stderr]    Compiling quick-error v1.2.3
[INFO] [stderr]    Compiling bit-vec v0.8.0
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling unarray v0.1.4
[INFO] [stderr]    Compiling bit-set v0.8.0
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling somatize-core v0.5.1
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling proptest v1.11.0
[INFO] [stderr]    Compiling somatize-compiler v0.5.1
[INFO] [stderr]    Compiling somatize-runtime v0.5.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1m 01s
[INFO] running `Command { std: "docker" "inspect" "67789ba05992592eb273433a399b142cc69143dae667e8f851521f7086f23917", 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" "67789ba05992592eb273433a399b142cc69143dae667e8f851521f7086f23917" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.23s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/somatize_runtime-4fa0c462903e57a6)
[INFO] [stdout] 
[INFO] [stdout] running 255 tests
[INFO] [stdout] test cache::fs_store::tests::format_version_guard ... ok
[INFO] [stdout] test cache::fs_store::tests::pins_roundtrip ... ok
[INFO] [stdout] test cache::fs_store::tests::survives_restart ... ok
[INFO] [stdout] test cache::gc::tests::min_age_protects_fresh_blobs ... ok
[INFO] [stdout] test cache::fs_store::tests::concurrent_writers_same_key ... ok
[INFO] [stdout] test cache::fs_store::tests::corrupt_blob_is_a_miss_not_an_error ... ok
[INFO] [stdout] test cache::fs_store::tests::roundtrip_and_dedup ... ok
[INFO] [stdout] test cache::local::tests::exists_check ... ok
[INFO] [stdout] test cache::local::tests::get_missing ... ok
[INFO] [stdout] test cache::local::tests::concurrent_same_key_puts_are_safe ... ok
[INFO] [stdout] test cache::gc::tests::evicts_cheap_large_before_expensive_small ... ok
[INFO] [stdout] test cache::local::tests::put_and_get ... ok
[INFO] [stdout] test cache::local::tests::remove_entry ... ok
[INFO] [stdout] test cache::memory::tests::clear_empties_cache ... ok
[INFO] [stdout] test cache::local::tests::put_with_origin_records_provenance ... ok
[INFO] [stdout] test cache::local::tests::orphan_tmp_files_are_not_entries ... ok
[INFO] [stdout] test cache::memory::tests::exists_check ... ok
[INFO] [stdout] test cache::local::tests::metadata_persists ... ok
[INFO] [stdout] test cache::memory::tests::lru_evicts_oldest_when_full ... ok
[INFO] [stdout] test cache::memory::tests::get_missing_returns_none ... ok
[INFO] [stdout] test cache::memory::tests::lru_access_prevents_eviction ... ok
[INFO] [stdout] test cache::memory::tests::lru_overwrite_updates_size ... ok
[INFO] [stdout] test cache::memory::tests::overwrite_existing_key ... ok
[INFO] [stdout] test cache::memory::tests::provenance_survives_a_put ... ok
[INFO] [stdout] test cache::memory::tests::put_and_get ... ok
[INFO] [stdout] test cache::memory::tests::lru_tracks_byte_usage ... ok
[INFO] [stdout] test cache::memory::tests::remove_entry ... ok
[INFO] [stdout] test cache::fs_store::tests::eviction_keeps_record_and_refills ... ok
[INFO] [stdout] test cache::memory::tests::metadata_available ... ok
[INFO] [stdout] test cache::memory::tests::multiple_keys ... ok
[INFO] [stdout] test cache::local::tests::survives_restart ... ok
[INFO] [stdout] test cache::gc::tests::under_budget_is_a_noop ... ok
[INFO] [stdout] test effects::graph_handler::tests::a_failing_graph_comes_back_as_a_result ... ok
[INFO] [stdout] test cache::tiered::tests::get_from_memory_first ... ok
[INFO] [stdout] test effects::graph_handler::tests::a_graph_effect_runs_the_graph ... ok
[INFO] [stdout] test cache::tiered::tests::put_writes_to_all_tiers ... ok
[INFO] [stdout] test effects::graph_handler::tests::a_step_sub_graph_without_a_runtime_names_the_fix ... ok
[INFO] [stdout] test effects::graph_handler::tests::fit_mode_fits_and_summarizes ... ok
[INFO] [stdout] test cache::gc::tests::pinned_blobs_are_roots ... ok
[INFO] [stdout] test effects::graph_handler::tests::the_handler_claims_only_graph_effects ... ok
[INFO] [stdout] test effects::journal::tests::a_disabled_journal_records_nothing ... ok
[INFO] [stdout] test effects::graph_handler::tests::a_sub_graph_containing_a_step_runs ... ok
[INFO] [stdout] test effects::journal::tests::an_evicted_blob_reads_as_absent ... ok
[INFO] [stdout] test effects::journal::tests::different_effects_at_the_same_site_differ ... ok
[INFO] [stdout] test effects::journal::tests::failures_are_not_recorded ... ok
[INFO] [stdout] test effects::graph_handler::tests::an_identical_pure_graph_effect_is_served_from_the_journal ... ok
[INFO] [stdout] test effects::journal::tests::impure_effects_do_not_leak_across_runs ... ok
[INFO] [stdout] test cache::tiered::tests::miss_returns_none ... ok
[INFO] [stdout] test effects::journal::tests::keying::adjacent_site_fields_do_not_blur_together ... ok
[INFO] [stdout] test cache::tiered::tests::promotes_from_local_to_memory ... ok
[INFO] [stdout] test effects::journal::tests::effects_within_a_turn_are_distinct ... ok
[INFO] [stdout] test cache::tiered::tests::get_located_names_the_tier_that_answered ... ok
[INFO] [stdout] test cache::tiered::tests::remove_from_all_tiers ... ok
[INFO] [stdout] test effects::sleep_handler::tests::it_sleeps_and_claims_only_sleeps ... ok
[INFO] [stdout] test effects::journal::tests::pure_effects_are_shared ... ok
[INFO] [stdout] test effects::graph_handler::tests::nesting_stops_at_the_depth_cap ... ok
[INFO] [stdout] test effects::journal::tests::records_then_replays ... ok
[INFO] [stdout] test effects::tests::a_spawned_child_that_hands_off_is_an_error ... ok
[INFO] [stdout] test effects::tests::a_capped_step_still_reports_its_cost ... ok
[INFO] [stdout] test effects::tests::a_step_can_decline_journaling ... ok
[INFO] [stdout] test effects::tests::a_spawned_child_that_panics_is_contained ... ok
[INFO] [stdout] test effects::tests::an_answer_does_not_carry_to_another_run ... ok
[INFO] [stdout] test effects::tests::all_settled_keeps_what_succeeded ... ok
[INFO] [stdout] test effects::tests::a_fresh_run_calls_the_model ... ok
[INFO] [stdout] test effects::tests::awaiting_nothing_is_an_error ... ok
[INFO] [stdout] test effects::tests::an_unhandled_effect_says_so ... ok
[INFO] [stdout] test effects::tests::first_returns_the_first_answer ... ok
[INFO] [stdout] test effects::tests::a_runaway_step_is_capped ... ok
[INFO] [stdout] test effects::tests::resuming_without_a_journal_is_refused ... ok
[INFO] [stdout] test effects::tests::re_running_without_an_answer_suspends_again ... ok
[INFO] [stdout] test effects::tests::spawned_siblings_journal_separately ... ok
[INFO] [stdout] test effects::tests::replaying_a_run_performs_nothing ... ok
[INFO] [stdout] test effects::tests::concurrent_effects_keep_request_order ... ok
[INFO] [stdout] test effects::tests::spawning_emits_the_fan_out ... ok
[INFO] [stdout] test effects::tests::runs_a_multi_turn_step ... ok
[INFO] [stdout] test effects::tests::spawning_an_unknown_step_names_it ... ok
[INFO] [stdout] test effects::tests::spawning_nothing_is_an_error ... ok
[INFO] [stdout] test effects::tests::spawns_a_worker_per_item_and_joins_in_order ... ok
[INFO] [stdout] test effects::tests::spawning_without_a_library_explains_itself ... ok
[INFO] [stdout] test effects::tests::suspends_then_resumes_with_the_answer ... ok
[INFO] [stdout] test event_bus::tests::a_sink_may_touch_the_bus_from_inside_record ... ok
[INFO] [stdout] test event_bus::tests::remove_sink_drops_every_clone_of_a_doubly_registered_arc ... ok
[INFO] [stdout] test event_bus::tests::multiple_subscribers ... ok
[INFO] [stdout] test event_bus::tests::remove_sink_flushes_detaches_and_respects_identity ... ok
[INFO] [stdout] test event_bus::tests::emit_without_subscribers_succeeds ... ok
[INFO] [stdout] test event_bus::tests::flush_sinks_flushes_all_registered_sinks ... ok
[INFO] [stdout] test event_bus::tests::sinks_observe_events_synchronously_before_emit_returns ... ok
[INFO] [stdout] test event_bus::tests::sinks_stay_lossless_while_subscribers_lag ... ok
[INFO] [stdout] test event_bus::tests::subscriber_after_emit_misses_earlier_events ... ok
[INFO] [stdout] test event_bus::tests::subscriber_receives_events ... ok
[INFO] [stdout] test executor::tests::cache_hit_emits_cache_hit_event ... ok
[INFO] [stdout] test executor::tests::different_input_misses_cache ... ok
[INFO] [stdout] test executor::tests::early_cutoff_downstream_hits_when_upstream_output_unchanged ... ok
[INFO] [stdout] test executor::tests::execute_emits_events ... ok
[INFO] [stdout] test executor::tests::execute_empty_plan ... ok
[INFO] [stdout] test executor::tests::execute_missing_filter_errors ... ok
[INFO] [stdout] test executor::tests::execute_sequence_with_graph_info ... ok
[INFO] [stdout] test executor::tests::execute_single_node ... ok
[INFO] [stdout] test executor::tests::execute_parallel_branches_merge_outputs ... ok
[INFO] [stdout] test executor::tests::execute_stream_chunks_input ... ok
[INFO] [stdout] test executor::tests::execute_stream_chain ... ok
[INFO] [stdout] test executor::tests::execute_stream_single_chunk ... ok
[INFO] [stdout] test executor::tests::graph_info_from_linear ... ok
[INFO] [stdout] test executor::tests::nondeterministic_filter_is_never_cached ... ok
[INFO] [stdout] test executor::tests::resolve_input_multiple_predecessors ... ok
[INFO] [stdout] test executor::tests::resolve_input_no_predecessors_fallback ... ok
[INFO] [stdout] test executor::tests::resolve_input_single_predecessor ... ok
[INFO] [stdout] test executor::tests::a_panicking_parallel_branch_becomes_an_error ... ok
[INFO] [stdout] test executor::tests::second_run_hits_cache_and_skips_execution ... ok
[INFO] [stdout] test executor::tests::spill_roundtrip_through_datastore ... ok
[INFO] [stdout] test executor::tests::stream_and_standard_share_one_cache_line ... ok
[INFO] [stdout] test executor::tests::stream_emits_one_bracket_per_node ... ok
[INFO] [stdout] test executor::tests::parallel_merge_keeps_rerun_outputs ... ok
[INFO] [stdout] test executor::tests::stream_node_failed_names_the_chunk ... ok
[INFO] [stdout] test executor::tests::stream_events_match_standard_for_fixed_chains ... ok
[INFO] [stdout] test executor::tests::stream_refuses_fit_mode ... ok
[INFO] [stdout] test executor::tests::uncacheable_filter_always_executes ... ok
[INFO] [stdout] test executors::pbt::tests::pbt_basic_run ... ok
[INFO] [stdout] test executors::pbt::tests::pbt_population_evolves ... ok
[INFO] [stdout] test executors::stream::tests::a_chunk_cache_key_follows_the_run_seed ... ok
[INFO] [stdout] test executors::pbt::tests::pbt_emits_events ... ok
[INFO] [stdout] test executors::stream::tests::an_unknown_node_is_an_error_not_a_skip ... ok
[INFO] [stdout] test executors::stream::tests::barrier_accumulates_then_flushes ... ok
[INFO] [stdout] test executors::stream::tests::barrier_flush_goes_through_the_cache ... ok
[INFO] [stdout] test executors::stream::tests::cached_chunks_are_served_and_counted ... ok
[INFO] [stdout] test executors::stream::tests::fixed_state_processes_each_chunk ... ok
[INFO] [stdout] test executors::stream::tests::evolving_state_accumulates ... ok
[INFO] [stdout] test executors::stream::tests::mixed_pipeline_fixed_then_barrier ... ok
[INFO] [stdout] test executors::stream::tests::non_finite_chunks_do_not_share_a_cache_key ... ok
[INFO] [stdout] test executors::stream::tests::uncacheable_chunks_are_not_cached ... ok
[INFO] [stdout] test executors::study::tests::all_failed_study_completes_with_nan_best ... ok
[INFO] [stdout] test executors::study::tests::best_updated_fires_once_when_trials_worsen ... ok
[INFO] [stdout] test executors::study::tests::composite_objective_selects_best_trial ... ok
[INFO] [stdout] test executors::study::tests::failing_tracker_never_fails_the_study ... ok
[INFO] [stdout] test executors::study::tests::frozen_param_overrides_a_sampled_dimension ... ok
[INFO] [stdout] test executors::study::tests::frozen_params_reach_every_trial ... ok
[INFO] [stdout] test executors::study::tests::bayesian_through_runner_improves_over_time ... ok
[INFO] [stdout] test executors::study::tests::grid_study_started_reports_real_total ... ok
[INFO] [stdout] test executors::study::tests::median_pruner_stops_bad_trials_maximize ... ok
[INFO] [stdout] test executors::study::tests::median_pruner_stops_bad_trials_minimize ... ok
[INFO] [stdout] test executors::study::tests::non_objective_metric_never_consults_the_pruner ... ok
[INFO] [stdout] test executors::study::tests::percentile_pruning_works_through_the_runner ... ok
[INFO] [stdout] test executors::study::tests::planned_trials_is_stamped_and_progress_completes ... ok
[INFO] [stdout] test executors::study::tests::pruner_verdict_wins_over_completed_outcome ... ok
[INFO] [stdout] test executor::tests::cache_survives_process_restart ... ok
[INFO] [stdout] test executors::study::tests::report_after_prune_is_sticky_and_skips_the_pruner ... ok
[INFO] [stdout] test executors::study::tests::report_emits_trial_metric_events ... ok
[INFO] [stdout] test executors::study::tests::pruning_watches_first_composite_term_when_no_objectives ... ok
[INFO] [stdout] test executors::study::tests::reported_and_final_metrics_are_concatenated_not_deduped ... ok
[INFO] [stdout] test executors::study::tests::resume_continues_without_repeating_grid_params ... ok
[INFO] [stdout] test executors::study::tests::sampler_feedback_values_are_exact_and_skip_non_completed ... ok
[INFO] [stdout] test executors::study::tests::sampler_receives_feedback_per_completed_trial ... ok
[INFO] [stdout] test executors::study::tests::study_is_saved_after_every_trial_with_monotonic_growth ... ok
[INFO] [stdout] test executors::study::tests::study_progress_tracking ... ok
[INFO] [stdout] test executors::study::tests::resume_replays_history_into_the_sampler_before_sampling ... ok
[INFO] [stdout] test executors::study::tests::study_runner_grid_search ... ok
[INFO] [stdout] test executors::study::tests::study_runner_handles_failed_trials ... ok
[INFO] [stdout] test executors::study::tests::study_runner_handles_pruned_trials ... ok
[INFO] [stdout] test executors::study::tests::timestamps_backfilled_and_monotonic ... ok
[INFO] [stdout] test executors::study::tests::study_runner_random_search ... ok
[INFO] [stdout] test forward::tests::standard_forward ... ok
[INFO] [stdout] test executors::study::tests::trial_context_accessors_and_cross_thread_clone ... ok
[INFO] [stdout] test forward::tests::stream_forward ... ok
[INFO] [stdout] test forward::tests::stream_matches_standard ... ok
[INFO] [stdout] test graph_session::tests::graph_run_diamond ... ok
[INFO] [stdout] test graph_session::tests::graph_fit_trainable ... ok
[INFO] [stdout] test graph_session::tests::graph_run_linear ... ok
[INFO] [stdout] test graph_session::tests::session_compile_diagnostics ... ok
[INFO] [stdout] test graph_session::tests::session_fit_and_forward ... ok
[INFO] [stdout] test graph_session::tests::session_run_linear ... ok
[INFO] [stdout] test graph_session::tests::state_address_is_stable_for_the_same_graph ... ok
[INFO] [stdout] test graph_session::tests::state_address_separates_graphs_that_share_node_ids ... ok
[INFO] [stdout] test graph_session::tests::the_catalog_is_the_compiler_registry ... ok
[INFO] [stdout] test node_catalog::tests::a_failing_state_store_is_reported_not_fatal ... ok
[INFO] [stdout] test node_catalog::tests::a_step_registers_beside_filters_not_as_one ... ok
[INFO] [stdout] test node_catalog::tests::a_steps_node_meta_declares_it_effectful_and_uncacheable ... ok
[INFO] [stdout] test node_catalog::tests::clear_states_keeps_filters ... ok
[INFO] [stdout] test node_catalog::tests::implements_filter_registry ... ok
[INFO] [stdout] test node_catalog::tests::has_steps_flips_when_the_first_step_arrives ... ok
[INFO] [stdout] test node_catalog::tests::register_and_query ... ok
[INFO] [stdout] test node_catalog::tests::state_management ... ok
[INFO] [stdout] test pruner::tests::median_empty_history ... ok
[INFO] [stdout] test node_catalog::tests::merge_from_merges_and_rejects_a_config_collision ... ok
[INFO] [stdout] test pruner::tests::median_keeps_above_median ... ok
[INFO] [stdout] test pruner::tests::median_no_prune_during_warmup ... ok
[INFO] [stdout] test pruner::tests::median_no_prune_insufficient_history ... ok
[INFO] [stdout] test pruner::tests::median_prunes_below_median ... ok
[INFO] [stdout] test pruner::tests::percentile_keeps_above_threshold ... ok
[INFO] [stdout] test pruner::tests::percentile_prunes_below_threshold ... ok
[INFO] [stdout] test pruner::tests::percentile_warmup_respected ... ok
[INFO] [stdout] test runner::local::tests::state_cache_key_is_sensitive_to_labels ... ok
[INFO] [stdout] test sampler::bayesian::tests::different_seeds_differ ... ok
[INFO] [stdout] test sampler::bayesian::tests::record_result_trait_method_feeds_the_model ... ok
[INFO] [stdout] test sampler::bayesian::tests::respects_n_trials_limit ... ok
[INFO] [stdout] test sampler::bayesian::tests::startup_phase_is_random ... ok
[INFO] [stdout] test sampler::bayesian::tests::tpe_actually_biases_towards_good_regions ... ok
[INFO] [stdout] test sampler::bayesian::tests::tpe_phase_after_recording_history ... ok
[INFO] [stdout] test executors::study::tests::tracker_persists_study_after_every_trial ... ok
[INFO] [stdout] test sampler::tests::grid_prepare_resolves_total_before_first_sample ... ok
[INFO] [stdout] test sampler::tests::grid_empty_space ... ok
[INFO] [stdout] test sampler::tests::grid_sampler_generates_all_combinations ... ok
[INFO] [stdout] test sampler::bayesian::tests::deterministic_with_seed ... ok
[INFO] [stdout] test sampler::tests::grid_sampler_int_dimension ... ok
[INFO] [stdout] test sampler::tests::grid_sampler_respects_log_scale ... ok
[INFO] [stdout] test sampler::tests::linspace_linear ... ok
[INFO] [stdout] test sampler::tests::linspace_log_denser_at_low_end ... ok
[INFO] [stdout] test sampler::tests::linspace_single_point ... ok
[INFO] [stdout] test sampler::tests::random_sampler_deterministic_with_seed ... ok
[INFO] [stdout] test sampler::tests::random_sampler_different_seeds_differ ... ok
[INFO] [stdout] test sampler::tests::random_sampler_generates_n_trials ... ok
[INFO] [stdout] test sampler::tests::random_sampler_respects_bounds ... ok
[INFO] [stdout] test sampler::tests::record_result_is_a_noop_for_stateless_samplers ... ok
[INFO] [stdout] test strategy::tests::a_contributor_missing_a_key_is_an_error_naming_it ... ok
[INFO] [stdout] test strategy::tests::a_node_in_two_partitions_is_refused ... ok
[INFO] [stdout] test strategy::tests::aggregating_over_zero_contributors_errors_rather_than_panicking ... ok
[INFO] [stdout] test strategy::tests::allreduce_averages_and_the_others_say_what_they_are_not ... ok
[INFO] [stdout] test strategy::tests::an_unclaimed_node_is_refused_by_name ... ok
[INFO] [stdout] test strategy::tests::data_parallel_runs_its_loop ... ok
[INFO] [stdout] test strategy::tests::interleaved_partitions_are_refused ... ok
[INFO] [stdout] test strategy::tests::mismatched_shapes_name_both ... ok
[INFO] [stdout] test strategy::tests::model_parallel_threads_the_activation_between_stages ... ok
[INFO] [stdout] test strategy::tests::no_partitions_at_all_is_refused ... ok
[INFO] [stdout] test strategy::tests::an_unnamed_worker_pool_refuses_a_pinned_partition ... ok
[INFO] [stdout] test strategy::tests::partitions_are_ordered_by_the_plan_not_by_declaration ... ok
[INFO] [stdout] test strategy::tests::shard_pair_refuses_row_counts_that_disagree ... ok
[INFO] [stdout] test strategy::tests::shard_pair_without_targets_yields_none_per_shard ... ok
[INFO] [stdout] test strategy::tests::shard_pair_splits_targets_alongside_inputs ... ok
[INFO] [stdout] test strategy::tests::the_adaptive_variants_say_what_they_would_need ... ok
[INFO] [stdout] test strategy::tests::the_federated_loop_converges_to_the_mean_of_its_clients ... ok
[INFO] [stdout] test strategy::tests::single_worker_aggregation_is_the_identity ... ok
[INFO] [stdout] test study_io::tests::load_errors_are_typed ... ok
[INFO] [stdout] test study_io::tests::a_study_survives_a_round_trip_through_a_file ... ok
[INFO] [stdout] test tracking::head::tests::a_blank_head_reads_as_no_parent ... ok
[INFO] [stdout] test tracking::head::tests::advancing_head_reports_whether_it_moved ... ok
[INFO] [stdout] test tracking::head::tests::head_is_not_read_when_a_parent_is_already_known ... ok
[INFO] [stdout] test tracking::head::tests::checkout_refuses_a_run_that_does_not_exist ... ok
[INFO] [stdout] test tracking::head::tests::head_roundtrips_and_tolerates_absence ... ok
[INFO] [stdout] test tracking::head::tests::precedence_is_explicit_then_env_then_head ... ok
[INFO] [stdout] test tracking::reader::tests::run_info_detects_crash_from_stale_heartbeat ... ok
[INFO] [stdout] test tracking::reader::tests::run_info_duration_and_kind ... ok
[INFO] [stdout] test tracking::head::tests::write_head_creates_the_root ... ok
[INFO] [stdout] test strategy::tests::fedavg_averages_element_wise ... ok
[INFO] [stdout] test tracking::summary::tests::a_failed_run_leads_with_its_error ... ok
[INFO] [stdout] test tracking::summary::tests::a_bare_run_dir_summarizes_with_warnings ... ok
[INFO] [stdout] test tracking::summary::tests::a_study_run_summarizes_its_trials ... ok
[INFO] [stdout] test tracking::summary::tests::audit_report_flags_are_grouped_by_family ... ok
[INFO] [stdout] test tracking::summary::tests::cache_ratio_counts_hits_over_attempts ... ok
[INFO] [stdout] test tracking::summary::tests::malformed_artifacts_warn_instead_of_failing ... ok
[INFO] [stdout] test tracking::summary::tests::headline_is_deterministic ... ok
[INFO] [stdout] test executor::tests::parallel_branches_run_concurrently ... ok
[INFO] [stdout] test tracking::summary::tests::summarizes_a_completed_run_end_to_end ... ok
[INFO] [stdout] test executors::stream::tests::a_panicking_chunk_is_contained ... ok
[INFO] [stdout] test effects::journal::tests::keying::pure_and_sited_keys_never_collide ... ok
[INFO] [stdout] test effects::journal::tests::keying::a_sited_key_separates_effects ... ok
[INFO] [stderr]      Running tests/agentic_step.rs (/opt/rustwide/target/debug/deps/agentic_step-33a302c1c84169d3)
[INFO] [stdout] test effects::journal::tests::keying::a_sited_key_is_exactly_its_site_and_effect ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 255 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.16s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 21 tests
[INFO] [stdout] test a_remote_step_is_wrapped_for_dispatch ... ok
[INFO] [stdout] test a_panicking_step_emits_node_failed ... ok
[INFO] [stdout] test a_failing_step_emits_node_failed ... ok
[INFO] [stdout] test a_handoff_emits_its_event ... ok
[INFO] [stdout] test a_handoff_runs_only_the_chosen_target ... ok
[INFO] [stdout] test a_panicking_step_is_contained_like_a_panicking_filter ... ok
[INFO] [stdout] test a_step_node_compiles_to_a_step_plan ... ok
[INFO] [stdout] test a_step_edge_is_schema_checked_like_any_other ... ok
[INFO] [stdout] test a_step_can_decide_a_branch_by_handing_off ... ok
[INFO] [stdout] test a_step_without_a_library_explains_itself ... ok
[INFO] [stdout] test an_undeclared_handoff_target_is_reported ... ok
[INFO] [stdout] test handoff_targets_are_compiled_exactly_once ... ok
[INFO] [stdout] test a_step_runs_inside_a_loop ... ok
[INFO] [stdout] test a_step_and_a_filter_start_with_their_own_kind ... ok
[INFO] [stdout] test a_filter_cache_key_ignores_its_agentic_neighbours ... ok
[INFO] [stdout] test a_suspended_run_halts_the_plan_and_then_resumes ... ok
[INFO] [stdout] test a_step_emits_agent_events ... ok
[INFO] [stdout] test a_suspension_emits_suspended_and_resuming_emits_resumed ... ok
[INFO] [stdout] test a_step_reads_from_and_writes_to_its_neighbours ... ok
[INFO] [stdout] test re_running_the_same_run_replays_instead_of_calling ... ok
[INFO] [stdout] test the_output_cache_never_touches_a_step ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/coverage_boost.rs (/opt/rustwide/target/debug/deps/coverage_boost-cf013cac43e9e941)
[INFO] [stdout] 
[INFO] [stdout] running 22 tests
[INFO] [stdout] test executor_branch_falls_back_to_default_arm ... ok
[INFO] [stdout] test executor_branch_selects_arm ... ok
[INFO] [stdout] test executor_branch_rejects_unmatched_selector ... ok
[INFO] [stdout] test executor_branch_rejects_unreadable_condition ... ok
[INFO] [stdout] test executor_loop_carry_feeds_each_iteration_the_last_output ... ok
[INFO] [stdout] test executor_loop_exhaust_runs_full_count ... ok
[INFO] [stdout] test executor_loop_rejects_unreadable_signal ... ok
[INFO] [stdout] test executor_loop_terminates_on_done ... ok
[INFO] [stdout] test executor_remote_falls_back_to_local ... ok
[INFO] [stdout] test session_compile_all_modes ... ok
[INFO] [stdout] test executor_remote_with_transport ... ok
[INFO] [stdout] test session_forward_after_fit ... ok
[INFO] [stdout] test executor_spills_large_values_to_datastore ... ok
[INFO] [stdout] test graph_fit_free_function_trainable ... ok
[INFO] [stdout] test graph_predict_free_function ... ok
[INFO] [stdout] test graph_run_free_function ... ok
[INFO] [stdout] test session_graph_and_library_accessors ... ok
[INFO] [stdout] test session_persist_without_datastore_errors ... ok
[INFO] [stdout] test session_persist_and_load_states ... ok
[INFO] [stdout] test session_run_returns_all_outputs ... ok
[INFO] [stdout] test session_with_data_store ... ok
[INFO] [stdout] test session_with_transport ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/fit_determinism.rs (/opt/rustwide/target/debug/deps/fit_determinism-9bddf6bbcfd2b0ea)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test fit_answers_with_the_last_node_not_an_arbitrary_one ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stderr]      Running tests/fit_through_run_node.rs (/opt/rustwide/target/debug/deps/fit_through_run_node-63e7a60431d28b94)
[INFO] [stdout] test a_branch_fits_only_the_arm_that_runs ... ok
[INFO] [stdout] test fit_and_forward_agree_on_every_node_output ... ok
[INFO] [stdout] test both_branches_of_a_fan_out_are_fitted_from_their_own_predecessor ... ok
[INFO] [stdout] test a_fit_reports_cache_activity_like_a_run ... ok
[INFO] [stderr]      Running tests/integration.rs (/opt/rustwide/target/debug/deps/integration-a87d7dee8398a3e5)
[INFO] [stdout] test a_graph_containing_a_step_can_be_fitted ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test cache_invalidation_on_config_change ... ok
[INFO] [stdout] test compile_then_execute_with_cache ... ok
[INFO] [stdout] test cache_invalidation_on_data_change ... ok
[INFO] [stdout] test study_continues_after_failed_trials ... ok
[INFO] [stdout] test full_workflow_fit_forward_cache_rerun ... ok
[INFO] [stdout] test graph_single_filter ... ok
[INFO] [stdout] test graph_single_sample ... ok
[INFO] [stdout] test graph_fit_error_propagates ... ok
[INFO] [stdout] test study_with_graph_integration ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/memory_usage.rs (/opt/rustwide/target/debug/deps/memory_usage-d23d183d7f025c02)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test stream_peak_memory_bounded ... ok
[INFO] [stdout] test stream_memory_does_not_grow_with_chunks ... ok
[INFO] [stdout] test repeated_forward_memory_does_not_grow ... ok
[INFO] [stdout] test pipeline_fit_then_repeated_forward_stable ... ok
[INFO] [stdout] test value_clone_is_cheap ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.27s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/pbt_integration.rs (/opt/rustwide/target/debug/deps/pbt_integration-8ec5d420eb073d47)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test graph_session_fit_forward_roundtrip ... ok
[INFO] [stdout] test pbt_emits_generation_events ... ok
[INFO] [stdout] test graph_session_subscribe_events ... ok
[INFO] [stdout] test pbt_with_graph_session_converges ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/session_steps.rs (/opt/rustwide/target/debug/deps/session_steps-5792e3fe593be8e2)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test graph_session_without_a_driver_names_the_fix ... ok
[INFO] [stdout] test graph_session_fit_drives_steps ... ok
[INFO] [stdout] test graph_session_run_drives_steps ... ok
[INFO] [stderr]      Running tests/topology.rs (/opt/rustwide/target/debug/deps/topology-580f1d85245f0236)
[INFO] [stdout] test graph_session_runs_a_mixed_graph ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test a_diamond_reaches_both_branches ... ok
[INFO] [stderr]      Running tests/tracking.rs (/opt/rustwide/target/debug/deps/tracking-37c4e9919215b0cc)
[INFO] [stdout] test a_fan_in_is_fitted_on_both_branches ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 30 tests
[INFO] [stdout] test graph_fit_events_reach_the_run_dir ... ok
[INFO] [stdout] test heartbeat_updates_status ... ok
[INFO] [stdout] test open_resumes_sequence_and_status ... ok
[INFO] [stdout] test collect_git_info_inside_and_outside_a_repo ... FAILED
[INFO] [stdout] test heartbeat_on_finalized_run_keeps_terminal_state ... ok
[INFO] [stdout] test open_repairs_torn_trailing_line ... ok
[INFO] [stdout] test a_resumed_completion_supersedes_the_suspension_cost ... ok
[INFO] [stdout] test open_without_events_file_starts_at_zero ... ok
[INFO] [stdout] test open_with_corrupt_manifest_errors_without_side_effects ... ok
[INFO] [stdout] test local_tracker_creates_valid_run_dir ... ok
[INFO] [stdout] test run_reader_aggregates_a_tracked_run ... ok
[INFO] [stdout] test run_reader_aggregates_agent_events ... ok
[INFO] [stdout] test run_reader_skips_torn_and_unknown_lines ... ok
[INFO] [stdout] test save_artifact_overwrites_and_roundtrips_binary ... ok
[INFO] [stdout] test run_reader_to_mermaid_without_graph_snapshot_errors ... ok
[INFO] [stdout] test run_reader_overlay_and_annotated_mermaid ... ok
[INFO] [stdout] test sink_flush_cadence_makes_lines_durable_without_manual_flush ... ok
[INFO] [stdout] test sink_append_continues_without_truncating_and_create_truncates ... ok
[INFO] [stdout] test sink_flushes_on_drop ... ok
[INFO] [stdout] test sink_metric_tee_lines_are_typed_and_complete ... ok
[INFO] [stdout] test sink_records_all_events_in_envelope ... ok
[INFO] [stdout] test sink_swallows_io_errors_without_panicking ... ok
[INFO] [stdout] test save_artifact_creates_parent_dirs ... ok
[INFO] [stdout] test sink_tees_metrics ... ok
[INFO] [stdout] test sink_is_lossless_under_concurrent_emit ... ok
[INFO] [stdout] test save_study_is_atomic_and_readable ... ok
[INFO] [stdout] test session_fit_and_run_emit_matching_run_bracket ... ok
[INFO] [stdout] test save_manifest_roundtrips_updates ... ok
[INFO] [stdout] test run_id_prefixes_and_study_path_by_kind ... ok
[INFO] [stderr] error: test failed, to rerun pass `--test tracking`
[INFO] [stdout] test list_runs_orders_and_detects_crashes ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- collect_git_info_inside_and_outside_a_repo stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'collect_git_info_inside_and_outside_a_repo' (1852) panicked at tests/tracking.rs:534:26:
[INFO] [stdout] sha inside a repo
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x62824da40471 - std[70759c8f55707aa4]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x62824da40471 - std[70759c8f55707aa4]::backtrace_rs::backtrace::trace_unsynchronized::<std[70759c8f55707aa4]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x62824da40471 - std[70759c8f55707aa4]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x62824da40471 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x62824da56f4a - <core[df12db4294e9bfd3]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x62824da56f4a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    6:     0x62824da44cbc - core[df12db4294e9bfd3]::io::write::default_write_fmt::<alloc[2182bb758b4b3781]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x62824da44cbc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x62824da19e76 - <std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x62824da19e76 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x62824da373d9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x62824d5271d0 - <alloc[2182bb758b4b3781]::boxed::Box<dyn for<'a, 'b> core[df12db4294e9bfd3]::ops::function::Fn<(&'a std[70759c8f55707aa4]::panic::PanicHookInfo<'b>,), Output = ()> + core[df12db4294e9bfd3]::marker::Send + core[df12db4294e9bfd3]::marker::Sync> as core[df12db4294e9bfd3]::ops::function::Fn<(&std[70759c8f55707aa4]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/alloc/src/boxed.rs:2334:9
[INFO] [stdout]   12:     0x62824d5271d0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x62824da37702 - <alloc[2182bb758b4b3781]::boxed::Box<dyn for<'a, 'b> core[df12db4294e9bfd3]::ops::function::Fn<(&'a std[70759c8f55707aa4]::panic::PanicHookInfo<'b>,), Output = ()> + core[df12db4294e9bfd3]::marker::Send + core[df12db4294e9bfd3]::marker::Sync> as core[df12db4294e9bfd3]::ops::function::Fn<(&std[70759c8f55707aa4]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/alloc/src/boxed.rs:2334:9
[INFO] [stdout]   14:     0x62824da37702 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:823:13
[INFO] [stdout]   15:     0x62824da19f22 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:688:13
[INFO] [stdout]   16:     0x62824da128f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x62824da1ac0d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:679:5
[INFO] [stdout]   18:     0x62824da5776c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x62824da57444 - core[df12db4294e9bfd3]::panicking::panic_display::<&str>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/panicking.rs:259:5
[INFO] [stdout]   20:     0x62824da57444 - core[df12db4294e9bfd3]::option::expect_failed
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/option.rs:2257:5
[INFO] [stdout]   21:     0x62824d92b1c2 - <core[df12db4294e9bfd3]::option::Option<alloc[2182bb758b4b3781]::string::String>>::expect
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/option.rs:969:21
[INFO] [stdout]   22:     0x62824d4de8ef - tracking[b9c3d1f26bd5c07]::collect_git_info_inside_and_outside_a_repo
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/tracking.rs:534:26
[INFO] [stdout]   23:     0x62824d4c7ea7 - tracking[b9c3d1f26bd5c07]::collect_git_info_inside_and_outside_a_repo::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/tracking.rs:529:48
[INFO] [stdout]   24:     0x62824d4fc096 - <tracking[b9c3d1f26bd5c07]::collect_git_info_inside_and_outside_a_repo::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x62824d51a4bb - <fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String> as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x62824d51a4bb - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:733:18
[INFO] [stdout]   27:     0x62824d527b25 - test[9d35eded1c95d3be]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:756:74
[INFO] [stdout]   28:     0x62824d527b25 - <core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<test[9d35eded1c95d3be]::run_test_in_process::{closure#0}> as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x62824d527b25 - std[70759c8f55707aa4]::panicking::catch_unwind::do_call::<core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<test[9d35eded1c95d3be]::run_test_in_process::{closure#0}>, core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:576:43
[INFO] [stdout]   30:     0x62824d527b25 - std[70759c8f55707aa4]::panicking::catch_unwind::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<test[9d35eded1c95d3be]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x62824d527b25 - std[70759c8f55707aa4]::panic::catch_unwind::<core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<test[9d35eded1c95d3be]::run_test_in_process::{closure#0}>, core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x62824d527b25 - test[9d35eded1c95d3be]::run_test_in_process
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:756:27
[INFO] [stdout]   33:     0x62824d527b25 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:677:43
[INFO] [stdout]   34:     0x62824d5213e4 - test[9d35eded1c95d3be]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:707:41
[INFO] [stdout]   35:     0x62824d5213e4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x62824d52ac82 - std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   37:     0x62824d52ac82 - <core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x62824d52ac82 - std[70759c8f55707aa4]::panicking::catch_unwind::do_call::<core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:576:43
[INFO] [stdout]   39:     0x62824d52ac82 - std[70759c8f55707aa4]::panicking::catch_unwind::<(), core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x62824d52ac82 - std[70759c8f55707aa4]::panic::catch_unwind::<core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x62824d52ac82 - std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   42:     0x62824d52ac82 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x62824da3f489 - <alloc[2182bb758b4b3781]::boxed::Box<dyn core[df12db4294e9bfd3]::ops::function::FnOnce<(), Output = ()> + core[df12db4294e9bfd3]::marker::Send> as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/alloc/src/boxed.rs:2320:9
[INFO] [stdout]   44:     0x62824da3f489 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/thread/unix.rs:123:17
[INFO] [stdout]   45:     0x71fa1e9a9dfa - <unknown>
[INFO] [stdout]   46:     0x71fa1ea3d3d4 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     collect_git_info_inside_and_outside_a_repo
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 29 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.16s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "67789ba05992592eb273433a399b142cc69143dae667e8f851521f7086f23917", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "67789ba05992592eb273433a399b142cc69143dae667e8f851521f7086f23917", kill_on_drop: false }`
[INFO] [stdout] 67789ba05992592eb273433a399b142cc69143dae667e8f851521f7086f23917
