[INFO] fetching crate sherd 0.5.2...
[INFO] testing sherd-0.5.2 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate sherd 0.5.2 into /workspace/builds/worker-7-tc2/source
[INFO] started tweaking crates.io crate sherd 0.5.2
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate sherd 0.5.2
[INFO] tweaked toml for crates.io crate sherd 0.5.2 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate sherd 0.5.2 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate sherd 0.5.2 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:61:12
[INFO] [stderr]    |
[INFO] [stderr] 61 | homepage = "https://github.com/pr0d1r2/sherd"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 66 | repository = "https://github.com/pr0d1r2/sherd"
[INFO] [stderr]    |              ----------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `sherd` (manifest) generated 1 warning
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 45a6678dad274bd3a5e0d8c2ba0b07f1f3be157889040de25a8a039f1da1f8ff
[INFO] running `Command { std: "docker" "start" "45a6678dad274bd3a5e0d8c2ba0b07f1f3be157889040de25a8a039f1da1f8ff", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "45a6678dad274bd3a5e0d8c2ba0b07f1f3be157889040de25a8a039f1da1f8ff", 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" "45a6678dad274bd3a5e0d8c2ba0b07f1f3be157889040de25a8a039f1da1f8ff" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "45a6678dad274bd3a5e0d8c2ba0b07f1f3be157889040de25a8a039f1da1f8ff", 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" "45a6678dad274bd3a5e0d8c2ba0b07f1f3be157889040de25a8a039f1da1f8ff" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:61:12
[INFO] [stderr]    |
[INFO] [stderr] 61 | homepage = "https://github.com/pr0d1r2/sherd"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 66 | repository = "https://github.com/pr0d1r2/sherd"
[INFO] [stderr]    |              ----------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `sherd` (manifest) generated 1 warning
[INFO] [stderr]    Compiling regex-automata v0.4.16
[INFO] [stderr]    Compiling bit-vec v0.6.3
[INFO] [stderr]    Compiling microlith v0.7.1
[INFO] [stderr]    Compiling bit-set v0.5.3
[INFO] [stderr]    Compiling bstr v1.13.0
[INFO] [stderr]    Compiling regex v1.13.1
[INFO] [stderr]    Compiling fancy-regex v0.13.0
[INFO] [stderr]    Compiling tiktoken-rs v0.6.0
[INFO] [stderr]    Compiling itok v0.3.0
[INFO] [stderr]    Compiling sherd v0.5.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 14.69s
[INFO] running `Command { std: "docker" "inspect" "45a6678dad274bd3a5e0d8c2ba0b07f1f3be157889040de25a8a039f1da1f8ff", 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" "45a6678dad274bd3a5e0d8c2ba0b07f1f3be157889040de25a8a039f1da1f8ff" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:61:12
[INFO] [stderr]    |
[INFO] [stderr] 61 | homepage = "https://github.com/pr0d1r2/sherd"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 66 | repository = "https://github.com/pr0d1r2/sherd"
[INFO] [stderr]    |              ----------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `sherd` (manifest) generated 1 warning
[INFO] [stderr]    Compiling sherd v0.5.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 7.45s
[INFO] running `Command { std: "docker" "inspect" "45a6678dad274bd3a5e0d8c2ba0b07f1f3be157889040de25a8a039f1da1f8ff", 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" "45a6678dad274bd3a5e0d8c2ba0b07f1f3be157889040de25a8a039f1da1f8ff" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:61:12
[INFO] [stderr]    |
[INFO] [stderr] 61 | homepage = "https://github.com/pr0d1r2/sherd"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 66 | repository = "https://github.com/pr0d1r2/sherd"
[INFO] [stderr]    |              ----------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `sherd` (manifest) generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.76s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/sherd/b39c4847cccdf7d4/out/sherd-b39c4847cccdf7d4)
[INFO] [stdout] 
[INFO] [stdout] running 361 tests
[INFO] [stdout] test adopt::tests::a_map_forgives_comments_and_refuses_ambiguity ... ok
[INFO] [stdout] test cli::adopt::tests::adopt_without_a_dir_is_usage_rather_than_this_repo ... ok
[INFO] [stdout] test adopt::tests::a_citation_is_not_a_word_the_row_matches_on ... ok
[INFO] [stdout] test adopt::tests::a_destination_already_holding_the_id_is_refused ... ok
[INFO] [stdout] test cli::args::tests::a_tree_that_is_not_a_repository_resolves_to_itself ... ok
[INFO] [stdout] test cli::args::tests::arg_dir_resolves_against_root_not_the_cwd ... ok
[INFO] [stdout] test adopt::tests::a_moved_row_keeps_its_number_and_its_citers_follow ... ok
[INFO] [stdout] test adopt::tests::every_row_is_accounted_for_exactly_once ... ok
[INFO] [stdout] test cli::args::tests::depth_defaults_to_rule_and_refuses_a_typo ... ok
[INFO] [stdout] test cli::adopt::tests::a_source_this_reader_cannot_parse_is_usage_not_nothing_to_move ... ok
[INFO] [stdout] test adopt::tests::received_rows_land_in_id_order_among_resident_rows ... ok
[INFO] [stdout] test adopt::tests::a_refused_map_leaves_every_file_untouched ... ok
[INFO] [stdout] test cli::args::tests::a_miss_names_the_spelling_that_would_have_worked ... ok
[INFO] [stdout] test adopt::tests::a_violation_the_source_already_had_does_not_refuse_the_move ... ok
[INFO] [stdout] test cli::author::tests::init_reports_a_directory_it_cannot_read ... ok
[INFO] [stdout] test cli::args::tests::repo_root_finds_the_tree_that_has_both_markers ... ok
[INFO] [stdout] test adopt::tests::the_migration_passes_the_checker_that_gates_every_spec ... ok
[INFO] [stdout] test cli::author::tests::init_writes_a_scaffold_with_a_row_per_child ... ok
[INFO] [stdout] test adopt::tests::a_home_no_table_declares_is_refused ... ok
[INFO] [stdout] test adopt::tests::a_row_two_nodes_claim_equally_is_placed_nowhere ... ok
[INFO] [stdout] test adopt::tests::a_milestone_range_is_refused_only_when_the_map_splits_it ... ok
[INFO] [stdout] test cli::author::tests::init_run_twice_refuses_the_second_time ... ok
[INFO] [stdout] test cli::author::tests::init_on_a_path_that_is_not_a_directory_is_usage ... ok
[INFO] [stdout] test cli::adopt::tests::adopt_proposes_then_reruns_clean ... ok
[INFO] [stdout] test cli::author::tests::init_stdout_writes_nothing ... ok
[INFO] [stdout] test cli::args::tests::a_dir_in_another_repo_resolves_that_repo_s_root ... ok
[INFO] [stdout] test cli::check::tests::review_of_an_unknown_revision_is_an_error_not_a_clean_bill ... ok
[INFO] [stdout] test cli::args::tests::a_flag_before_the_dir_does_not_hide_it ... ok
[INFO] [stdout] test adopt::tests::a_second_run_over_a_migrated_tree_moves_nothing ... ok
[INFO] [stdout] test cli::args::tests::every_spelling_of_a_dir_resolves_to_one_root ... ok
[INFO] [stdout] test cli::check::tests::check_reports_the_violations_it_finds_and_exits_one ... ok
[INFO] [stdout] test cli::author::tests::init_refuses_to_overwrite_an_existing_spec ... ok
[INFO] [stdout] test cli::check::tests::a_node_whose_spec_cannot_be_read_is_skipped ... ok
[INFO] [stdout] test cli::check::tests::review_of_a_real_revision_reports_and_succeeds ... ok
[INFO] [stdout] test cli::check::tests::a_missing_slice_registry_is_not_drift ... ok
[INFO] [stdout] test cli::check::tests::a_citation_fails_on_a_missing_node_and_on_a_missing_row ... ok
[INFO] [stdout] test cli::author::tests::sync_writes_once_then_reports_clean ... ok
[INFO] [stdout] test cli::check::tests::check_on_a_clean_tree_exits_zero ... ok
[INFO] [stdout] test cli::check::tests::an_edge_that_skips_a_level_is_a_finding ... ok
[INFO] [stdout] test cli::check::tests::review_prints_the_findings_it_has_and_stays_advisory ... ok
[INFO] [stdout] test cli::measure::tests::route_reports_a_hit_a_miss_and_an_ambiguity_by_exit_code ... ok
[INFO] [stdout] test cli::propose::tests::a_node_declaring_no_types_reports_rather_than_erroring ... ok
[INFO] [stdout] test cli::propose::tests::seam_on_a_dir_matching_no_node_is_usage ... ok
[INFO] [stdout] test cli::propose::tests::seam_names_a_public_type_and_not_a_private_one ... ok
[INFO] [stdout] test cli::propose::tests::a_private_or_crate_visible_module_is_still_a_node ... ok
[INFO] [stdout] test cli::measure::tests::absence_is_reported_and_is_not_a_failure ... ok
[INFO] [stdout] test cli::propose::tests::a_type_belongs_to_the_nearest_node_not_to_every_ancestor ... ok
[INFO] [stdout] test cli::steps::tests::plan_format_is_positional_agnostic_and_strict ... ok
[INFO] [stdout] test cli::tests::a_dir_matching_no_node_is_usage_not_a_vacuous_pass ... ok
[INFO] [stdout] test cli::tests::a_verb_missing_its_argument_is_usage_not_a_crash ... ok
[INFO] [stdout] test cli::tests::an_outcome_verdict_outside_the_three_words_is_refused ... ok
[INFO] [stdout] test cli::tests::an_unknown_command_is_a_usage_error ... ok
[INFO] [stdout] test cli::propose::tests::split_on_a_directory_with_no_spec_is_usage ... ok
[INFO] [stdout] test cli::measure::tests::the_coverage_verb_checks_records_and_refuses ... ok
[INFO] [stdout] test cli::tests::help_and_no_args_both_succeed ... ok
[INFO] [stdout] test cli::measure::tests::a_tree_with_no_ratchet_is_a_usage_error ... ok
[INFO] [stdout] test cli::steps::tests::plan_for_an_undeclared_milestone_is_usage ... ok
[INFO] [stdout] test cli::tests::the_usage_text_names_every_exit_code_it_returns ... ok
[INFO] [stdout] test cli::measure::tests::the_debt_verb_checks_records_and_refuses ... ok
[INFO] [stdout] test code::structure_tests::a_brace_group_names_every_module_in_it ... ok
[INFO] [stdout] test code::structure_tests::a_private_or_crate_visible_type_is_not_vocabulary ... ok
[INFO] [stdout] test code::structure_tests::a_single_member_group_is_still_a_group ... ok
[INFO] [stdout] test code::structure_tests::a_source_with_no_types_yields_an_empty_vocabulary ... ok
[INFO] [stdout] test code::structure_tests::a_word_beginning_with_a_keyword_is_not_a_declaration ... ok
[INFO] [stdout] test code::structure_tests::an_import_carries_the_items_it_names ... ok
[INFO] [stdout] test code::structure_tests::an_inline_or_test_only_module_is_not_a_candidate ... ok
[INFO] [stdout] test code::structure_tests::crate_uses_names_internal_modules_and_ignores_the_rest ... ok
[INFO] [stdout] test code::structure_tests::every_public_type_form_is_named_with_the_word_that_declared_it ... ok
[INFO] [stdout] test code::structure_tests::pub_and_pub_crate_and_private_are_three_different_things ... ok
[INFO] [stdout] test code::structure_tests::types_across_sources_are_pooled_and_deduplicated ... ok
[INFO] [stdout] test code::tests::a_bodyless_test_module_closes_at_its_semicolon ... ok
[INFO] [stdout] test code::tests::a_brace_in_a_char_literal_does_not_open_a_block ... ok
[INFO] [stdout] test code::tests::a_call_is_a_free_function_not_a_method_or_a_macro ... ok
[INFO] [stdout] test code::tests::a_call_keeps_its_arguments_including_nested_ones ... ok
[INFO] [stdout] test code::tests::a_cfg_test_function_closes_its_own_region ... ok
[INFO] [stdout] test code::tests::a_lifetime_does_not_open_a_literal ... ok
[INFO] [stdout] test code::tests::a_private_double_is_invisible_to_signatures_and_visible_to_test_decls ... ok
[INFO] [stdout] test code::tests::a_type_keeps_its_fields_and_a_fn_keeps_only_its_line ... ok
[INFO] [stdout] test code::tests::an_unclosed_call_ends_at_the_input_rather_than_panicking ... ok
[INFO] [stdout] test code::structure_tests::a_file_reaching_for_nothing_internal_yields_nothing ... ok
[INFO] [stdout] test code::tests::code_below_a_test_module_is_code_to_the_measure_and_not_to_the_cut ... ok
[INFO] [stdout] test code::tests::every_declaration_form_in_this_crate_is_named ... ok
[INFO] [stdout] test code::tests::expected_calls_skips_macros_and_methods ... ok
[INFO] [stdout] test code::tests::expected_calls_finds_the_undefined_one_only ... ok
[INFO] [stdout] test code::tests::is_called_accepts_a_one_line_body_that_declares_and_calls ... ok
[INFO] [stdout] test code::tests::is_called_sees_a_generic_declaration_as_a_declaration ... ok
[INFO] [stdout] test code::tests::markers_are_the_long_literals_a_body_matches_on ... ok
[INFO] [stdout] test code::tests::signatures_keep_shape_and_drop_bodies ... ok
[INFO] [stdout] test code::tests::split_finds_the_test_boundary ... ok
[INFO] [stdout] test code::tests::split_of_a_file_with_no_tests_is_all_impl ... ok
[INFO] [stdout] test code::tests::test_decls_carries_names_not_bodies ... ok
[INFO] [stdout] test code::tests::the_marker_inside_a_string_does_not_split_the_file ... ok
[INFO] [stdout] test code::tests::public_fns_reads_declarations_only ... ok
[INFO] [stdout] test code::tests::the_measure_matches_at_column_zero_only ... ok
[INFO] [stdout] test debt::tests::a_breach_names_the_ceiling_and_the_measurement ... ok
[INFO] [stdout] test cli::tests::both_version_spellings_exit_clean_and_name_the_crate_version ... FAILED
[INFO] [stdout] test debt::tests::a_floor_refuses_a_fall_and_states_what_it_saw ... ok
[INFO] [stdout] test debt::tests::a_percentage_keeps_both_decimals ... ok
[INFO] [stdout] test debt::tests::a_broken_build_and_a_missing_toolchain_both_yield_nothing ... ok
[INFO] [stdout] test debt::tests::a_failed_build_yields_no_measurement ... ok
[INFO] [stdout] test debt::tests::a_verdict_names_every_ratio_that_rose ... ok
[INFO] [stdout] test debt::tests::both_ceilings_are_read_or_neither_is ... ok
[INFO] [stdout] test debt::tests::both_ratios_come_from_one_denominator ... ok
[INFO] [stdout] test debt::tests::excess_is_lines_over_the_limit_clippy_reports ... ok
[INFO] [stdout] test debt::tests::a_recorded_ceiling_is_tenths_and_absence_is_not_zero ... ok
[INFO] [stdout] test debt::tests::recording_debt_with_no_ratchet_is_an_error ... ok
[INFO] [stdout] test debt::tests::recording_into_a_tree_with_no_floor_is_an_error ... ok
[INFO] [stdout] test debt::tests::a_toolchain_that_did_not_run_yields_no_measurement ... ok
[INFO] [stdout] test debt::tests::recording_rewrites_numbers_and_keeps_every_reason ... ok
[INFO] [stdout] test debt::tests::the_denominator_counts_both_measured_directories ... ok
[INFO] [stdout] test debt::tests::recording_raises_and_refuses_to_lower ... ok
[INFO] [stdout] test debt::tests::the_gate_calls_this_rather_than_restating_it ... ok
[INFO] [stdout] test debt::tests::recording_lowers_and_refuses_to_raise ... ok
[INFO] [stdout] test debt::tests::the_filter_counts_src_and_dev_warnings_only ... ok
[INFO] [stdout] test fed::declared_tests::the_declared_set_is_what_the_tables_name ... ok
[INFO] [stdout] test fed::nav_tests::a_leaf_names_its_ancestors_itself_and_its_co_children ... ok
[INFO] [stdout] test fed::nav_tests::a_lens_holding_a_pipe_stays_one_cell ... ok
[INFO] [stdout] test fed::nav_tests::a_node_label_is_relative_and_the_root_is_a_dot ... ok
[INFO] [stdout] test fed::nav_tests::a_section_renders_with_its_header ... ok
[INFO] [stdout] test fed::declared_tests::each_node_appears_once ... ok
[INFO] [stdout] test fed::nav_tests::the_root_has_no_up_and_no_siblings ... ok
[INFO] [stdout] test fed::nav_tests::the_walk_finds_nested_source_and_skips_build_output ... ok
[INFO] [stdout] test fed::nav_tests::upstream_doubles_every_backslash_and_the_decode_is_unchanged ... ok
[INFO] [stdout] test fed::tests::a_backslash_in_a_cell_survives_the_parse ... ok
[INFO] [stdout] test fed::tests::a_cell_ending_in_a_backslash_still_yields_its_edge ... ok
[INFO] [stdout] test fed::tests::an_escaped_pipe_is_still_one_cell ... ok
[INFO] [stdout] test fed::tests::depth_invariant_violated ... ok
[INFO] [stdout] test fed::tests::discover_ignores_globs ... ok
[INFO] [stdout] test fed::tests::escaped_pipe_stays_in_the_cell ... ok
[INFO] [stdout] test fed::tests::every_row_of_a_mixed_table_survives ... ok
[INFO] [stdout] test fed::nav_tests::a_file_belongs_to_its_nearest_node_and_to_no_ancestor ... ok
[INFO] [stdout] test fed::tests::header_row_is_not_an_edge ... ok
[INFO] [stdout] test fed::tests::exhaustive_invariant_detects_duplicates_and_missing ... ok
[INFO] [stdout] test cli::tests::every_graph_rendering_succeeds_and_they_are_not_the_same_render ... ok
[INFO] [stdout] test fed::tests::mermaid_is_plain_and_ascii ... ok
[INFO] [stdout] test fed::tests::mermaid_declares_each_node_once ... ok
[INFO] [stdout] test fed::tests::missing_not_owns_detected ... ok
[INFO] [stdout] test fed::tests::mermaid_uses_the_widely_supported_directive ... ok
[INFO] [stdout] test fed::tests::parses_rows_and_stops_at_next_section ... ok
[INFO] [stdout] test fed::tests::supervisor_dirs_never_become_nodes ... ok
[INFO] [stdout] test fed::tests::table_escapes_the_delimiter ... ok
[INFO] [stdout] test git::tests::a_command_aimed_at_a_root_refuses_the_exported_environment ... ok
[INFO] [stdout] test git::tests::a_command_naming_its_own_repo_refuses_it_too ... ok
[INFO] [stdout] test fed::tests::mermaid_is_derived_from_f_rows ... ok
[INFO] [stdout] test fed::tests::tree_nests_and_needs_no_renderer ... ok
[INFO] [stdout] test land::git_tests::a_branch_with_no_commits_is_refused_before_anything_else ... ok
[INFO] [stdout] test land::git_tests::a_day_apart_in_seconds_is_a_day_apart_on_the_calendar ... ok
[INFO] [stdout] test land::git_tests::a_branch_level_with_main_has_no_commits_to_weigh ... ok
[INFO] [stdout] test fed::tests::a_node_is_findable_by_the_name_a_reader_typed ... ok
[INFO] [stdout] test land::git_tests::a_dirty_tree_is_refused_before_anything_expensive_happens ... ok
[INFO] [stdout] test land::git_tests::a_believable_branch_fast_forwards_onto_main ... ok
[INFO] [stdout] test land::git_tests::a_fast_forward_moves_main_to_the_branch_head ... ok
[INFO] [stdout] test land::git_tests::a_diverged_main_is_refused_and_the_branch_is_restored ... ok
[INFO] [stdout] test land::git_tests::current_branch_reads_the_checked_out_name ... ok
[INFO] [stdout] test land::git_tests::asking_to_push_with_no_remote_says_so_rather_than_claiming_it ... ok
[INFO] [stdout] test land::git_tests::git_reports_a_failure_rather_than_an_empty_string ... ok
[INFO] [stdout] test land::git_tests::evidence_counts_the_commits_on_the_branch_and_no_others ... ok
[INFO] [stdout] test land::git_tests::stamp_converts_epoch_seconds_to_a_real_calendar_date ... ok
[INFO] [stdout] test land::tests::a_perfect_record_does_not_excuse_a_finding_or_a_red_gate ... ok
[INFO] [stdout] test land::tests::a_refusal_carries_the_number_that_caused_it ... ok
[INFO] [stdout] test land::tests::a_run_gets_one_branch_not_one_per_apply ... ok
[INFO] [stdout] test land::tests::an_unattributable_branch_is_unknown_not_trustworthy ... ok
[INFO] [stdout] test land::tests::nothing_lands_until_the_node_has_earned_it ... ok
[INFO] [stdout] test land::tests::stamp_is_utc_civil_time ... ok
[INFO] [stdout] test lens::tests::a_ceiling_is_compared_at_the_boundary_not_near_it ... ok
[INFO] [stdout] test lens::tests::a_node_ceiling_comes_from_the_file_not_a_constant ... ok
[INFO] [stdout] test lens::tests::chain_of_repo_root_is_at_least_the_root_spec ... ok
[INFO] [stdout] test land::git_tests::origin_counts_as_a_remote_not_only_gitlab ... ok
[INFO] [stdout] test lens::tests::every_node_resolves_to_a_real_ceiling ... ok
[INFO] [stdout] test lens::tests::the_root_ceiling_comes_from_its_spec_row_not_the_default ... ok
[INFO] [stdout] test lens::tests::verdict_reports_direction_and_distance ... ok
[INFO] [stdout] test plan::git_tests::a_bare_cite_belongs_to_the_row_s_own_node ... ok
[INFO] [stdout] test plan::git_tests::a_dir_with_no_module_is_never_actionable ... ok
[INFO] [stdout] test plan::git_tests::a_kept_outcome_counts_in_both_tallies_and_a_reverted_one_in_neither ... ok
[INFO] [stdout] test land::git_tests::landing_from_a_repo_with_nothing_to_land_refuses_and_touches_nothing ... ok
[INFO] [stdout] test plan::git_tests::a_multi_file_row_is_caught_whatever_the_word_order ... ok
[INFO] [stdout] test plan::git_tests::a_namespaced_cite_names_its_owner_and_dot_is_root ... ok
[INFO] [stdout] test land::git_tests::a_push_reports_whichever_of_the_three_things_happened ... ok
[INFO] [stdout] test plan::git_tests::a_row_citing_no_invariant_yields_none ... ok
[INFO] [stdout] test plan::git_tests::a_row_naming_two_nodes_is_decomposed_not_moved ... ok
[INFO] [stdout] test plan::git_tests::a_row_that_edits_existing_code_is_never_actionable ... ok
[INFO] [stdout] test plan::git_tests::a_row_that_is_not_a_function_at_all_is_named_as_such ... ok
[INFO] [stdout] test plan::git_tests::a_task_number_ignores_its_suffix ... ok
[INFO] [stdout] test plan::git_tests::an_untried_node_outranks_one_that_has_failed ... ok
[INFO] [stdout] test plan::git_tests::every_stem_matches_its_own_ing_form ... ok
[INFO] [stdout] test plan::git_tests::five_consecutive_keeps_clears_the_landing_bar ... ok
[INFO] [stdout] test plan::git_tests::open_tasks_reads_this_repo_and_skips_what_is_done ... ok
[INFO] [stdout] test plan::git_tests::report_is_not_a_replacement_even_though_it_contains_port ... ok
[INFO] [stdout] test plan::git_tests::the_whitelist_still_says_yes_to_one_added_function ... ok
[INFO] [stdout] test plan::route_tests::a_query_naming_nothing_is_a_miss ... ok
[INFO] [stdout] test plan::git_tests::a_milestone_keeps_its_own_rows_and_counts_the_unscheduled ... ok
[INFO] [stdout] test plan::route_tests::a_query_naming_one_node_resolves_to_it ... ok
[INFO] [stdout] test plan::route_tests::a_query_spanning_two_nodes_equally_is_ambiguous ... ok
[INFO] [stdout] test plan::route_tests::a_vocabulary_is_derived_for_every_node_the_walk_finds ... ok
[INFO] [stdout] test plan::route_tests::words_under_four_characters_carry_no_signal ... ok
[INFO] [stdout] test plan::tests::a_blocked_row_is_never_handed_back ... ok
[INFO] [stdout] test plan::route_tests::the_root_is_never_the_answer ... ok
[INFO] [stdout] test plan::tests::a_replacement_row_is_not_actionable ... ok
[INFO] [stdout] test plan::tests::a_root_row_is_never_actionable ... ok
[INFO] [stdout] test plan::tests::a_row_that_names_a_position_is_a_replacement ... ok
[INFO] [stdout] test plan::tests::a_spec_editing_row_is_not_actionable ... ok
[INFO] [stdout] test plan::tests::adding_a_function_stays_actionable ... ok
[INFO] [stdout] test plan::tests::an_untried_node_outranks_one_that_has_failed ... ok
[INFO] [stdout] test plan::tests::believability_of_an_unknown_node_is_neutral ... ok
[INFO] [stdout] test plan::tests::cited_invariant_takes_the_first_v_id ... ok
[INFO] [stdout] test plan::tests::classify_is_word_order_independent ... ok
[INFO] [stdout] test plan::tests::confidence_degrades_with_distance ... ok
[INFO] [stdout] test plan::tests::every_confidence_states_how_it_fails ... ok
[INFO] [stdout] test plan::tests::horizon_is_short_because_the_state_self_modifies ... ok
[INFO] [stdout] test plan::tests::json_form_is_pinned ... ok
[INFO] [stdout] test plan::tests::json_of_an_empty_plan_keeps_every_key ... ok
[INFO] [stdout] test plan::tests::json_str_escapes_what_rfc_8259_requires ... ok
[INFO] [stdout] test plan::git_tests::a_plan_ranks_what_it_can_act_on_and_counts_what_it_cannot ... ok
[INFO] [stdout] test plan::tests::report_is_not_a_replacement ... ok
[INFO] [stdout] test plan::tests::row_identity_follows_its_text ... ok
[INFO] [stdout] test plan::tests::the_freeze_names_only_real_nodes ... ok
[INFO] [stdout] test plan::tests::triage_never_proposes_moving_a_row_to_where_it_already_is ... ok
[INFO] [stdout] test plan::tests::triage_returns_only_unmanaged_rows ... ok
[INFO] [stdout] test plan::tests::a_frozen_node_is_never_offered_as_a_step ... ok
[INFO] [stdout] test plan::tests::plan_never_exceeds_the_horizon ... ok
[INFO] [stdout] test review::git_tests::an_empty_diff_adds_nothing_without_erroring ... ok
[INFO] [stdout] test review::git_tests::an_unreadable_module_is_an_error_not_a_clean_review ... ok
[INFO] [stdout] test review::git_tests::a_commit_touching_no_module_yields_nothing ... ok
[INFO] [stdout] test review::git_tests::only_added_pub_fns_in_a_module_are_collected ... ok
[INFO] [stdout] test review::tests::a_documented_one_is_not ... ok
[INFO] [stdout] test review::tests::a_fn_the_commit_did_not_add_is_not_judged ... ok
[INFO] [stdout] test review::tests::a_generic_declaration_is_still_a_declaration ... ok
[INFO] [stdout] test review::tests::a_length_check_beside_positional_indexes_names_the_slice_pattern ... ok
[INFO] [stdout] test review::tests::a_long_byte_scanner_names_the_named_boundary_shape ... ok
[INFO] [stdout] test review::tests::a_new_fn_recognising_an_existing_fn_s_markers_is_flagged ... ok
[INFO] [stdout] test review::tests::a_new_pub_fn_without_a_doc_is_flagged ... ok
[INFO] [stdout] test review::tests::a_scalar_returning_fn_is_not_a_detector ... ok
[INFO] [stdout] test review::tests::a_single_index_without_a_length_check_is_not_the_shape ... ok
[INFO] [stdout] test review::tests::a_subprocess_whose_status_is_never_read_is_named ... ok
[INFO] [stdout] test review::tests::accepts_a_detector_with_a_positive_case ... ok
[INFO] [stdout] test review::tests::accepts_a_fn_called_from_a_sibling_node ... ok
[INFO] [stdout] test review::tests::accepts_a_fn_that_uses_every_input ... ok
[INFO] [stdout] test review::tests::accepts_a_fn_the_impl_actually_calls ... ok
[INFO] [stdout] test review::tests::an_attribute_between_the_doc_and_the_fn_still_counts_as_documented ... ok
[INFO] [stdout] test review::tests::an_option_returning_fn_is_still_a_detector ... ok
[INFO] [stdout] test review::tests::calling_the_existing_fn_is_reuse_and_not_a_finding ... ok
[INFO] [stdout] test review::git_tests::added_in_commit_reads_pub_fns_out_of_the_diff ... ok
[INFO] [stdout] test review::tests::every_rule_that_runs_is_named_in_the_report ... ok
[INFO] [stdout] test review::tests::flags_a_fn_only_tests_call ... ok
[INFO] [stdout] test review::tests::flags_a_generic_fn_nothing_calls ... ok
[INFO] [stdout] test review::tests::flags_a_detector_tested_only_on_empty ... ok
[INFO] [stdout] test review::tests::flags_a_new_fn_that_ignores_an_input ... ok
[INFO] [stdout] test review::tests::one_shared_marker_is_below_the_threshold ... ok
[INFO] [stdout] test slice::tests::a_malformed_declaration_is_an_error_not_a_skip ... ok
[INFO] [stdout] test slice::tests::a_rule_matching_nothing_in_real_files_is_an_error ... ok
[INFO] [stdout] test slice::tests::a_source_matching_no_files_is_an_error_not_an_empty_slice ... ok
[INFO] [stdout] test slice::tests::an_unknown_rule_names_the_alternatives ... ok
[INFO] [stdout] test slice::tests::comments_and_blanks_are_skipped ... ok
[INFO] [stdout] test slice::tests::drift_is_reported_per_output_and_a_regenerated_tree_is_clean ... ok
[INFO] [stdout] test slice::tests::fence_takes_the_block_after_its_anchor ... ok
[INFO] [stdout] test slice::tests::lead_skips_the_heading_rather_than_counting_it ... ok
[INFO] [stdout] test slice::tests::lead_takes_the_rule_and_drops_the_justification ... ok
[INFO] [stdout] test slice::tests::prefix_pulls_table_rows ... ok
[INFO] [stdout] test review::git_tests::commit_finds_the_stub_shape_end_to_end ... ok
[INFO] [stdout] test spec::row_tests::a_bracketed_table_row_is_seen_as_unreadable_and_a_real_one_is_not ... ok
[INFO] [stdout] test review::tests::the_crate_source_is_assembled_in_a_stable_order ... ok
[INFO] [stdout] test spec::row_tests::a_declaration_a_namespaced_id_and_a_foreign_rule_are_untouched ... ok
[INFO] [stdout] test slice::tests::section_stops_at_the_next_heading ... ok
[INFO] [stdout] test spec::row_tests::a_milestone_cell_is_carried_as_written_while_its_claim_is_expanded ... ok
[INFO] [stdout] test spec::row_tests::an_already_quoted_id_keeps_one_pair_of_backticks ... ok
[INFO] [stdout] test spec::row_tests::a_row_carries_its_section_and_its_line ... ok
[INFO] [stdout] test spec::row_tests::only_a_line_an_id_opens_is_a_row ... ok
[INFO] [stdout] test spec::row_tests::requalifying_twice_changes_nothing_the_second_time ... ok
[INFO] [stdout] test spec::scaffold_tests::a_childless_directory_gets_no_federation_table ... ok
[INFO] [stdout] test spec::scaffold_tests::a_scaffold_carries_no_ids_at_all ... ok
[INFO] [stdout] test spec::row_tests::a_citation_whose_target_moved_gains_that_node ... ok
[INFO] [stdout] test spec::scaffold_tests::a_scaffold_passes_the_checker_that_gates_every_other_spec ... ok
[INFO] [stdout] test spec::tests::a_bug_citing_an_invariant_is_reflected ... ok
[INFO] [stdout] test spec::scaffold_tests::every_child_gets_a_row_naming_what_it_does_not_own ... ok
[INFO] [stdout] test spec::tests::a_bug_naming_no_invariant_is_unreflected ... ok
[INFO] [stdout] test spec::tests::a_bullet_declares_the_id_it_opens_with ... ok
[INFO] [stdout] test spec::tests::a_finished_task_is_not_remaining_work ... ok
[INFO] [stdout] test spec::tests::a_citation_carries_the_node_path_it_names ... ok
[INFO] [stdout] test spec::tests::a_foreign_rule_is_not_a_citation_here ... ok
[INFO] [stdout] test spec::tests::a_row_is_declared_by_the_line_it_opens ... ok
[INFO] [stdout] test spec::tests::an_archive_stub_is_not_history ... ok
[INFO] [stdout] test spec::tests::check_runs_against_microlith ... ok
[INFO] [stdout] test spec::tests::fmt_is_lossless_and_idempotent ... ok
[INFO] [stdout] test spec::tests::only_the_bugs_section_is_read ... ok
[INFO] [stdout] test spec::tests::sections_split_on_headers ... ok
[INFO] [stdout] test spec::upsert_tests::a_document_without_the_anchor_is_returned_unchanged ... ok
[INFO] [stdout] test spec::upsert_tests::an_absent_section_is_inserted_after_its_anchor ... ok
[INFO] [stdout] test spec::upsert_tests::an_existing_section_is_replaced_and_nothing_else_moves ... ok
[INFO] [stdout] test spec::upsert_tests::upserting_the_same_body_is_idempotent ... ok
[INFO] [stdout] test spec::tests::microlith_is_reached_only_through_its_root ... ok
[INFO] [stdout] test split::split_tests::a_grade_every_module_shares_is_reported_as_ranking_nothing ... ok
[INFO] [stdout] test split::split_tests::a_module_named_by_no_row_is_not_a_candidate ... ok
[INFO] [stdout] test split::split_tests::a_module_that_is_both_a_file_and_a_directory_is_flagged ... ok
[INFO] [stdout] test split::split_tests::a_name_matches_as_a_word_and_not_as_a_substring ... ok
[INFO] [stdout] test spec::tests::every_citation_in_this_repository_resolves ... ok
[INFO] [stdout] test split::structure_tests::a_family_is_proposed_with_the_hub_its_members_share ... ok
[INFO] [stdout] test split::structure_tests::a_family_needs_more_than_a_pair ... ok
[INFO] [stdout] test split::structure_tests::a_shared_hub_is_present_in_every_member ... ok
[INFO] [stdout] test split::structure_tests::an_already_federated_crate_proposes_its_directories ... ok
[INFO] [stdout] test split::tests::propose_decomposes_a_multi_node_row ... ok
[INFO] [stdout] test split::tests::propose_keeps_a_row_with_no_node_vocabulary ... ok
[INFO] [stdout] test split::tests::propose_moves_a_single_node_row ... ok
[INFO] [stdout] test split::weight_tests::a_filename_is_not_a_row_about_the_node_it_spells ... ok
[INFO] [stdout] test split::weight_tests::a_leaf_spec_weighs_nothing_for_its_siblings ... ok
[INFO] [stdout] test cli::propose::tests::split_proposes_nodes_the_spec_never_mentions ... ok
[INFO] [stdout] test cli::check::tests::a_file_within_both_ceilings_is_silent ... ok
[INFO] [stdout] test state::path_tests::a_missing_file_is_a_cold_start_not_an_error ... ok
[INFO] [stdout] test split::weight_tests::generated_navigation_is_not_law_about_a_sibling ... ok
[INFO] [stdout] test split::split_tests::proposals_lead_with_the_heaviest_not_the_alphabetically_first ... ok
[INFO] [stdout] test cli::propose::tests::split_proposes_and_refuses_to_apply ... ok
[INFO] [stdout] test state::path_tests::the_store_lives_in_the_git_dir_not_the_worktree ... ok
[INFO] [stdout] test state::path_tests::two_states_at_different_paths_share_nothing ... ok
[INFO] [stdout] test state::tests::a_key_with_a_space_survives_the_round_trip ... ok
[INFO] [stdout] test state::tests::a_value_may_still_contain_spaces ... ok
[INFO] [stdout] test state::tests::an_ordered_entry_is_findable_by_its_dedup_key ... ok
[INFO] [stdout] test state::path_tests::a_state_remembers_where_it_came_from ... ok
[INFO] [stderr] fatal: not a git repository (or any of the parent directories): .git
[INFO] [stdout] test state::tests::an_ordered_log_resumes_over_keys_written_before_it_existed ... ok
[INFO] [stdout] test cli::check::tests::validate_passes_a_clean_tree_and_fails_a_broken_one ... ok
[INFO] [stdout] test state::tests::clear_kind_removes_only_that_kind ... ok
[INFO] [stdout] test state::tests::content_hash_tracks_content_only ... ok
[INFO] [stdout] test state::tests::counting_a_file_twice_hits_the_cache_and_a_changed_file_misses ... ok
[INFO] [stdout] test state::tests::ordering_is_stable_regardless_of_insertion_order ... ok
[INFO] [stdout] test state::tests::pushing_the_same_entry_twice_changes_nothing ... ok
[INFO] [stdout] test state::tests::round_trips_and_is_idempotent ... ok
[INFO] [stdout] test state::tests::an_unreadable_file_is_an_error_not_a_zero ... ok
[INFO] [stdout] test state::path_tests::the_default_path_is_read_from_the_environment_at_the_edge ... ok
[INFO] [stdout] test state::path_tests::a_repository_names_its_common_dir ... ok
[INFO] [stdout] test tests::path_deps_are_only_what_the_list_records ... ok
[INFO] [stdout] test tokens::tests::a_file_that_cannot_be_read_is_an_error_never_a_zero ... ok
[INFO] [stdout] test tests::a_path_dep_is_seen_and_a_target_path_is_not ... ok
[INFO] [stdout] test tokens::tests::a_missing_file_is_a_cold_start ... ok
[INFO] [stdout] test tokens::tests::an_unparsable_limit_is_an_error_not_a_skip ... ok
[INFO] [stdout] test tokens::tests::ceilings_parse_the_itok_format ... ok
[INFO] [stdout] test cli::measure::tests::a_chain_over_its_ceiling_exits_one_and_a_generous_one_exits_zero ... ok
[INFO] [stdout] test tokens::tests::count_carries_its_method ... ok
[INFO] [stdout] test tokens::tests::a_malformed_ceiling_line_is_named_and_numbered ... ok
[INFO] [stdout] test tokens::tests::working_saturates_when_window_smaller_than_entry ... ok
[INFO] [stdout] test wave::wave_tests::a_cycle_is_reported_rather_than_looped ... ok
[INFO] [stdout] test tokens::tests::longest_prefix_wins ... ok
[INFO] [stdout] test wave::wave_tests::a_node_with_no_sibling_deps_is_ready_and_a_dependent_waits ... ok
[INFO] [stdout] test wave::wave_tests::a_self_edge_is_a_cycle_of_one ... ok
[INFO] [stdout] test wave::wave_tests::a_type_only_edge_is_counted_and_never_scheduled_against ... ok
[INFO] [stdout] test tokens::tests::counting_a_real_file_agrees_with_counting_its_text ... ok
[INFO] [stdout] test wave::wave_tests::depth_and_width_are_pinned_by_a_known_fixture ... ok
[INFO] [stdout] test testrepo::tests::the_fixture_refuses_the_git_environment_a_hook_exports ... ok
[INFO] [stdout] test testrepo::tests::the_fixture_commits_land_in_its_own_repo ... ok
[INFO] [stdout] test wave::wave_tests::a_scoped_wave_drops_an_edge_that_leaves_the_scope ... ok
[INFO] [stdout] test wave::wave_tests::the_federation_table_would_have_scheduled_them_together ... ok
[INFO] [stdout] test wave::wave_tests::the_schedule_follows_the_use_crate_edges ... ok
[INFO] [stdout] test wave::wave_tests::an_import_naming_only_a_type_is_an_edge_and_not_a_wait ... ok
[INFO] [stdout] test cli::check::tests::a_file_in_a_tests_tree_is_measured_as_tests ... ok
[INFO] [stdout] test cli::check::tests::the_code_and_test_halves_have_their_own_ceilings ... ok
[INFO] [stdout] test split::weight_tests::an_existing_node_still_has_a_weight_in_its_parent ... ok
[INFO] [stdout] test cli::check::tests::a_default_ceiling_nobody_set_is_advisory ... ok
[INFO] [stdout] test state::tests::an_ordered_log_keeps_the_newest_not_a_hash_sample ... ok
[INFO] [stdout] test lens::tests::depth_selects_something_or_it_is_a_flag_that_lies ... ok
[INFO] [stdout] test split::split_tests::a_federated_tree_proposes_and_weighs_its_existing_nodes ... ok
[INFO] [stdout] test cli::measure::tests::lens_runs_at_every_depth_and_the_depths_differ ... ok
[INFO] [stdout] test cli::tests::a_dir_with_no_spec_is_a_usage_error_not_a_violation ... ok
[INFO] [stdout] test cli::tests::the_read_only_verbs_succeed_on_this_repo ... ok
[INFO] [stdout] test cli::tests::the_read_only_verbs_all_exit_clean_on_this_repo ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- cli::tests::both_version_spellings_exit_clean_and_name_the_crate_version stdout ----
[INFO] [stdout] sherd 0.5.2
[INFO] [stdout] sherd 0.5.2
[INFO] [stdout] 
[INFO] [stdout] thread 'cli::tests::both_version_spellings_exit_clean_and_name_the_crate_version' (983) panicked at src/cli/tests/dispatch.rs:177:5:
[INFO] [stdout] assertion `left == right` failed: 0.5.2
[INFO] [stdout]   left: Some("0.3")
[INFO] [stdout]  right: Some("0.5.2")
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x645d64925541 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x645d64925541 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x645d64925541 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x645d64925541 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x645d6493ccaa - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x645d6493ccaa - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x645d6492a2cc - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x645d6492a2cc - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x645d648fe0a6 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x645d648fe0a6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x645d6491c6f9 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x645d648759e0 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x645d648759e0 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x645d6491c8b2 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x645d6491c8b2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x645d648fe152 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x645d648f6559 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x645d648fef2d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x645d6493d54c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x645d6493d443 - core[a373ad73a504971]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:447:23
[INFO] [stdout]   20:     0x645d643c05a8 - core[a373ad73a504971]::panicking::assert_failed::<core[a373ad73a504971]::option::Option<&str>, core[a373ad73a504971]::option::Option<&str>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:407:5
[INFO] [stdout]   21:     0x645d644056e9 - sherd[54c7cdaaa83ff335]::cli::tests::both_version_spellings_exit_clean_and_name_the_crate_version
[INFO] [stdout]                                at /opt/rustwide/workdir/src/cli/tests/dispatch.rs:177:5
[INFO] [stdout]   22:     0x645d644008e7 - sherd[54c7cdaaa83ff335]::cli::tests::both_version_spellings_exit_clean_and_name_the_crate_version::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/cli/tests/dispatch.rs:164:66
[INFO] [stdout]   23:     0x645d644c1006 - <sherd[54c7cdaaa83ff335]::cli::tests::both_version_spellings_exit_clean_and_name_the_crate_version::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x645d64868e2b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x645d64868e2b - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   26:     0x645d64876005 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   27:     0x645d64876005 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x645d64876005 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   29:     0x645d64876005 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   30:     0x645d64876005 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x645d64876005 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   32:     0x645d64876005 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   33:     0x645d6486f8f4 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   34:     0x645d6486f8f4 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x645d64879092 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x645d64879092 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x645d64879092 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   38:     0x645d64879092 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   39:     0x645d64879092 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x645d64879092 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x645d64879092 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x645d6492454f - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   43:     0x645d6492454f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   44:     0x70c3c28c9dfa - <unknown>
[INFO] [stdout]   45:     0x70c3c295d3d4 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     cli::tests::both_version_spellings_exit_clean_and_name_the_crate_version
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 360 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 16.26s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "45a6678dad274bd3a5e0d8c2ba0b07f1f3be157889040de25a8a039f1da1f8ff", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "45a6678dad274bd3a5e0d8c2ba0b07f1f3be157889040de25a8a039f1da1f8ff", kill_on_drop: false }`
[INFO] [stdout] 45a6678dad274bd3a5e0d8c2ba0b07f1f3be157889040de25a8a039f1da1f8ff
