[INFO] fetching crate tokmd-analysis-explain 1.9.0...
[INFO] testing tokmd-analysis-explain-1.9.0 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-2
[INFO] extracting crate tokmd-analysis-explain 1.9.0 into /workspace/builds/worker-1-tc1/source
[INFO] started tweaking crates.io crate tokmd-analysis-explain 1.9.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate tokmd-analysis-explain 1.9.0
[INFO] tweaked toml for crates.io crate tokmd-analysis-explain 1.9.0 written to /workspace/builds/worker-1-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate tokmd-analysis-explain 1.9.0 on toolchain 562dee4820c458d823175268e41601d4c060588a
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate tokmd-analysis-explain 1.9.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" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] bfb8aa2fd2f49b99d9aa0441f7847094509659e309cefffd4ee0b1e3a185cacc
[INFO] running `Command { std: "docker" "start" "-a" "bfb8aa2fd2f49b99d9aa0441f7847094509659e309cefffd4ee0b1e3a185cacc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "bfb8aa2fd2f49b99d9aa0441f7847094509659e309cefffd4ee0b1e3a185cacc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bfb8aa2fd2f49b99d9aa0441f7847094509659e309cefffd4ee0b1e3a185cacc", kill_on_drop: false }`
[INFO] [stdout] bfb8aa2fd2f49b99d9aa0441f7847094509659e309cefffd4ee0b1e3a185cacc
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] bb32ae1f95299e6d827126b065ce38d573fa9ec107e9343efd4486543c664710
[INFO] running `Command { std: "docker" "start" "-a" "bb32ae1f95299e6d827126b065ce38d573fa9ec107e9343efd4486543c664710", kill_on_drop: false }`
[INFO] [stderr]    Compiling tokmd-analysis-explain v1.9.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.36s
[INFO] running `Command { std: "docker" "inspect" "bb32ae1f95299e6d827126b065ce38d573fa9ec107e9343efd4486543c664710", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bb32ae1f95299e6d827126b065ce38d573fa9ec107e9343efd4486543c664710", kill_on_drop: false }`
[INFO] [stdout] bb32ae1f95299e6d827126b065ce38d573fa9ec107e9343efd4486543c664710
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8bb9f10aa358cf996200bd5418f3baa813a94edaf61bde6e0cea59d2f6cb0ac6
[INFO] running `Command { std: "docker" "start" "-a" "8bb9f10aa358cf996200bd5418f3baa813a94edaf61bde6e0cea59d2f6cb0ac6", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.183
[INFO] [stderr]    Compiling zerocopy v0.8.47
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling console v0.15.11
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling insta v1.46.3
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling proptest v1.10.0
[INFO] [stderr]    Compiling tokmd-analysis-explain v1.9.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 16.63s
[INFO] running `Command { std: "docker" "inspect" "8bb9f10aa358cf996200bd5418f3baa813a94edaf61bde6e0cea59d2f6cb0ac6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8bb9f10aa358cf996200bd5418f3baa813a94edaf61bde6e0cea59d2f6cb0ac6", kill_on_drop: false }`
[INFO] [stdout] 8bb9f10aa358cf996200bd5418f3baa813a94edaf61bde6e0cea59d2f6cb0ac6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3e71ef26e78a6cbb8533125ad2ca9e90121de5433412509ad61065d21eaaf6c0
[INFO] running `Command { std: "docker" "start" "-a" "3e71ef26e78a6cbb8533125ad2ca9e90121de5433412509ad61065d21eaaf6c0", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tokmd_analysis_explain-56dc43962144fe97)
[INFO] [stdout] running 3 tests
[INFO] [stderr]      Running tests/bdd.rs (/opt/rustwide/target/debug/deps/bdd-2b47219653baf32c)
[INFO] [stdout] test tests::catalog_is_sorted_and_unique ... ok
[INFO] [stdout] test tests::lookup_finds_alias_with_normalization ... ok
[INFO] [stdout] test tests::lookup_finds_canonical_key ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 17 tests
[INFO] [stdout] test given_alias_lookup_when_resolved_then_uses_canonical_prefix ... ok
[INFO] [stdout] test given_catalog_when_called_then_contains_all_canonical_keys ... ok
[INFO] [stdout] test given_dotted_key_when_lookup_then_normalizes_and_resolves ... ok
[INFO] [stdout] test given_catalog_when_called_then_no_duplicate_keys ... ok
[INFO] [stdout] test given_leading_trailing_whitespace_when_lookup_then_trims_and_resolves ... ok
[INFO] [stdout] test given_canonical_key_when_lookup_then_returns_explanation ... ok
[INFO] [stdout] test given_catalog_when_called_then_keys_are_sorted ... ok
[INFO] [stdout] test given_catalog_when_called_then_contains_header ... ok
[INFO] [stdout] test given_every_canonical_key_when_lookup_then_all_resolve ... ok
[INFO] [stdout] test given_mixed_separators_when_lookup_then_normalizes_and_resolves ... ok
[INFO] [stdout] test given_alias_when_lookup_then_returns_canonical_explanation ... ok
[INFO] [stdout] test given_hyphenated_key_when_lookup_then_normalizes_and_resolves ... ok
[INFO] [stdout] test given_catalog_when_called_then_does_not_list_aliases ... ok
[INFO] [stdout] test given_spaced_key_when_lookup_then_normalizes_and_resolves ... ok
[INFO] [stdout] test given_uppercase_key_when_lookup_then_normalizes_and_resolves ... ok
[INFO] [stdout] test given_unknown_key_when_lookup_then_returns_none ... ok
[INFO] [stderr]      Running tests/deep_v3.rs (/opt/rustwide/target/debug/deps/deep_v3-e1e135d878e781bc)
[INFO] [stdout] test given_any_lookup_when_resolved_then_format_is_canonical_colon_space_summary ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 24 tests
[INFO] [stdout] test catalog_header_is_exactly_one_line ... ok
[INFO] [stdout] test catalog_is_idempotent ... ok
[INFO] [stdout] test catalog_no_empty_lines ... ok
[INFO] [stdout] test catalog_line_count_matches_entry_count ... ok
[INFO] [stdout] test lookup_all_code_age_aliases_match ... ok
[INFO] [stdout] test lookup_doc_density_mentions_ratio ... ok
[INFO] [stdout] test lookup_normalizes_mixed_case_alias ... ok
[INFO] [stdout] test lookup_all_context_window_fit_aliases_match ... ok
[INFO] [stdout] test lookup_newline_in_key_does_not_resolve ... ok
[INFO] [stdout] test lookup_cocomo_related_key_is_absent ... ok
[INFO] [stdout] test lookup_gini_mentions_inequality ... ok
[INFO] [stdout] test lookup_normalizes_multiple_consecutive_separators ... ok
[INFO] [stdout] test lookup_all_doc_density_aliases_match_canonical ... ok
[INFO] [stdout] test lookup_verbosity_mentions_bytes ... ok
[INFO] [stdout] test lookup_summaries_end_with_period ... ok
[INFO] [stdout] test lookup_hotspots_mentions_change_frequency ... ok
[INFO] [stdout] test lookup_output_never_has_trailing_newline ... ok
[INFO] [stdout] test lookup_single_char_keys_do_not_resolve ... ok
[INFO] [stdout] test lookup_tab_separated_key_normalizes ... ok
[INFO] [stdout] test lookup_output_contains_exactly_one_colon_space_separator ... ok
[INFO] [stdout] test lookup_unicode_key_does_not_resolve ... ok
[INFO] [stdout] test every_lookupable_canonical_key_appears_in_catalog ... ok
[INFO] [stdout] test lookup_very_long_key_returns_none ... ok
[INFO] [stdout] test catalog_every_key_is_resolvable_via_lookup ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/deep_w66.rs (/opt/rustwide/target/debug/deps/deep_w66-122c06e09ae82366)
[INFO] [stdout] 
[INFO] [stdout] running 27 tests
[INFO] [stdout] test aliases_w66::docs_alias ... ok
[INFO] [stdout] test aliases_w66::documentation_density_alias ... ok
[INFO] [stdout] test aliases_w66::churn_alias_for_predictive_churn ... ok
[INFO] [stdout] test aliases_w66::bytes_per_line_alias_for_verbosity ... ok
[INFO] [stdout] test aliases_w66::mi_alias_for_maintainability_index ... ok
[INFO] [stdout] test canonical_keys_w66::lookup_returns_canonical_name_first ... ok
[INFO] [stdout] test aliases_w66::dup_alias_for_duplicate_waste ... ok
[INFO] [stdout] test canonical_keys_w66::all_known_canonical_keys_resolve ... ok
[INFO] [stdout] test canonical_keys_w66::lookup_result_contains_summary_text ... ok
[INFO] [stdout] test catalog_w66::catalog_has_no_duplicates ... ok
[INFO] [stdout] test catalog_w66::catalog_keys_are_sorted ... ok
[INFO] [stdout] test catalog_w66::catalog_starts_with_header ... ok
[INFO] [stdout] test missing_data_w66::numeric_key_returns_none ... ok
[INFO] [stdout] test missing_data_w66::nonexistent_key_returns_none ... ok
[INFO] [stdout] test catalog_w66::catalog_is_deterministic ... ok
[INFO] [stdout] test aliases_w66::entropy_alias_for_entropy_suspects ... ok
[INFO] [stdout] test catalog_w66::catalog_keys_use_dash_prefix ... ok
[INFO] [stdout] test missing_data_w66::special_chars_key_returns_none ... ok
[INFO] [stdout] test normalization_w66::mixed_case_normalized ... ok
[INFO] [stdout] test normalization_w66::dash_replaced_by_underscore ... ok
[INFO] [stdout] test normalization_w66::dot_replaced_by_underscore ... ok
[INFO] [stdout] test normalization_w66::leading_trailing_whitespace_trimmed ... ok
[INFO] [stdout] test normalization_w66::whitespace_only_returns_none ... ok
[INFO] [stdout] test normalization_w66::space_replaced_by_underscore ... ok
[INFO] [stdout] test normalization_w66::empty_string_returns_none ... ok
[INFO] [stdout] test missing_data_w66::very_long_key_returns_none ... ok
[INFO] [stdout] test catalog_w66::catalog_every_key_resolvable ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/deep_w69.rs (/opt/rustwide/target/debug/deps/deep_w69-c4e637875c6cc9d6)
[INFO] [stdout] 
[INFO] [stdout] running 25 tests
[INFO] [stdout] test catalog_contains_known_keys ... ok
[INFO] [stdout] test catalog_has_no_duplicates ... ok
[INFO] [stdout] test catalog_is_deterministic ... ok
[INFO] [stdout] test catalog_starts_with_header ... ok
[INFO] [stdout] test catalog_is_sorted ... ok
[INFO] [stdout] test lookup_alias_docs ... ok
[INFO] [stdout] test lookup_alias_churn ... ok
[INFO] [stdout] test lookup_alias_todo ... ok
[INFO] [stdout] test lookup_bus_factor ... ok
[INFO] [stdout] test lookup_doc_density ... ok
[INFO] [stdout] test lookup_gini ... ok
[INFO] [stdout] test lookup_hotspots ... ok
[INFO] [stdout] test lookup_coupling ... ok
[INFO] [stdout] test lookup_normalizes_dashes ... ok
[INFO] [stdout] test lookup_normalizes_dots ... ok
[INFO] [stdout] test lookup_normalizes_leading_trailing_whitespace ... ok
[INFO] [stdout] test lookup_imports ... ok
[INFO] [stdout] test lookup_normalizes_spaces ... ok
[INFO] [stdout] test lookup_test_density ... ok
[INFO] [stdout] test lookup_normalizes_case ... ok
[INFO] [stdout] test lookup_todo_density ... ok
[INFO] [stdout] test lookup_unknown_key_returns_none ... ok
[INFO] [stdout] test lookup_empty_string_returns_none ... ok
[INFO] [stdout] test lookup_verbosity ... ok
[INFO] [stdout] test lookup_whitespace_ratio ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/edge_cases.rs (/opt/rustwide/target/debug/deps/edge_cases-dc2890bd974ac1e2)
[INFO] [stdout] 
[INFO] [stdout] running 25 tests
[INFO] [stdout] test catalog_does_not_contain_alias_names ... ok
[INFO] [stdout] test catalog_ends_with_newline ... ok
[INFO] [stdout] test canonical_keys_without_aliases_still_resolve ... ok
[INFO] [stdout] test all_summaries_end_with_period ... ok
[INFO] [stdout] test lookup_empty_string_returns_none ... ok
[INFO] [stdout] test lookup_canonical_with_appended_chars_returns_none ... ok
[INFO] [stdout] test lookup_long_valid_key_padded_returns_none ... ok
[INFO] [stdout] test lookup_purely_numeric_returns_none ... ok
[INFO] [stdout] test lookup_canonical_with_prepended_chars_returns_none ... ok
[INFO] [stdout] test lookup_with_carriage_return_returns_none ... ok
[INFO] [stdout] test lookup_with_cjk_characters_returns_none ... ok
[INFO] [stdout] test lookup_various_whitespace_only_returns_none ... ok
[INFO] [stdout] test lookup_prefix_of_canonical_key_returns_none ... ok
[INFO] [stdout] test lookup_with_emoji_returns_none ... ok
[INFO] [stdout] test catalog_line_format_is_consistent ... ok
[INFO] [stdout] test lookup_with_null_byte_returns_none ... ok
[INFO] [stdout] test lookup_with_accented_chars_returns_none ... ok
[INFO] [stdout] test lookup_with_form_feed_returns_none ... ok
[INFO] [stdout] test lookup_with_path_separators_returns_none ... ok
[INFO] [stdout] test lookup_with_special_regex_chars_returns_none ... ok
[INFO] [stdout] test lookup_with_vertical_tab_returns_none ... ok
[INFO] [stdout] test lookup_suffix_of_canonical_key_returns_none ... ok
[INFO] [stdout] test all_summaries_are_single_sentence ... ok
[INFO] [stdout] test no_alias_resolves_to_different_canonical_keys ... ok
[INFO] [stdout] test lookup_extremely_long_input_returns_none ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/explain_depth_w55.rs (/opt/rustwide/target/debug/deps/explain_depth_w55-8c923896efb2466d)
[INFO] [stdout] 
[INFO] [stdout] running 33 tests
[INFO] [stdout] test catalog_contains_no_blank_lines ... ok
[INFO] [stdout] test catalog_does_not_contain_duplicates ... ok
[INFO] [stdout] test all_catalog_keys_round_trip_through_lookup ... ok
[INFO] [stdout] test catalog_ends_with_trailing_newline ... ok
[INFO] [stdout] test catalog_keys_are_strictly_alphabetical ... ok
[INFO] [stdout] test lookup_archetype_mentions_repository_type ... ok
[INFO] [stdout] test lookup_bus_factor_mentions_author ... ok
[INFO] [stdout] test lookup_context_window_fit_mentions_token ... ok
[INFO] [stdout] test lookup_case_insensitive_for_all_canonical_keys ... ok
[INFO] [stdout] test lookup_coupling_mentions_modules_or_commits ... ok
[INFO] [stdout] test lookup_duplicate_waste_mentions_redundant ... ok
[INFO] [stdout] test lookup_entropy_suspects_mentions_entropy ... ok
[INFO] [stdout] test lookup_freshness_mentions_recency_or_stale ... ok
[INFO] [stdout] test catalog_is_deterministic_across_100_calls ... ok
[INFO] [stdout] test lookup_imports_mentions_dependency ... ok
[INFO] [stdout] test lookup_dot_hyphen_space_all_normalize_identically ... ok
[INFO] [stdout] test lookup_maintainability_index_mentions_maintainability ... ok
[INFO] [stdout] test lookup_mixed_separator_chains_resolve ... ok
[INFO] [stdout] test lookup_output_is_ascii_for_all_canonical_keys ... ok
[INFO] [stdout] test lookup_license_radar_mentions_spdx_or_license ... ok
[INFO] [stdout] test alias_lookup_always_returns_canonical_key_prefix ... ok
[INFO] [stdout] test lookup_polyglot_entropy_mentions_language ... ok
[INFO] [stdout] test lookup_predictive_churn_mentions_velocity ... ok
[INFO] [stdout] test lookup_technical_debt_ratio_mentions_debt ... ok
[INFO] [stdout] test lookup_test_density_mentions_test_files ... ok
[INFO] [stdout] test lookup_todo_density_mentions_markers ... ok
[INFO] [stdout] test lookup_triple_word_keys_normalize_across_separators ... ok
[INFO] [stdout] test lookup_whitespace_ratio_mentions_blank ... ok
[INFO] [stdout] test lookup_with_leading_and_trailing_spaces_resolves ... ok
[INFO] [stdout] test lookup_summary_length_is_reasonable_for_every_key ... ok
[INFO] [stdout] test lookup_with_interior_tab_does_not_resolve ... ok
[INFO] [stdout] test lookup_output_starts_with_canonical_key_for_all_entries ... ok
[INFO] [stdout] test catalog_every_line_after_header_starts_with_dash_space ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running tests/explain_depth_w57.rs (/opt/rustwide/target/debug/deps/explain_depth_w57-7a0ec52ce8420fa3)
[INFO] [stdout] test result: ok. 33 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 22 tests
[INFO] [stdout] test catalog_ends_with_newline ... ok
[INFO] [stdout] test catalog_is_deterministic ... ok
[INFO] [stdout] test catalog_has_no_duplicate_entries ... ok
[INFO] [stdout] test catalog_starts_with_header_line ... ok
[INFO] [stdout] test catalog_is_sorted_ascending ... ok
[INFO] [stdout] test lookup_empty_string_returns_none ... ok
[INFO] [stdout] test lookup_multiple_aliases_for_same_key ... ok
[INFO] [stdout] test lookup_churn_alias_resolves_to_predictive_churn ... ok
[INFO] [stdout] test lookup_leading_trailing_whitespace_trimmed ... ok
[INFO] [stdout] test lookup_dot_separator ... ok
[INFO] [stdout] test lookup_result_contains_nonempty_description ... ok
[INFO] [stdout] test lookup_returns_canonical_key_as_prefix ... ok
[INFO] [stdout] test lookup_space_separator ... ok
[INFO] [stdout] test lookup_uppercase_key ... ok
[INFO] [stdout] test lookup_unknown_key_returns_none ... ok
[INFO] [stdout] test lookup_whitespace_only_returns_none ... ok
[INFO] [stdout] test lookup_hyphen_separator ... ok
[INFO] [stdout] test lookup_mixed_case_key ... ok
[INFO] [stdout] test lookup_mi_alias_resolves_to_maintainability_index ... ok
[INFO] [stdout] test lookup_alias_resolves_to_canonical ... ok
[INFO] [stdout] test lookup_all_canonical_keys_resolve ... ok
[INFO] [stdout] test catalog_has_at_least_25_entries ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/explain_depth_w60.rs (/opt/rustwide/target/debug/deps/explain_depth_w60-247cd73e5d23c2a8)
[INFO] [stdout] 
[INFO] [stdout] running 50 tests
[INFO] [stdout] test catalog_header_line_is_not_a_key_line ... ok
[INFO] [stdout] test all_summaries_are_non_trivially_long ... ok
[INFO] [stdout] test catalog_key_count_is_exactly_28 ... ok
[INFO] [stdout] test catalog_key_set_matches_lookup_resolvable_canonical_keys ... ok
[INFO] [stdout] test catalog_keys_are_all_lowercase_with_underscores ... ok
[INFO] [stdout] test all_summaries_are_pure_ascii ... ok
[INFO] [stdout] test catalog_keys_do_not_contain_consecutive_underscores ... ok
[INFO] [stdout] test all_summaries_are_single_line ... ok
[INFO] [stdout] test catalog_keys_do_not_start_or_end_with_underscore ... ok
[INFO] [stdout] test complexity_family_summaries_mention_complexity ... ok
[INFO] [stdout] test duplication_family_summaries_mention_duplicate_or_redundant ... ok
[INFO] [stdout] test given_catalog_when_parsed_then_no_lines_have_trailing_whitespace ... ok
[INFO] [stdout] test given_key_in_cyrillic_when_looked_up_then_returns_none ... ok
[INFO] [stdout] test given_duplication_density_alias_when_looked_up_then_matches_canonical ... ok
[INFO] [stdout] test given_duplication_aliases_when_looked_up_then_all_match_canonical ... ok
[INFO] [stdout] test given_key_with_backslash_when_looked_up_then_returns_none ... ok
[INFO] [stdout] test given_key_with_doubled_underscore_when_looked_up_then_returns_none ... ok
[INFO] [stdout] test git_family_summaries_mention_relevant_concepts ... ok
[INFO] [stdout] test given_every_canonical_key_when_looked_up_then_format_is_key_colon_space_summary ... ok
[INFO] [stdout] test given_key_with_embedded_newline_returns_none ... ok
[INFO] [stdout] test given_key_with_numeric_suffix_when_looked_up_then_returns_none ... ok
[INFO] [stdout] test given_complexity_histogram_alias_when_looked_up_then_matches_canonical ... ok
[INFO] [stdout] test given_key_with_zero_width_space_when_looked_up_then_returns_none ... ok
[INFO] [stdout] test given_halstead_aliases_when_looked_up_then_all_match_canonical ... ok
[INFO] [stdout] test given_key_with_newline_when_looked_up_then_returns_none ... ok
[INFO] [stdout] test given_key_with_trailing_separator_when_looked_up_then_returns_none ... ok
[INFO] [stdout] test given_key_with_null_byte_when_looked_up_then_returns_none ... ok
[INFO] [stdout] test given_key_with_emoji_prefix_or_suffix_when_looked_up_then_returns_none ... ok
[INFO] [stdout] test given_lookup_with_html_tags_then_returns_none ... ok
[INFO] [stdout] test given_three_word_key_with_mixed_seps_when_looked_up_then_all_resolve_identically ... ok
[INFO] [stdout] test every_catalog_key_round_trips_through_lookup_back_to_same_key ... ok
[INFO] [stdout] test given_every_alias_when_looked_up_then_output_starts_with_its_canonical ... ok
[INFO] [stdout] test given_lookup_with_sql_injection_like_input_then_returns_none ... ok
[INFO] [stdout] test given_partial_canonical_key_when_looked_up_then_returns_none ... ok
[INFO] [stdout] test given_two_word_key_with_mixed_seps_when_looked_up_then_all_resolve ... ok
[INFO] [stdout] test given_max_cyclomatic_has_no_aliases_when_looked_up_then_only_canonical_works ... ok
[INFO] [stdout] test lookup_with_all_separator_chars_repeated ... ok
[INFO] [stdout] test size_metric_summaries_mention_relevant_terms ... ok
[INFO] [stdout] test no_summary_exceeds_200_characters ... ok
[INFO] [stdout] test lookup_with_100k_char_input_returns_none_without_panic ... ok
[INFO] [stdout] test given_key_with_carriage_return_when_looked_up_then_returns_none ... ok
[INFO] [stdout] test catalog_called_1000_times_returns_identical_result ... ok
[INFO] [stdout] test catalog_never_changes_across_invocations ... ok
[INFO] [stdout] test lookup_with_random_case_resolves ... ok
[INFO] [stdout] test lookup_canonical_with_random_padding_resolves ... ok
[INFO] [stdout] test lookup_result_when_some_always_contains_colon_space ... ok
[INFO] [stdout] test lookup_unknown_prefix_returns_none ... ok
[INFO] [stdout] test lookup_never_panics_on_binary_like_input ... ok
[INFO] [stdout] test lookup_result_canonical_key_has_no_spaces ... ok
[INFO] [stdout] test lookup_is_deterministic_for_any_input ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 50 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.33s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/property.rs (/opt/rustwide/target/debug/deps/property-cb3df2f4bd9a77eb)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test lookup_canonical_with_padding_resolves ... ok
[INFO] [stdout] test lookup_result_always_has_colon_space_format ... ok
[INFO] [stdout] test lookup_resolves_canonical_with_random_case ... ok
[INFO] [stdout] test catalog_is_always_identical ... ok
[INFO] [stdout] test lookup_resolves_canonical_with_any_separator ... ok
[INFO] [stdout] test lookup_never_panics ... ok
[INFO] [stdout] test lookup_returns_none_for_pure_separators ... ok
[INFO] [stdout] test lookup_returns_none_for_numeric_strings ... ok
[INFO] [stdout] test lookup_never_panics_on_ascii ... ok
[INFO] [stdout] test lookup_never_panics_on_long_input ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.07s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/proptest_w56.rs (/opt/rustwide/target/debug/deps/proptest_w56-f6aa78026d032552)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test catalog_line_format_is_consistent ... ok
[INFO] [stdout] test catalog_is_valid_utf8_and_nonempty ... ok
[INFO] [stdout] test catalog_is_deterministic ... ok
[INFO] [stdout] test normalization_is_consistent ... ok
[INFO] [stdout] test unknown_keys_return_none ... ok
[INFO] [stdout] test lookup_is_deterministic ... ok
[INFO] [stdout] test canonical_keys_always_resolve ... ok
[INFO] [stdout] test lookup_never_panics ... ok
[INFO] [stdout] test lookup_output_is_valid_utf8 ... ok
[INFO] [stdout] test lookup_result_starts_with_canonical ... ok
[INFO] [stdout] test case_insensitive_lookup ... ok
[INFO] [stdout] test catalog_keys_all_resolve ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.86s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/snapshots.rs (/opt/rustwide/target/debug/deps/snapshots-5bd51c1ee5ef7546)
[INFO] [stdout] 
[INFO] [stdout] running 32 tests
[INFO] [stdout] test snapshot_alias_churn_matches_predictive_churn ... ok
[INFO] [stdout] test snapshot_alias_mi_matches_maintainability_index ... ok
[INFO] [stdout] test snapshot_lookup_avg_cognitive ... ok
[INFO] [stdout] test snapshot_lookup_code_age_distribution ... ok
[INFO] [stdout] test snapshot_lookup_archetype ... ok
[INFO] [stdout] test snapshot_lookup_complexity_histogram ... ok
[INFO] [stdout] test snapshot_lookup_bus_factor ... ok
[INFO] [stdout] test snapshot_lookup_avg_cyclomatic ... ok
[INFO] [stdout] test snapshot_lookup_doc_density ... ok
[INFO] [stdout] test snapshot_lookup_halstead ... ok
[INFO] [stdout] test snapshot_lookup_license_radar ... ok
[INFO] [stdout] test snapshot_lookup_hotspots ... ok
[INFO] [stdout] test snapshot_lookup_entropy_suspects ... ok
[INFO] [stdout] test snapshot_lookup_context_window_fit ... ok
[INFO] [stdout] test snapshot_lookup_duplicate_waste ... ok
[INFO] [stdout] test snapshot_lookup_duplication_density ... ok
[INFO] [stdout] test snapshot_lookup_gini ... ok
[INFO] [stdout] test snapshot_lookup_imports ... ok
[INFO] [stdout] test snapshot_lookup_coupling ... ok
[INFO] [stdout] test snapshot_lookup_freshness ... ok
[INFO] [stdout] test snapshot_lookup_test_density ... ok
[INFO] [stdout] test snapshot_lookup_whitespace_ratio ... ok
[INFO] [stdout] test snapshot_catalog_full ... ok
[INFO] [stdout] test snapshot_lookup_todo_density ... ok
[INFO] [stdout] test snapshot_lookup_maintainability_index ... ok
[INFO] [stdout] test snapshot_lookup_polyglot_entropy ... ok
[INFO] [stdout] test snapshot_lookup_max_nesting_depth ... ok
[INFO] [stdout] test snapshot_lookup_predictive_churn ... ok
[INFO] [stdout] test snapshot_lookup_verbosity ... ok
[INFO] [stdout] test snapshot_lookup_technical_debt_ratio ... ok
[INFO] [stdout] test snapshot_lookup_max_cyclomatic ... ok
[INFO] [stdout] test snapshot_alias_entropy_matches_entropy_suspects ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 32 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests tokmd_analysis_explain
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "3e71ef26e78a6cbb8533125ad2ca9e90121de5433412509ad61065d21eaaf6c0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3e71ef26e78a6cbb8533125ad2ca9e90121de5433412509ad61065d21eaaf6c0", kill_on_drop: false }`
[INFO] [stdout] 3e71ef26e78a6cbb8533125ad2ca9e90121de5433412509ad61065d21eaaf6c0