[INFO] cloning repository https://github.com/misttech/lens
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/misttech/lens" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmisttech%2Flens", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmisttech%2Flens'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 7e53404743384e0f723dfa043f5ff926226dd883
[INFO] testing misttech/lens against 1.99.0-beta.8 for beta-1.100-4
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmisttech%2Flens" "/workspace/builds/worker-3-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc1/source'...
[INFO] [stderr] done.
[INFO] removed /workspace/builds/worker-3-tc1/source/rust-toolchain.toml
[INFO] started tweaking git repo https://github.com/misttech/lens
[INFO] finished tweaking git repo https://github.com/misttech/lens
[INFO] tweaked toml for git repo https://github.com/misttech/lens written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/misttech/lens 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 git repo https://github.com/misttech/lens 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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 74a45eab72082edb8bddc55b5b07bbf243729807d58444ea63da05708c757bd9
[INFO] running `Command { std: "docker" "start" "74a45eab72082edb8bddc55b5b07bbf243729807d58444ea63da05708c757bd9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "74a45eab72082edb8bddc55b5b07bbf243729807d58444ea63da05708c757bd9", 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" "74a45eab72082edb8bddc55b5b07bbf243729807d58444ea63da05708c757bd9" "/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" "74a45eab72082edb8bddc55b5b07bbf243729807d58444ea63da05708c757bd9", 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" "74a45eab72082edb8bddc55b5b07bbf243729807d58444ea63da05708c757bd9" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling hashbrown v0.17.1
[INFO] [stderr]    Compiling winnow v0.7.15
[INFO] [stderr]    Compiling toml_write v0.1.2
[INFO] [stderr]    Compiling indexmap v2.14.0
[INFO] [stderr]    Compiling syn v3.0.3
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling toml_datetime v0.6.11
[INFO] [stderr]    Compiling serde_spanned v0.6.9
[INFO] [stderr]    Compiling toml_edit v0.22.27
[INFO] [stderr]    Compiling toml v0.8.23
[INFO] [stderr]    Compiling lens v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 15.75s
[INFO] running `Command { std: "docker" "inspect" "74a45eab72082edb8bddc55b5b07bbf243729807d58444ea63da05708c757bd9", 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" "74a45eab72082edb8bddc55b5b07bbf243729807d58444ea63da05708c757bd9" "/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 lens v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 6.31s
[INFO] running `Command { std: "docker" "inspect" "74a45eab72082edb8bddc55b5b07bbf243729807d58444ea63da05708c757bd9", 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" "74a45eab72082edb8bddc55b5b07bbf243729807d58444ea63da05708c757bd9" "/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.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/lens-c47fc732802771f2)
[INFO] [stdout] 
[INFO] [stdout] running 257 tests
[INFO] [stdout] test adapters::generic::tests::a_missing_final_newline_does_not_lose_the_last_line ... ok
[INFO] [stdout] test adapters::generic::tests::an_indented_stanza_stays_with_its_header ... ok
[INFO] [stdout] test adapters::generic::tests::blank_lines_separate_blocks ... ok
[INFO] [stdout] test adapters::generic::tests::consecutive_blank_lines_do_not_make_empty_blocks ... ok
[INFO] [stdout] test adapters::generic::tests::empty_input_is_an_empty_document ... ok
[INFO] [stdout] test adapters::generic::tests::a_flat_list_is_one_block ... ok
[INFO] [stdout] test adapters::generic::tests::a_numbered_gutter_line_is_not_a_new_block ... ok
[INFO] [stdout] test adapters::generic::tests::a_return_to_the_margin_starts_a_new_block ... ok
[INFO] [stdout] test adapters::generic::tests::origins_are_strictly_increasing ... ok
[INFO] [stdout] test adapters::generic::tests::line_numbers_are_one_based_and_count_blank_lines ... ok
[INFO] [stdout] test adapters::generic::tests::the_stream_is_recorded ... ok
[INFO] [stdout] test adapters::generic::tests::every_line_survives_parsing ... ok
[INFO] [stdout] test adapters::git::tests::a_commit_header_is_kind_header ... ok
[INFO] [stdout] test adapters::git::tests::prose_is_not_git_output ... ok
[INFO] [stdout] test cli::tests::a_budget_flag_before_the_command_is_ours ... ok
[INFO] [stdout] test cli::tests::bare_invocation_is_help ... ok
[INFO] [stdout] test adapters::git::tests::a_malformed_hunk_header_is_an_error ... ok
[INFO] [stdout] test adapters::git::tests::a_hunk_header_is_kept_verbatim ... ok
[INFO] [stdout] test cli::tests::subcommand_names_only_bind_in_first_position ... ok
[INFO] [stdout] test adapters::git::tests::porcelain_status_is_one_block_per_path ... ok
[INFO] [stdout] test adapters::git::tests::each_hunk_is_its_own_block ... ok
[INFO] [stdout] test cli::tests::a_lone_dash_names_a_command_not_a_flag ... ok
[INFO] [stdout] test adapters::git::tests::status_paths_are_diff_blocks ... ok
[INFO] [stdout] test adapters::git::tests::oneline_log_is_one_header_per_commit ... ok
[INFO] [stdout] test cli::tests::unknown_lens_flag_is_an_error_not_a_command ... ok
[INFO] [stdout] test cli::tests::first_non_flag_token_starts_the_child ... ok
[INFO] [stdout] test adapters::git::tests::origins_are_the_raw_line_numbers ... ok
[INFO] [stdout] test cli::tests::version_flag_is_recognized ... ok
[INFO] [stdout] test cli::tests::a_budget_flag_needs_a_number ... ok
[INFO] [stdout] test cli::tests::a_use_flag_before_a_subcommand_is_kept ... ok
[INFO] [stdout] test cli::tests::child_argv_is_never_empty_for_a_run ... ok
[INFO] [stdout] test cli::tests::child_flags_are_never_interpreted ... ok
[INFO] [stdout] test executor::tests::git_gets_no_pager_and_a_dumb_terminal ... ok
[INFO] [stdout] test cli::tests::every_subcommand_token_round_trips ... ok
[INFO] [stdout] test adapters::generic::tests::tabs_count_as_indentation ... ok
[INFO] [stdout] test executor::tests::lens_variables_are_removed_and_others_are_not ... ok
[INFO] [stdout] test config::tests::an_unknown_command_gets_the_default_lens ... ok
[INFO] [stdout] test config::tests::plot_and_the_runner_see_the_same_pipeline ... ok
[INFO] [stdout] test config::tests::use_forces_a_lens_that_would_not_match ... ok
[INFO] [stdout] test config::tests::a_flag_between_git_and_diff_does_not_hide_the_subcommand ... ok
[INFO] [stdout] test config::tests::use_of_an_unknown_lens_is_an_error ... ok
[INFO] [stdout] test config::tests::git_diff_is_more_specific_than_git ... ok
[INFO] [stdout] test cli::tests::a_use_flag_before_the_command_is_ours ... ok
[INFO] [stdout] test config::tests::git_status_selects_the_git_lens ... ok
[INFO] [stdout] test log::tests::a_corrupt_line_does_not_lose_the_rest ... ok
[INFO] [stdout] test adapters::git::tests::the_large_show_fixture_preserves_every_hunk_header ... ok
[INFO] [stdout] test log::tests::a_log_under_the_size_limit_is_not_rotated ... ok
[INFO] [stdout] test config::tests::later_layers_win_and_keep_their_provenance ... ok
[INFO] [stdout] test config::tests::extends_inherits_then_overrides ... ok
[INFO] [stdout] test executor::tests::binary_output_survives_capture_unchanged ... ok
[INFO] [stdout] test log::tests::a_run_record_round_trips_through_json ... ok
[INFO] [stdout] test log::tests::an_off_logger_writes_nothing_at_all ... ok
[INFO] [stdout] test log::tests::an_unwritable_directory_degrades_instead_of_failing ... ok
[INFO] [stdout] test log::tests::a_passthrough_run_carries_its_reason ... ok
[INFO] [stdout] test log::tests::levels_order_from_quiet_to_loud ... ok
[INFO] [stdout] test pipeline::ansi::tests::an_overwrite_leaves_the_uncovered_tail ... ok
[INFO] [stdout] test log::tests::aggregation_counts_runs_and_passthroughs ... ok
[INFO] [stdout] test pipeline::ansi::tests::an_unterminated_escape_does_not_leak ... ok
[INFO] [stdout] test log::tests::aggregation_respects_the_since_cutoff ... ok
[INFO] [stdout] test pipeline::ansi::tests::carriage_returns_keep_only_the_final_state ... ok
[INFO] [stdout] test log::tests::level_names_round_trip ... ok
[INFO] [stdout] test pipeline::ansi::tests::color_codes_are_removed ... ok
[INFO] [stdout] test log::tests::the_record_shape_is_the_documented_one ... ok
[INFO] [stdout] test log::tests::events_carry_their_fields ... ok
[INFO] [stdout] test log::tests::rotation_shifts_generations_and_drops_the_oldest ... ok
[INFO] [stdout] test pipeline::ansi::tests::stripping_makes_later_matching_work ... ok
[INFO] [stdout] test pipeline::ansi::tests::operating_system_commands_are_removed ... ok
[INFO] [stdout] test pipeline::ansi::tests::text_without_escapes_is_untouched ... ok
[INFO] [stdout] test executor::tests::streams_are_captured_separately ... ok
[INFO] [stdout] test pipeline::ansi::tests::the_stage_drops_nothing ... ok
[INFO] [stdout] test log::tests::records_above_the_level_are_dropped ... ok
[INFO] [stdout] test pipeline::ansi::tests::cursor_movement_and_erase_sequences_are_removed ... ok
[INFO] [stdout] test log::tests::since_specs_parse_the_documented_units ... ok
[INFO] [stdout] test pipeline::ansi::tests::the_stage_leaves_line_numbers_alone ... ok
[INFO] [stdout] test pipeline::budget::tests::a_tight_budget_drops_the_cheapest_first ... ok
[INFO] [stdout] test log::tests::concurrent_writers_all_land_whole_lines ... ok
[INFO] [stdout] test pipeline::ansi::tests::tabs_survive_and_other_controls_do_not ... ok
[INFO] [stdout] test executor::tests::large_output_on_both_streams_does_not_deadlock ... ok
[INFO] [stdout] test pipeline::budget::tests::forced_blocks_always_survive_budget_pressure ... ok
[INFO] [stdout] test pipeline::cause::tests::a_cascade_keeps_one_and_elides_the_rest ... ok
[INFO] [stdout] test pipeline::budget::tests::both_streams_share_one_budget ... ok
[INFO] [stdout] test pipeline::budget::tests::dropping_stops_at_the_core ... ok
[INFO] [stdout] test pipeline::cause::tests::a_forced_block_survives_grouping ... ok
[INFO] [stdout] test pipeline::budget::tests::no_budget_drops_nothing ... ok
[INFO] [stdout] test pipeline::budget::tests::an_error_is_never_dropped_even_if_unforced ... ok
[INFO] [stdout] test pipeline::budget::tests::a_generous_budget_drops_nothing ... ok
[INFO] [stdout] test executor::tests::other_commands_are_not_rewritten ... ok
[INFO] [stdout] test pipeline::cause::tests::a_pair_is_left_alone ... ok
[INFO] [stdout] test pipeline::cause::tests::a_path_is_a_place_not_a_counter ... ok
[INFO] [stdout] test pipeline::cause::tests::different_causes_are_not_grouped ... ok
[INFO] [stdout] test pipeline::cause::tests::findings_in_different_files_keep_their_files ... ok
[INFO] [stdout] test pipeline::cause::tests::interleaved_causes_are_counted_separately ... ok
[INFO] [stdout] test pipeline::cause::tests::grouping_never_renumbers ... ok
[INFO] [stdout] test executor::tests::signal_deaths_become_128_plus_signum ... ok
[INFO] [stdout] test pipeline::classify::location_tests::a_linter_finding_with_no_severity_word_is_a_finding ... ok
[INFO] [stdout] test pipeline::classify::location_tests::a_location_needs_both_numbers ... ok
[INFO] [stdout] test pipeline::cause::tests::the_same_cause_in_one_file_is_grouped ... ok
[INFO] [stdout] test pipeline::classify::location_tests::a_search_hit_is_not_a_finding ... ok
[INFO] [stdout] test pipeline::classify::tests::failures_are_recognized ... ok
[INFO] [stdout] test pipeline::classify::location_tests::a_search_hit_whose_text_starts_with_digits_is_not_a_finding ... ok
[INFO] [stdout] test pipeline::classify::location_tests::severity_after_a_location_is_respected ... ok
[INFO] [stdout] test pipeline::classify::tests::matching_is_anchored_at_word_boundaries ... ok
[INFO] [stdout] test pipeline::classify::tests::progress_classification_is_not_overwritten ... ok
[INFO] [stdout] test pipeline::classify::location_tests::an_explanatory_line_is_not_a_finding ... ok
[INFO] [stdout] test pipeline::cause::tests::the_same_cause_in_different_files_is_not_grouped ... ok
[INFO] [stdout] test pipeline::cause::tests::reports_inside_one_block_are_grouped ... ok
[INFO] [stdout] test pipeline::classify::tests::a_failing_command_always_shows_something ... ok
[INFO] [stdout] test pipeline::cause::tests::the_survivor_is_the_first ... ok
[INFO] [stdout] test pipeline::classify::tests::separators_are_noise ... ok
[INFO] [stdout] test pipeline::classify::tests::stderr_gets_a_deeper_rescue_than_stdout ... ok
[INFO] [stdout] test pipeline::cause::tests::a_pair_inside_a_block_is_left_alone ... ok
[INFO] [stdout] test pipeline::cause::tests::an_elision_records_its_reason ... ok
[INFO] [stdout] test pipeline::cause::tests::ordinary_lines_in_a_block_are_left_alone ... ok
[INFO] [stdout] test pipeline::cause::tests::ordinary_output_is_never_grouped ... ok
[INFO] [stdout] test pipeline::classify::location_tests::a_compiler_finding_after_a_location_is_a_finding ... ok
[INFO] [stdout] test pipeline::classify::tests::prose_about_errors_is_not_a_failure ... ok
[INFO] [stdout] test pipeline::context::tests::progress_next_to_a_failure_stays_dropped ... ok
[INFO] [stdout] test pipeline::context::tests::context_rescues_a_block_an_earlier_stage_dropped ... ok
[INFO] [stdout] test pipeline::context::tests::zero_context_forces_only_the_failure ... ok
[INFO] [stdout] test pipeline::context::tests::overlapping_windows_do_not_conflict ... ok
[INFO] [stdout] test pipeline::classify::tests::the_floor_does_not_fire_when_a_failure_is_visible ... ok
[INFO] [stdout] test pipeline::classify::tests::the_floor_does_not_fire_on_success ... ok
[INFO] [stdout] test executor::tests::the_child_is_timed ... ok
[INFO] [stdout] test pipeline::classify::tests::the_more_serious_signal_wins ... ok
[INFO] [stdout] test pipeline::classify::tests::the_floor_rescues_a_block_progress_had_dropped ... ok
[INFO] [stdout] test pipeline::classify::tests::warnings_are_not_failures ... ok
[INFO] [stdout] test pipeline::context::tests::a_grouped_duplicate_next_to_an_error_stays_dropped ... ok
[INFO] [stdout] test pipeline::context::tests::a_document_without_failures_is_untouched ... ok
[INFO] [stdout] test pipeline::context::tests::blocks_around_a_failure_are_forced ... ok
[INFO] [stdout] test pipeline::context::tests::context_reaches_as_far_as_configured ... ok
[INFO] [stdout] test pipeline::context::tests::context_at_the_edges_does_not_panic ... ok
[INFO] [stdout] test pipeline::dedupe::tests::a_repeated_pattern_collapses_as_a_unit ... ok
[INFO] [stdout] test pipeline::cause::tests::the_failure_is_still_visible ... ok
[INFO] [stdout] test pipeline::dedupe::tests::annotating_twice_does_not_stack ... ok
[INFO] [stdout] test pipeline::dedupe::tests::repeated_failures_are_never_collapsed ... ok
[INFO] [stdout] test pipeline::dedupe::tests::identical_lines_still_collapse ... ok
[INFO] [stdout] test pipeline::dedupe::tests::a_single_occurrence_is_not_annotated ... ok
[INFO] [stdout] test pipeline::dedupe::tests::a_pair_of_identical_lines_survives_intact ... ok
[INFO] [stdout] test pipeline::dedupe::tests::a_loop_body_inside_one_block_collapses ... ok
[INFO] [stdout] test pipeline::dedupe::tests::annotation_is_marked_as_ours ... ok
[INFO] [stdout] test pipeline::dedupe::tests::repeated_failing_blocks_are_never_collapsed ... ok
[INFO] [stdout] test executor::tests::exit_codes_are_propagated_unchanged ... ok
[INFO] [stdout] test pipeline::excerpt::tests::nothing_is_renumbered ... ok
[INFO] [stdout] test pipeline::excerpt::tests::the_location_survives ... ok
[INFO] [stdout] test pipeline::dedupe::tests::varying_numbers_do_not_defeat_pattern_matching ... ok
[INFO] [stdout] test pipeline::dedupe::tests::consecutive_duplicates_collapse_to_one_with_a_count ... ok
[INFO] [stdout] test pipeline::progress::tests::a_mixed_block_survives_whole ... ok
[INFO] [stdout] test pipeline::excerpt::tests::a_few_findings_keep_theirs ... ok
[INFO] [stdout] test pipeline::excerpt::tests::many_findings_lose_their_quoted_source ... ok
[INFO] [stdout] test pipeline::dedupe::tests::the_count_is_what_replaces_the_copies ... ok
[INFO] [stdout] test pipeline::dedupe::tests::distinct_blocks_are_not_one_block_and_a_count ... ok
[INFO] [stdout] test pipeline::dedupe::tests::two_repeats_are_left_alone ... ok
[INFO] [stdout] test pipeline::dedupe::tests::lines_that_differ_only_by_a_number_are_not_one_line ... ok
[INFO] [stdout] test pipeline::dedupe::tests::non_consecutive_duplicates_both_survive ... ok
[INFO] [stdout] test pipeline::excerpt::tests::ordinary_output_is_untouched ... ok
[INFO] [stdout] test pipeline::progress::tests::content_that_merely_contains_a_number_is_not_progress ... ok
[INFO] [stdout] test pipeline::dedupe::tests::normalization_flattens_digit_runs ... ok
[INFO] [stdout] test pipeline::rank::tests::stderr_of_a_failing_command_is_boosted ... ok
[INFO] [stdout] test pipeline::rank::tests::vendoring_does_not_deprioritize_a_failure ... ok
[INFO] [stdout] test pipeline::dedupe::tests::a_forced_block_survives_deduplication ... ok
[INFO] [stdout] test pipeline::progress::tests::percentages_and_bars_are_progress ... ok
[INFO] [stdout] test pipeline::rank::tests::a_failure_outranks_everything ... ok
[INFO] [stdout] test pipeline::rank::tests::a_vendored_info_block_is_cheaper_than_source ... ok
[INFO] [stdout] test pipeline::rank::tests::class_sets_the_base_score ... ok
[INFO] [stdout] test pipeline::rank::tests::a_path_shared_across_kept_blocks_is_boosted ... ok
[INFO] [stdout] test pipeline::rank::tests::rank_does_not_drop_blocks ... ok
[INFO] [stdout] test pipeline::rank::tests::scores_stay_in_unit_interval ... ok
[INFO] [stdout] test pipeline::tests::counts_split_between_kept_and_elided ... ok
[INFO] [stdout] test pipeline::tests::dropping_a_block_records_what_was_removed ... ok
[INFO] [stdout] test pipeline::rank::tests::stderr_of_a_successful_command_is_not ... ok
[INFO] [stdout] test pipeline::tests::a_forced_block_cannot_be_dropped ... ok
[INFO] [stdout] test pipeline::tests::every_dropped_block_carries_an_elision ... ok
[INFO] [stdout] test pipeline::tests::forcing_a_dropped_block_clears_its_elision ... ok
[INFO] [stdout] test pipeline::tests::no_stage_mutates_a_line_origin ... ok
[INFO] [stdout] test pipeline::tests::unknown_stage_names_are_skipped ... ok
[INFO] [stdout] test pipeline::excerpt::tests::what_went_is_announced ... ok
[INFO] [stdout] test pipeline::progress::tests::a_dropped_block_says_how_much_went ... ok
[INFO] [stdout] test platform::tests::an_advisory_lock_excludes_a_second_holder ... ok
[INFO] [stdout] test platform::tests::is_executable_reads_the_permission_bits ... ok
[INFO] [stdout] test pipeline::progress::tests::a_forced_block_is_not_dropped ... ok
[INFO] [stdout] test platform::tests::linux_falls_back_to_xdg_defaults ... ok
[INFO] [stdout] test platform::tests::empty_xdg_var_is_treated_as_unset ... ok
[INFO] [stdout] test pipeline::progress::tests::an_empty_line_is_not_progress ... ok
[INFO] [stdout] test pipeline::progress::tests::build_churn_is_progress ... ok
[INFO] [stdout] test platform::tests::stdin_tty_detection_answers_without_panicking ... ok
[INFO] [stdout] test platform::tests::missing_home_does_not_panic ... ok
[INFO] [stdout] test platform::tests::xdg_vars_win_on_both_platforms ... ok
[INFO] [stdout] test platform::tests::signal_deaths_follow_the_shell_convention ... ok
[INFO] [stdout] test render::tests::a_failing_command_shows_its_failure_at_every_filtered_level ... ok
[INFO] [stdout] test pipeline::tests::no_stage_removes_a_block ... ok
[INFO] [stdout] test render::tests::a_failure_with_no_recognizable_error_still_surfaces ... ok
[INFO] [stdout] test render::tests::a_marker_carries_the_handle_and_the_count ... ok
[INFO] [stdout] test render::tests::a_marker_is_phrased_as_content_outside_the_view ... ok
[INFO] [stdout] test render::tests::a_marker_says_what_kind_of_content_is_missing ... ok
[INFO] [stdout] test platform::tests::store_and_log_paths_are_overridable ... ok
[INFO] [stdout] test render::tests::an_unfiltered_document_renders_unchanged_and_says_nothing ... ok
[INFO] [stdout] test plot::tests::dry_text_names_the_lens_and_the_stages ... ok
[INFO] [stdout] test render::tests::a_trailing_elision_is_announced ... ok
[INFO] [stdout] test plot::tests::trace_counts_shrink_when_progress_is_dropped ... ok
[INFO] [stdout] test pipeline::tests::stages_run_in_order ... ok
[INFO] [stdout] test plot::tests::dry_json_is_the_resolved_pipeline ... ok
[INFO] [stdout] test render::tests::a_marker_without_a_handle_still_announces ... ok
[INFO] [stdout] test platform::tests::set_arg0_changes_only_argv0 ... ok
[INFO] [stdout] test render::tests::level_one_shows_a_head_and_announces_the_rest ... ok
[INFO] [stdout] test render::tests::level_one_shows_output_that_did_not_fail ... ok
[INFO] [stdout] test render::tests::level_zero_names_the_failure ... ok
[INFO] [stdout] test render::tests::level_one_still_shows_failures_alone ... ok
[INFO] [stdout] test platform::tests::macos_falls_back_to_library ... ok
[INFO] [stdout] test render::tests::level_zero_does_not_count_the_line_it_shows ... ok
[INFO] [stdout] test render::tests::level_zero_ends_on_the_last_line_when_nothing_failed ... ok
[INFO] [stdout] test pipeline::tests::forced_blocks_survive_budget_pressure ... ok
[INFO] [stdout] test pipeline::tests::no_line_is_lost_without_being_counted ... ok
[INFO] [stdout] test render::tests::an_empty_stream_renders_empty_at_every_level ... ok
[INFO] [stdout] test render::tests::the_summary_level_reports_counts ... ok
[INFO] [stdout] test report::tests::thousands_are_grouped ... ok
[INFO] [stdout] test render::tests::levels_parse_from_numbers ... ok
[INFO] [stdout] test resolve::tests::a_prefix_match_needs_the_equals_sign ... ok
[INFO] [stdout] test render::tests::markers_sit_where_the_gap_is ... ok
[INFO] [stdout] test report::tests::the_report_names_the_stage_that_dropped_lines ... ok
[INFO] [stdout] test render::tests::progress_only_output_collapses_to_a_marker ... ok
[INFO] [stdout] test resolve::tests::interactive_flags_only_count_where_they_mean_that ... ok
[INFO] [stdout] test render::tests::the_items_level_keeps_failures_and_announces_the_rest ... ok
[INFO] [stdout] test render::tests::anything_removed_is_announced ... ok
[INFO] [stdout] test report::tests::budget_exceeded_is_stated ... ok
[INFO] [stdout] test resolve::tests::a_missing_command_passes_through_rather_than_erroring ... ok
[INFO] [stdout] test resolve::tests::interpreters_are_interactive_only_without_a_script ... ok
[INFO] [stdout] test resolve::tests::known_interactive_commands_pass_through ... ok
[INFO] [stdout] test resolve::tests::machine_readable_flags_pass_through ... ok
[INFO] [stdout] test resolve::tests::git_editor_subcommands_are_interactive_only_with_a_terminal ... ok
[INFO] [stdout] test resolve::tests::git_specific_flags_do_not_leak_to_other_commands ... ok
[INFO] [stdout] test resolve::tests::resolution_finds_a_real_binary_on_path ... ok
[INFO] [stdout] test resolve::tests::path_qualified_commands_skip_the_path_search ... ok
[INFO] [stdout] test render::tests::every_kept_line_appears_exactly_once ... ok
[INFO] [stdout] test store::tests::a_handle_is_eight_lowercase_hex_digits ... ok
[INFO] [stdout] test resolve::tests::raw_mode_wins_over_everything ... ok
[INFO] [stdout] test resolve::tests::reasons_have_stable_log_identifiers ... ok
[INFO] [stdout] test store::tests::fnv1a_matches_the_published_vectors ... ok
[INFO] [stdout] test store::tests::listing_a_store_that_does_not_exist_is_empty ... ok
[INFO] [stdout] test store::tests::argument_boundaries_are_part_of_the_address ... ok
[INFO] [stdout] test store::tests::every_input_changes_the_address ... ok
[INFO] [stdout] test store::tests::reading_a_run_that_is_not_there_is_an_error_not_a_panic ... ok
[INFO] [stdout] test store::tests::stray_directories_are_ignored ... ok
[INFO] [stdout] test store::tests::the_newest_run_is_never_pruned ... ok
[INFO] [stdout] test store::tests::a_written_run_reads_back_byte_for_byte ... ok
[INFO] [stdout] test store::tests::the_same_run_addresses_the_same_entry ... ok
[INFO] [stdout] test store::tests::timestamps_are_rfc3339_utc ... ok
[INFO] [stdout] test tokens::tests::a_long_input_stays_proportional ... ok
[INFO] [stdout] test tokens::tests::a_path_costs_more_than_prose_of_the_same_length ... ok
[INFO] [stdout] test tokens::tests::empty_text_costs_nothing ... ok
[INFO] [stdout] test resolve::tests::resolving_to_ourselves_passes_through ... ok
[INFO] [stdout] test tokens::tests::real_output_lands_within_fifteen_percent ... ok
[INFO] [stdout] test static_assert::tests::assertions_above_compiled ... ok
[INFO] [stdout] test store::tests::a_handle_from_a_user_is_validated ... ok
[INFO] [stdout] test tokens::tests::the_estimate_grows_with_the_text ... ok
[INFO] [stdout] test pipeline::tests::filtering_is_linear_in_the_input ... ok
[INFO] [stdout] test store::tests::a_byte_limit_also_evicts ... ok
[INFO] [stdout] test store::tests::pruning_keeps_the_newest_runs ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 257 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.59s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/lens-805126bedf9a94a7)
[INFO] [stdout] running 3 tests
[INFO] [stdout] test tests::exit_codes_round_trip_through_the_u8_range ... ok
[INFO] [stdout] test tests::help_names_the_split_rule ... ok
[INFO] [stdout] test tests::an_out_of_range_code_is_still_a_failure ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/fidelity.rs (/opt/rustwide/target/debug/deps/fidelity-f59c536f7bf2fa9c)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test an_unknown_lens_flag_does_not_become_a_command ... ok
[INFO] [stdout] test a_missing_command_fails_the_way_a_shell_fails ... ok
[INFO] [stdout] test version_and_help_answer_without_running_anything ... ok
[INFO] [stdout] test raw_mode_is_byte_identical_to_running_the_command_directly ... ok
[INFO] [stdout] test large_interleaved_output_completes ... ok
[INFO] [stdout] test lens_variables_do_not_reach_the_child ... ok
[INFO] [stdout] test streams_are_kept_separate ... ok
[INFO] [stdout] test a_child_flag_that_looks_like_ours_reaches_the_child ... ok
[INFO] [stdout] test exit_codes_are_propagated_unchanged ... ok
[INFO] [stdout] test signal_deaths_follow_the_shell_convention ... ok
[INFO] [stdout] test binary_output_survives_unchanged ... ok
[INFO] [stdout] test output_is_byte_identical_to_running_the_command_directly ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running tests/filtering.rs (/opt/rustwide/target/debug/deps/filtering-c0dcc334d463d990)
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.21s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 22 tests
[INFO] [stdout] test a_failure_with_no_error_word_still_surfaces ... ok
[INFO] [stdout] test debug_report_arrives_after_the_child ... ok
[INFO] [stdout] test ansi_escapes_do_not_reach_the_view ... ok
[INFO] [stdout] test empty_output_stays_empty ... ok
[INFO] [stdout] test an_unknown_level_is_refused ... ok
[INFO] [stdout] test anything_left_out_is_announced ... ok
[INFO] [stdout] test raw_mode_bypasses_filtering_entirely ... ok
[INFO] [stdout] test a_failing_command_always_shows_its_failure ... ok
[INFO] [stdout] test file_line_references_still_resolve_after_filtering ... ok
[INFO] [stdout] test repeated_lines_collapse_with_a_count ... ok
[INFO] [stdout] test output_that_needs_no_filtering_is_unchanged ... ok
[INFO] [stdout] test a_stream_the_command_never_wrote_to_stays_empty ... ok
[INFO] [stdout] test the_last_line_of_a_long_output_is_not_lost ... ok
[INFO] [stdout] test stats_reports_reduction_in_output_tokens ... ok
[INFO] [stdout] test show_reports_the_stored_runs_exit_code_at_every_level ... ok
[INFO] [stdout] test explain_prints_the_report_for_a_stored_run ... ok
[INFO] [stdout] test a_budget_drops_ordinary_output_and_keeps_the_failure ... ok
[INFO] [stdout] test a_marker_names_a_handle_but_not_a_command ... ok
[INFO] [stdout] test the_raw_view_is_byte_identical_to_the_command ... ok
[INFO] [stdout] test the_run_record_reports_what_filtering_did ... ok
[INFO] [stdout] test every_filtered_level_announces_what_it_left_out ... ok
[INFO] [stdout] test the_filtered_levels_narrow ... ok
[INFO] [stderr]      Running tests/git_adapter.rs (/opt/rustwide/target/debug/deps/git_adapter-93774de0e631635c)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.16s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test plot_names_the_git_adapter_for_git_diff ... ok
[INFO] [stdout] test a_hunk_header_survives_filtering ... ok
[INFO] [stderr]      Running tests/plot.rs (/opt/rustwide/target/debug/deps/plot-461edd06614ab422)
[INFO] [stdout] test unparseable_git_output_falls_back_to_generic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test config_path_prints_the_override ... ok
[INFO] [stdout] test lenses_lists_the_builtins ... ok
[INFO] [stdout] test plot_dry_does_not_spawn_the_command ... ok
[INFO] [stdout] test plot_selects_git_over_default ... ok
[INFO] [stdout] test unknown_use_is_an_error_not_a_run ... ok
[INFO] [stdout] test use_forces_a_lens_on_plot ... ok
[INFO] [stdout] test plot_json_matches_config_for_the_same_argv ... ok
[INFO] [stdout] test plot_trace_reads_a_stored_run ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running tests/store_and_log.rs (/opt/rustwide/target/debug/deps/store_and_log-953376d65d6f8fc1)
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 25 tests
[INFO] [stdout] test a_passthrough_run_stores_nothing ... ok
[INFO] [stdout] test show_re_emits_a_stored_run_without_re_running_it ... ok
[INFO] [stdout] test a_non_utf8_argument_runs_instead_of_panicking ... ok
[INFO] [stdout] test logging_never_touches_the_childs_streams ... ok
[INFO] [stdout] test an_unwritable_store_does_not_fail_the_command ... ok
[INFO] [stdout] test binary_output_is_stored_without_reinterpretation ... ok
[INFO] [stdout] test show_level_three_is_the_stored_bytes ... ok
[INFO] [stdout] test a_captured_run_is_stored_byte_for_byte ... ok
[INFO] [stdout] test an_unwritable_log_does_not_fail_the_command ... ok
[INFO] [stdout] test stats_on_an_empty_log_says_so ... ok
[INFO] [stdout] test log_off_writes_nothing ... ok
[INFO] [stdout] test the_run_record_carries_the_handle_of_its_stored_run ... ok
[INFO] [stdout] test lens_subcommands_do_not_record_runs ... ok
[INFO] [stdout] test show_says_so_when_a_run_is_not_there ... ok
[INFO] [stdout] test different_output_is_a_different_run ... ok
[INFO] [stdout] test show_treats_a_missing_meta_as_failed_not_succeeded ... ok
[INFO] [stdout] test logs_filters_by_level ... ok
[INFO] [stdout] test show_rejects_a_handle_that_could_escape_the_store ... ok
[INFO] [stdout] test stats_filters_by_command_and_window ... ok
[INFO] [stdout] test stats_aggregates_the_log ... ok
[INFO] [stdout] test the_log_never_carries_command_output ... ok
[INFO] [stdout] test the_same_run_twice_addresses_one_entry ... ok
[INFO] [stdout] test every_invocation_is_recorded_including_passthrough ... ok
[INFO] [stdout] test an_unparseable_log_level_falls_back_rather_than_failing ... ok
[INFO] [stdout] test logs_tails_the_records ... ok
[INFO] [stderr]    Doc-tests lens
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[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" "74a45eab72082edb8bddc55b5b07bbf243729807d58444ea63da05708c757bd9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "74a45eab72082edb8bddc55b5b07bbf243729807d58444ea63da05708c757bd9", kill_on_drop: false }`
[INFO] [stdout] 74a45eab72082edb8bddc55b5b07bbf243729807d58444ea63da05708c757bd9
