[INFO] fetching crate waymaker-flash 0.1.0...
[INFO] testing waymaker-flash-0.1.0 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate waymaker-flash 0.1.0 into /workspace/builds/worker-6-tc2/source
[INFO] started tweaking crates.io crate waymaker-flash 0.1.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate waymaker-flash 0.1.0
[INFO] tweaked toml for crates.io crate waymaker-flash 0.1.0 written to /workspace/builds/worker-6-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate waymaker-flash 0.1.0 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 waymaker-flash 0.1.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" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] 2f728039871103c9ae78f9534425f04776686b3a17928dda963d3e57b597f4a3
[INFO] running `Command { std: "docker" "start" "2f728039871103c9ae78f9534425f04776686b3a17928dda963d3e57b597f4a3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2f728039871103c9ae78f9534425f04776686b3a17928dda963d3e57b597f4a3", 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" "2f728039871103c9ae78f9534425f04776686b3a17928dda963d3e57b597f4a3" "/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" "2f728039871103c9ae78f9534425f04776686b3a17928dda963d3e57b597f4a3", 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" "2f728039871103c9ae78f9534425f04776686b3a17928dda963d3e57b597f4a3" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling waymaker-core v0.1.0
[INFO] [stderr]    Compiling waymaker-flash v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.86s
[INFO] running `Command { std: "docker" "inspect" "2f728039871103c9ae78f9534425f04776686b3a17928dda963d3e57b597f4a3", 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" "2f728039871103c9ae78f9534425f04776686b3a17928dda963d3e57b597f4a3" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling waymaker-flash v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.55s
[INFO] running `Command { std: "docker" "inspect" "2f728039871103c9ae78f9534425f04776686b3a17928dda963d3e57b597f4a3", 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" "2f728039871103c9ae78f9534425f04776686b3a17928dda963d3e57b597f4a3" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/waymaker-flash/0f6249b51d5d0f60/out/waymaker_flash-0f6249b51d5d0f60)
[INFO] [stdout] 
[INFO] [stdout] running 30 tests
[INFO] [stdout] test append::tests::a_payload_is_measured_from_the_record_rather_than_from_its_frame ... ok
[INFO] [stdout] test bank::tests::rounding_up_saturates_nowhere_and_refuses_at_the_ceiling ... ok
[INFO] [stdout] test bank::tests::a_program_shift_round_trips_every_granularity_a_device_can_have ... ok
[INFO] [stdout] test append::tests::an_amplification_saturates_rather_than_wrapping ... ok
[INFO] [stdout] test capacity::tests::a_refusal_carries_the_kernels_word_for_itself ... ok
[INFO] [stdout] test crc::tests::a_leading_zero_byte_changes_the_result ... ok
[INFO] [stdout] test crc::tests::crc16_nibble_matches_the_four_round_reduction ... ok
[INFO] [stdout] test crc::tests::both_are_usable_in_a_const_context ... ok
[INFO] [stdout] test crc::tests::crc32_nibble_matches_the_four_round_reduction ... ok
[INFO] [stdout] test crc::tests::crc32_does_not_reduce_to_a_nibble_multiply ... ok
[INFO] [stdout] test capacity::tests::the_floor_is_an_opening_record_one_effect_and_an_exit ... ok
[INFO] [stdout] test crc::tests::every_single_bit_flip_changes_the_result ... ok
[INFO] [stdout] test capacity::tests::what_a_record_owes_is_exactly_one_of_three_answers ... ok
[INFO] [stdout] test crc::tests::the_empty_input_hashes_to_the_initial_value ... ok
[INFO] [stdout] test frame::tests::a_reader_stops_at_the_end_of_its_bytes ... ok
[INFO] [stdout] test crc::tests::crc32_nibble_table_is_every_nibble_with_no_gap_and_no_repeat ... ok
[INFO] [stdout] test crc::tests::each_algorithm_reproduces_its_published_check_value ... ok
[INFO] [stdout] test frame::tests::a_body_splits_into_a_prefix_and_the_callers_bytes ... ok
[INFO] [stdout] test recovery::tests::every_ending_but_a_clean_one_withholds_the_append_offset ... ok
[INFO] [stdout] test capacity::tests::a_bank_the_floor_accepts_can_always_open_the_runs_first_boundary_of_either_kind ... ok
[INFO] [stdout] test capacity::tests::a_zero_length_bound_is_still_a_whole_frame ... ok
[INFO] [stdout] test capacity::tests::every_refusal_has_a_message_of_its_own ... ok
[INFO] [stdout] test frame::tests::version_one_permits_no_skipping ... ok
[INFO] [stderr]      Running tests/append.rs (/opt/rustwide/target/debug/build/waymaker-flash/b52074648dd77a4f/out/append-b52074648dd77a4f)
[INFO] [stdout] test capacity::tests::narrowing_a_value_past_u32_saturates_rather_than_truncating ... ok
[INFO] [stdout] test frame::tests::a_reader_reads_little_endian ... ok
[INFO] [stdout] test recovery::tests::rounding_up_lands_on_the_next_unit ... ok
[INFO] [stdout] test capacity::tests::a_payload_larger_than_its_bound_is_refused_even_when_the_padding_hides_it ... ok
[INFO] [stdout] test recovery::tests::is_erased_agrees_with_the_byte_at_a_time_definition_at_every_length_and_position ... ok
[INFO] [stdout] test swap::tests::a_region_is_inside_the_bank_it_belongs_to_and_no_other ... ok
[INFO] [stdout] test swap::tests::a_region_running_into_the_seal_is_not_inside_the_bank ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 19 tests
[INFO] [stdout] test a_committed_record_is_a_body_a_barrier_a_seal_and_a_barrier ... ok
[INFO] [stdout] test a_commit_barrier_that_fails_does_not_advance_the_writer ... ok
[INFO] [stdout] test a_journal_opens_only_where_a_recovery_said_it_is_safe ... ok
[INFO] [stdout] test a_payload_barrier_that_fails_leaves_nothing_that_can_be_sealed ... ok
[INFO] [stdout] test a_full_journal_refuses_the_next_record_rather_than_wrapping ... ok
[INFO] [stdout] test a_writer_handed_another_device_is_refused_before_a_byte_moves ... ok
[INFO] [stdout] test a_seal_wider_than_the_devices_program_unit_is_written_and_read_back ... ok
[INFO] [stdout] test an_unsealed_tail_with_nothing_programmed_past_its_slot_still_opens ... ok
[INFO] [stdout] test amplification_counts_what_the_device_was_asked_for_and_not_what_it_agreed_to ... ok
[INFO] [stdout] test an_unsealed_tail_with_something_programmed_in_its_slot_still_refuses ... ok
[INFO] [stdout] test a_committed_record_reads_back_through_recovery ... ok
[INFO] [stdout] test amplification_accumulates_over_the_records_a_writer_committed ... ok
[INFO] [stdout] test a_writer_resumes_where_the_last_boot_left_off ... ok
[INFO] [stdout] test a_dropped_stage_ends_the_journal_rather_than_letting_the_next_record_overwrite_it ... ok
[INFO] [stdout] test the_seal_is_one_program_unit_wide_at_every_granularity ... ok
[INFO] [stdout] test a_failed_step_ends_the_journal_whichever_step_it_was ... ok
[INFO] [stderr]      Running tests/bank.rs (/opt/rustwide/target/debug/build/waymaker-flash/b6574a5ee1e26d83/out/bank-b6574a5ee1e26d83)
[INFO] [stdout] test a_page_too_small_for_the_record_is_refused_before_a_byte_moves ... ok
[INFO] [stdout] test a_program_that_fails_does_not_advance_the_writer ... ok
[INFO] [stdout] test a_record_that_does_not_fit_is_refused_before_a_byte_moves ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 51 tests
[INFO] [stdout] test a_bank_whose_seal_fails_validation_is_not_a_candidate_at_any_generation ... ok
[INFO] [stdout] test a_bank_whose_header_and_seal_agree_is_a_candidate ... ok
[INFO] [stdout] test a_device_with_no_valid_seal_has_nothing_to_boot_from ... ok
[INFO] [stdout] test a_header_round_trips_every_field ... ok
[INFO] [stdout] test a_header_is_padded_with_erased_bytes ... ok
[INFO] [stdout] test a_header_sealed_with_one_check_is_refused_by_another ... ok
[INFO] [stdout] test a_length_that_reaches_past_the_bank_is_a_truncation_rather_than_a_read ... ok
[INFO] [stdout] test a_header_from_another_format_version_is_refused_before_its_body_is_read ... ok
[INFO] [stdout] test a_record_frame_is_not_a_bank_header_and_a_bank_header_is_not_a_seal ... ok
[INFO] [stdout] test a_run_input_longer_than_the_length_field_cannot_be_encoded ... ok
[INFO] [stdout] test a_seal_that_does_not_fit_writes_nothing ... ok
[INFO] [stdout] test a_bank_id_has_exactly_one_other ... ok
[INFO] [stdout] test a_layout_hands_back_the_granularity_its_device_programs_at ... ok
[INFO] [stdout] test a_seal_is_padded_to_its_program_unit_with_erased_bytes ... ok
[INFO] [stdout] test a_seal_names_the_digest_the_header_stores_for_itself ... ok
[INFO] [stdout] test a_bank_written_under_one_check_is_no_candidate_under_another ... ok
[INFO] [stdout] test a_seal_round_trips ... ok
[INFO] [stdout] test a_truncated_header_is_truncated_rather_than_corrupt ... ok
[INFO] [stdout] test an_odd_number_of_erase_blocks_still_gives_two_equal_banks ... ok
[INFO] [stdout] test a_seal_shorter_than_its_own_width_is_truncated ... ok
[INFO] [stdout] test a_seal_sealed_with_one_check_is_refused_by_another ... ok
[INFO] [stdout] test a_torn_seal_is_not_a_candidate ... ok
[INFO] [stdout] test a_seal_that_does_not_name_this_header_is_not_a_candidate_at_any_generation ... ok
[INFO] [stdout] test a_device_of_one_erase_block_cannot_hold_two_banks ... ok
[INFO] [stdout] test an_empty_run_input_is_an_ordinary_header ... ok
[INFO] [stdout] test every_single_byte_mutation_of_a_seal_is_caught ... ok
[INFO] [stdout] test a_program_shift_no_device_has_is_refused ... ok
[INFO] [stdout] test every_single_byte_mutation_of_a_header_is_caught ... ok
[INFO] [stdout] test an_erased_seal_region_is_not_a_seal ... ok
[INFO] [stdout] test header_len_of_still_checks_the_prefixs_own_seal ... ok
[INFO] [stdout] test a_device_that_programs_in_units_no_header_can_record_is_refused ... ok
[INFO] [stdout] test a_header_that_does_not_fit_writes_nothing ... ok
[INFO] [stdout] test a_whole_bank_round_trips_through_the_layout_the_header_and_the_scan ... ok
[INFO] [stdout] test a_bank_too_small_for_a_header_a_seal_and_a_record_is_refused ... ok
[INFO] [stdout] test a_bank_bounds_the_run_input_its_header_may_carry ... ok
[INFO] [stdout] test an_erased_bank_has_no_header ... ok
[INFO] [stdout] test every_geometry_a_layout_accepts_has_a_recordable_program_unit ... ok
[INFO] [stdout] test selection_is_total_over_a_bounded_sweep_of_generations ... ok
[INFO] [stdout] test the_highest_valid_seal_wins ... ok
[INFO] [stdout] test the_seal_is_the_bytes_this_test_says_it_is ... ok
[INFO] [stdout] test the_generation_ceiling_is_explicit_rather_than_a_wraparound ... ok
[INFO] [stdout] test header_len_of_answers_from_the_prefix_alone_even_when_the_rest_is_missing ... ok
[INFO] [stdout] test the_header_is_the_bytes_this_test_says_it_is ... ok
[INFO] [stdout] test header_len_of_is_truncated_before_the_prefix_itself_is_whole ... ok
[INFO] [stdout] test the_header_reader_reads_exactly_the_format_versions_the_range_declares ... ok
[INFO] [stdout] test the_layout_error_messages_say_different_things ... ok
[INFO] [stdout] test the_layout_reports_the_geometry_it_was_derived_from ... ok
[INFO] [stdout] test the_seal_is_a_whole_number_of_program_units_at_the_end_of_its_bank ... ok
[INFO] [stdout] test two_banks_at_one_generation_are_ambiguous_rather_than_resolved ... ok
[INFO] [stdout] test two_banks_of_one_erase_block_each_is_the_typical_device ... ok
[INFO] [stdout] test a_run_input_of_exactly_the_length_field_round_trips ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running tests/capacity.rs (/opt/rustwide/target/debug/build/waymaker-flash/5b01cab920eface6/out/capacity-5b01cab920eface6)
[INFO] [stdout] test result: ok. 51 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 31 tests
[INFO] [stdout] test a_bound_no_record_could_carry_is_not_reported_as_a_bank_being_too_small ... ok
[INFO] [stdout] test a_gate_refuses_a_journal_smaller_than_the_one_its_reserve_was_priced_for ... ok
[INFO] [stdout] test a_gate_is_refused_before_it_eats_the_exit_it_owes ... ok
[INFO] [stdout] test a_marker_owes_the_runs_exit_and_no_more ... ok
[INFO] [stdout] test a_marker_is_never_dearer_than_the_schedule_the_floor_priced ... ok
[INFO] [stdout] test a_payload_larger_than_its_bound_is_refused_however_the_padding_falls ... ok
[INFO] [stdout] test a_reserve_is_the_worst_case_outcome_and_the_worst_case_terminal_record ... ok
[INFO] [stdout] test a_reserve_refuses_a_journal_on_another_device ... ok
[INFO] [stdout] test a_refused_schedule_moves_no_byte_and_asks_the_device_for_nothing ... ok
[INFO] [stdout] test a_record_longer_than_the_bounds_the_reserve_was_computed_from_is_refused ... ok
[INFO] [stdout] test a_record_that_exactly_fits_beside_what_it_owes_is_admitted ... ok
[INFO] [stdout] test a_reserve_carries_what_continue_as_new_costs_the_bank_it_rolls_into ... ok
[INFO] [stdout] test a_reserve_refuses_bounds_a_bank_cannot_roll_over_into ... ok
[INFO] [stdout] test a_reserve_refuses_bounds_whose_own_tail_a_bank_could_not_hold ... ok
[INFO] [stdout] test a_reserve_refuses_bounds_whose_run_could_start_and_end_and_never_do_any_work ... ok
[INFO] [stdout] test a_reserve_refuses_a_journal_written_at_another_granularity ... ok
[INFO] [stdout] test a_full_journal_refuses_even_a_terminal_record ... ok
[INFO] [stdout] test a_journal_driven_past_its_capacity_refuses_rather_than_reusing_its_own_bytes ... ok
[INFO] [stdout] test a_reserved_writer_reports_the_same_amplification_the_plain_one_does ... ok
[INFO] [stdout] test a_run_started_at_its_declared_bound_is_admitted_and_priced_from_the_codec ... ok
[INFO] [stdout] test an_admitted_record_always_fits_the_journal_it_was_admitted_for ... ok
[INFO] [stdout] test a_terminal_only_reserve_strands_a_run_with_an_effect_outstanding ... ok
[INFO] [stdout] test every_layout_a_reserve_accepts_can_run_an_effect_end_to_end ... ok
[INFO] [stdout] test what_a_record_still_owes_is_a_function_of_its_kind_alone ... ok
[INFO] [stdout] test a_torn_outcome_at_the_reserve_boundary_still_leaves_room_for_the_retry ... ok
[INFO] [stdout] test scheduling_fails_at_the_reserve_boundary_while_a_terminal_record_still_commits ... ok
[INFO] [stdout] test a_bank_at_the_boundary_still_reads_back_as_the_history_it_committed ... ok
[INFO] [stdout] test a_schedule_admitted_by_a_weaker_reserve_can_strand_a_stricter_retry ... ok
[INFO] [stdout] test continue_as_new_succeeds_from_the_near_capacity_state ... ok
[INFO] [stdout] test the_exit_is_still_open_after_a_reset_at_the_boundary ... ok
[INFO] [stdout] test the_reserve_holds_at_every_program_granularity ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/cold_start.rs (/opt/rustwide/target/debug/build/waymaker-flash/4df3c4c230e455b4/out/cold_start-4df3c4c230e455b4)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test history_that_could_not_have_been_written_is_refused ... ok
[INFO] [stdout] test a_half_programmed_frame_ends_the_prefix_rather_than_being_read ... ok
[INFO] [stdout] test an_effect_appended_past_the_prefix_recovers_under_the_identity_it_was_dispatched_with ... ok
[INFO] [stderr]      Running tests/commit.rs (/opt/rustwide/target/debug/build/waymaker-flash/283c8b170df826f2/out/commit-283c8b170df826f2)
[INFO] [stdout] test a_schedule_frame_that_never_landed_leaves_the_prefix_untouched_and_reports_nothing ... ok
[INFO] [stdout] test an_erased_journal_replays_as_a_run_that_has_not_started ... ok
[INFO] [stdout] test a_frame_damaged_in_its_payload_ends_the_prefix_where_the_damage_starts ... ok
[INFO] [stdout] test a_cold_boot_selects_a_bank_recovers_its_prefix_and_replays_it ... ok
[INFO] [stdout] test a_recovered_prefix_replays_to_the_first_unresolved_effect ... ok
[INFO] [stdout] test an_out_of_sequence_frame_stops_a_cold_boot_and_withholds_the_append_point ... ok
[INFO] [stdout] test a_recovered_prefix_stops_at_a_terminal_record ... ok
[INFO] [stdout] test the_digest_a_schedule_records_is_the_one_replay_will_compare ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test a_scan_refuses_an_unsealed_frame_with_something_programmed_in_its_slot ... ok
[INFO] [stdout] test a_record_is_its_padded_body_and_one_program_unit_of_seal ... ok
[INFO] [stdout] test no_byte_of_a_commit_seal_is_ever_erased ... ok
[INFO] [stdout] test a_seal_holds_only_over_the_frame_check_it_was_computed_for ... ok
[INFO] [stdout] test encode_writes_the_body_and_then_the_seal ... ok
[INFO] [stdout] test a_scan_walks_a_sealed_record_and_ends_cleanly ... ok
[INFO] [stdout] test every_torn_seal_is_refused ... ok
[INFO] [stdout] test a_scan_ignores_a_frame_whose_seal_never_landed_and_ends_where_its_slot_did ... ok
[INFO] [stdout] test a_scan_still_refuses_a_frame_sealed_for_a_different_frame ... ok
[INFO] [stderr]      Running tests/corpus.rs (/opt/rustwide/target/debug/build/waymaker-flash/7c5174e45b7df94d/out/corpus-7c5174e45b7df94d)
[INFO] [stdout] test a_journal_with_no_room_for_a_seal_is_a_truncation ... ok
[INFO] [stdout] test a_seal_of_no_bytes_seals_nothing ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test the_corpus_directory_holds_exactly_the_cases_the_table_names ... ok
[INFO] [stdout] test the_corpus_is_read_at_the_format_version_it_was_written_at ... ok
[INFO] [stdout] test the_sample_list_holds_one_record_of_every_variant ... ok
[INFO] [stdout] test every_byte_a_reader_reads_is_covered_by_a_check ... ok
[INFO] [stdout] test every_corpus_file_decodes_to_the_record_the_table_names ... ok
[INFO] [stdout] test re_encoding_every_corpus_case_reproduces_its_bytes ... ok
[INFO] [stdout] test every_record_kind_this_firmware_writes_has_a_corpus_case ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/frame.rs (/opt/rustwide/target/debug/build/waymaker-flash/21ff768a3831314b/out/frame-21ff768a3831314b)
[INFO] [stdout] 
[INFO] [stdout] running 55 tests
[INFO] [stdout] test a_firing_carries_no_payload_at_all ... ok
[INFO] [stdout] test a_clock_kind_number_no_firmware_wrote_is_a_malformed_record ... ok
[INFO] [stdout] test a_body_that_does_not_fit_its_kind_is_refused ... ok
[INFO] [stdout] test a_clock_kind_the_decoder_refuses_is_a_clock_kind_the_encoder_refuses ... ok
[INFO] [stdout] test a_decoded_record_borrows_the_callers_page ... ok
[INFO] [stdout] test a_run_scoped_record_may_not_carry_an_effect_sequence ... ok
[INFO] [stdout] test a_scan_at_the_wrong_alignment_refuses_rather_than_reporting_a_clean_end ... ok
[INFO] [stdout] test a_scan_at_a_larger_alignment_than_the_writer_used_is_caught_by_the_seal ... ok
[INFO] [stdout] test a_scan_of_an_empty_or_erased_journal_yields_nothing ... ok
[INFO] [stdout] test a_scan_will_not_skip_an_unknown_kind ... ok
[INFO] [stdout] test a_header_says_how_long_its_frame_is_before_the_payload_is_in_hand ... ok
[INFO] [stdout] test a_scan_reads_its_slice_as_the_whole_journal ... ok
[INFO] [stdout] test a_scan_survives_a_journal_that_ends_mid_frame ... ok
[INFO] [stdout] test a_scheduled_timer_body_is_refused_at_every_other_length ... ok
[INFO] [stdout] test a_header_length_is_computed_by_whichever_check_the_caller_asked_for ... ok
[INFO] [stdout] test a_marker_carries_its_sequence_in_the_frame_header ... ok
[INFO] [stdout] test a_header_shorter_than_a_header_declares_no_length ... ok
[INFO] [stdout] test a_torn_short_header_at_the_end_of_a_journal_is_not_a_clean_end ... ok
[INFO] [stdout] test a_header_that_is_not_one_declares_no_length ... ok
[INFO] [stdout] test a_scan_walks_padded_frames_and_stops_at_the_erased_tail ... ok
[INFO] [stdout] test a_frame_whose_header_contains_an_erased_byte_is_still_a_frame ... ok
[INFO] [stdout] test a_scan_stops_at_the_first_damaged_frame_and_reports_where ... ok
[INFO] [stdout] test an_unknown_kind_is_self_delimiting ... ok
[INFO] [stdout] test a_frame_whose_padding_does_not_fit_the_journal_is_a_truncation ... ok
[INFO] [stdout] test a_truncated_frame_is_refused_at_every_length ... ok
[INFO] [stdout] test every_gate_and_every_version_a_u16_can_hold_round_trips ... ok
[INFO] [stdout] test a_version_marker_body_is_refused_at_every_other_length ... ok
[INFO] [stdout] test an_alignment_must_be_a_power_of_two ... ok
[INFO] [stdout] test an_input_digest_is_what_a_schedule_record_carries ... ok
[INFO] [stdout] test an_unsupported_format_version_is_refused ... ok
[INFO] [stdout] test rounding_up_lands_on_the_next_program_unit ... ok
[INFO] [stdout] test the_corpus_agrees_with_the_golden_frame_it_overlaps ... ok
[INFO] [stdout] test the_frame_constants_are_the_ones_section_09_states ... ok
[INFO] [stdout] test the_encoder_writes_the_golden_frames_byte_for_byte ... ok
[INFO] [stdout] test the_golden_frames_decode_to_the_records_they_were_built_from ... ok
[INFO] [stdout] test encode_refuses_an_output_buffer_one_byte_short ... ok
[INFO] [stdout] test every_decodable_record_kind_decodes_to_a_record ... ok
[INFO] [stdout] test encode_and_encoded_len_together_tell_a_retryable_failure_from_a_permanent_one ... ok
[INFO] [stdout] test the_sweep_draws_every_record_variant ... ok
[INFO] [stdout] test the_tests_own_checksums_reproduce_the_published_check_values ... ok
[INFO] [stdout] test the_written_version_is_one_the_range_reads ... ok
[INFO] [stdout] test a_header_length_agrees_with_the_decoder_at_every_payload_length ... ok
[INFO] [stdout] test padding_is_written_erased_and_never_read_back ... ok
[INFO] [stdout] test the_golden_frames_hold_the_fields_section_09_puts_at_those_offsets ... ok
[INFO] [stdout] test the_decoder_reads_exactly_the_format_versions_the_range_declares ... ok
[INFO] [stdout] test no_format_version_permits_skipping_an_unknown_kind_yet ... ok
[INFO] [stdout] test encode_refuses_a_payload_the_length_field_cannot_describe ... ok
[INFO] [stdout] test the_largest_program_granularities_round_trip_and_scan ... ok
[INFO] [stdout] test damaging_a_frame_without_resealing_it_is_always_caught ... ok
[INFO] [stdout] test the_longest_frame_round_trips ... ok
[INFO] [stdout] test a_scan_always_terminates_and_advances ... ok
[INFO] [stdout] test a_single_bit_flip_anywhere_in_a_frame_is_refused ... ok
[INFO] [stdout] test arbitrary_bytes_are_never_a_record_and_never_panic ... ok
[INFO] [stdout] test every_record_round_trips_at_every_alignment ... ok
[INFO] [stdout] test resealing_a_damaged_frame_reaches_every_check_past_the_checksums ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 55 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.33s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integrity.rs (/opt/rustwide/target/debug/build/waymaker-flash/5591c3fdcdf28d00/out/integrity-5591c3fdcdf28d00)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test a_frame_sealed_by_one_check_is_refused_by_the_other ... ok
[INFO] [stdout] test a_torn_write_leaves_the_committed_prefix_of_earlier_records_intact ... ok
[INFO] [stdout] test a_resealed_forgery_is_accepted_because_a_crc_is_not_authentication ... ok
[INFO] [stdout] test a_stale_erased_tail_is_the_end_of_history_and_a_programmed_one_is_not ... ok
[INFO] [stdout] test an_input_digest_is_the_frame_check_of_whatever_seals_the_frame ... ok
[INFO] [stdout] test a_swapped_integrity_check_round_trips_through_the_whole_codec ... ok
[INFO] [stdout] test only_the_header_seal_can_catch_a_header_edit_that_was_resealed_at_the_frame ... ok
[INFO] [stdout] test damage_in_a_frames_padding_is_not_caught ... ok
[INFO] [stdout] test every_candidate_computes_the_same_crc32c ... ok
[INFO] [stdout] test a_wrong_magic_is_refused_even_when_both_seals_hold ... ok
[INFO] [stdout] test an_erased_page_and_a_zeroed_page_are_never_records ... ok
[INFO] [stdout] test the_default_codec_is_the_shipped_check_and_nothing_else ... ok
[INFO] [stdout] test the_checksum_widths_are_the_ones_the_frame_freezes ... ok
[INFO] [stdout] test the_header_seal_is_the_header_check_and_the_frame_seal_is_the_frame_check ... ok
[INFO] [stdout] test the_rejected_candidate_reproduces_its_published_check_value ... ok
[INFO] [stdout] test the_shipped_check_is_the_catalogued_pair_adr_0010_settled ... ok
[INFO] [stdout] test a_write_torn_inside_a_program_unit_is_never_read_as_a_record ... ok
[INFO] [stdout] test burst_errors_are_caught_exhaustively_to_nine_bits_and_sampled_to_thirty_two ... ok
[INFO] [stdout] test a_write_torn_at_a_program_unit_boundary_is_never_read_as_a_record ... ok
[INFO] [stdout] test every_bit_a_partial_program_could_clear_is_caught ... ok
[INFO] [stderr]      Running tests/recovery.rs (/opt/rustwide/target/debug/build/waymaker-flash/450df7d8ca36f8c9/out/recovery-450df7d8ca36f8c9)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.20s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 30 tests
[INFO] [stdout] test a_bank_whose_header_fills_it_has_no_journal ... ok
[INFO] [stdout] test a_device_that_cannot_be_read_ends_a_recovery_without_a_prefix_or_an_offset ... ok
[INFO] [stdout] test a_page_that_is_not_whole_read_units_is_used_down_to_the_unit ... ok
[INFO] [stdout] test a_recovery_refuses_a_device_its_region_was_not_validated_against ... ok
[INFO] [stdout] test a_journal_region_is_the_bytes_between_a_banks_header_and_its_seal ... ok
[INFO] [stdout] test a_bank_whose_header_leaves_exactly_no_journal_is_refused_too ... ok
[INFO] [stdout] test a_read_that_fails_mid_scan_ends_a_recovery_after_a_short_prefix ... ok
[INFO] [stdout] test a_region_refuses_what_the_device_would_refuse ... ok
[INFO] [stdout] test a_frame_the_page_cannot_hold_stops_recovery_without_calling_it_damage ... ok
[INFO] [stdout] test a_full_journal_appends_at_its_end_and_a_caller_finds_no_room ... ok
[INFO] [stdout] test a_hole_in_a_journal_is_not_the_end_of_it ... ok
[INFO] [stdout] test a_recovery_at_a_wider_read_unit_still_stops_where_a_scan_does ... ok
[INFO] [stdout] test a_recovery_never_reads_outside_the_region_it_was_given ... ok
[INFO] [stdout] test a_frame_exactly_the_size_of_the_page_is_read_rather_than_refused ... ok
[INFO] [stdout] test a_journal_that_stopped_at_damage_has_no_append_offset ... ok
[INFO] [stdout] test a_recovery_with_the_wrong_check_stops_at_the_first_frame ... ok
[INFO] [stdout] test a_region_a_driver_could_read_but_never_program_is_refused ... ok
[INFO] [stdout] test a_short_tail_that_is_not_erased_is_a_torn_header ... ok
[INFO] [stdout] test a_region_refuses_a_granularity_the_device_cannot_program_at ... ok
[INFO] [stdout] test every_offset_a_recovery_reports_is_relative_to_its_region ... ok
[INFO] [stdout] test every_recovery_error_is_a_distinct_shape ... ok
[INFO] [stdout] test an_append_offset_is_only_ever_erased_media ... ok
[INFO] [stdout] test an_erased_journal_recovers_nothing_and_appends_at_its_first_byte ... ok
[INFO] [stdout] test every_region_error_says_something_different ... ok
[INFO] [stdout] test an_unknown_record_kind_stops_recovery ... ok
[INFO] [stdout] test recovery_is_a_position_rather_than_a_buffer ... ok
[INFO] [stdout] test recovery_stops_at_a_torn_frame_and_never_reaches_the_valid_one_after_it ... ok
[INFO] [stdout] test the_cost_of_a_record_does_not_depend_on_how_many_came_before_it ... ok
[INFO] [stdout] test a_bank_written_at_another_devices_granularity_is_refused ... ok
[INFO] [stderr]      Running tests/storage.rs (/opt/rustwide/target/debug/build/waymaker-flash/b9129c2dfee1316c/out/storage-b9129c2dfee1316c)
[INFO] [stdout] test a_recovery_reads_what_a_scan_reads ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test an_erase_is_validated_against_the_erase_block_and_the_capacity ... ok
[INFO] [stdout] test a_read_is_validated_against_the_read_unit_and_the_capacity ... ok
[INFO] [stdout] test the_contract_can_be_implemented_from_outside_the_crate_that_declares_it ... ok
[INFO] [stdout] test a_geometry_reports_the_four_units_it_was_built_from ... ok
[INFO] [stdout] test a_unit_that_is_not_a_power_of_two_is_not_a_geometry ... ok
[INFO] [stdout] test an_offset_and_a_length_that_overflow_are_out_of_bounds_rather_than_wrapping ... ok
[INFO] [stdout] test a_zero_unit_is_not_a_geometry ... ok
[INFO] [stdout] test a_program_is_validated_against_the_program_unit_and_the_capacity ... ok
[INFO] [stdout] test every_geometry_error_carries_a_message_and_they_are_all_different ... ok
[INFO] [stdout] test a_capacity_need_not_be_a_power_of_two_as_long_as_it_is_whole_blocks ... ok
[INFO] [stdout] test the_smallest_legal_geometry_is_one_block_of_one_byte ... ok
[INFO] [stdout] test units_that_do_not_nest_are_not_a_geometry ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/swap.rs (/opt/rustwide/target/debug/build/waymaker-flash/c510eecd74a1a38f/out/swap-c510eecd74a1a38f)
[INFO] [stdout] 
[INFO] [stdout] running 22 tests
[INFO] [stdout] test a_swap_error_says_which_refusal_it_is ... ok
[INFO] [stdout] test a_completed_swaps_recovery_reads_back_the_check_it_was_sealed_with ... ok
[INFO] [stdout] test a_swap_refuses_a_device_it_was_not_prepared_with ... ok
[INFO] [stdout] test a_swap_installs_the_next_run_in_the_other_bank_and_makes_it_authoritative ... ok
[INFO] [stdout] test a_swap_refuses_a_generation_that_would_wrap ... ok
[INFO] [stdout] test a_swap_refuses_a_page_too_small_for_the_next_runs_header ... ok
[INFO] [stdout] test a_swap_refuses_a_device_with_no_single_authority ... ok
[INFO] [stdout] test a_swap_refuses_a_reader_validated_against_another_device ... ok
[INFO] [stdout] test a_run_refused_for_capacity_rolls_over_with_the_writer_it_was_refused_on ... ok
[INFO] [stdout] test the_old_run_survives_until_the_lazy_erase_and_is_never_authoritative_after_it ... ok
[INFO] [stdout] test the_old_runs_effect_ids_stay_distinguishable_from_the_new_runs ... ok
[INFO] [stdout] test a_swap_refuses_a_reader_that_is_not_the_bank_it_is_retiring ... ok
[INFO] [stdout] test recovery_never_combines_the_footprints_of_the_two_runs ... ok
[INFO] [stdout] test the_new_run_starts_its_effect_sequence_at_the_first_one ... ok
[INFO] [stdout] test a_swap_refuses_an_input_that_leaves_no_room_for_the_opening_record ... ok
[INFO] [stdout] test a_swap_refuses_a_header_written_at_another_granularity ... ok
[INFO] [stdout] test a_swap_that_fails_at_its_commit_barrier_says_so ... ok
[INFO] [stdout] test a_swap_refuses_to_install_the_run_it_is_replacing ... ok
[INFO] [stdout] test the_installed_journal_is_erased_and_takes_the_new_runs_opening_record ... ok
[INFO] [stdout] test a_swap_that_fails_before_its_seal_leaves_the_old_run_authoritative ... ok
[INFO] [stdout] test the_seven_steps_reach_the_device_in_the_order_the_protocol_states ... ok
[INFO] [stdout] test an_installed_run_can_write_the_opening_record_it_must_write ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests waymaker_flash
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test src/append.rs - append (line 28) ... ok
[INFO] [stdout] test src/swap.rs - swap (line 32) ... ok
[INFO] [stdout] test src/recovery.rs - recovery::Recovery (line 571) ... 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 5 tests
[INFO] [stdout] test src/swap.rs - swap (line 60) - compile fail ... ok
[INFO] [stdout] test src/append.rs - append (line 59) - compile fail ... ok
[INFO] [stdout] test src/append.rs - append (line 36) - compile fail ... ok
[INFO] [stdout] test src/swap.rs - swap (line 40) - compile fail ... ok
[INFO] [stdout] test src/recovery.rs - recovery::Recovery (line 579) - compile fail ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.15s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.47s; merged doctests compilation took 0.31s
[INFO] running `Command { std: "docker" "inspect" "2f728039871103c9ae78f9534425f04776686b3a17928dda963d3e57b597f4a3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2f728039871103c9ae78f9534425f04776686b3a17928dda963d3e57b597f4a3", kill_on_drop: false }`
[INFO] [stdout] 2f728039871103c9ae78f9534425f04776686b3a17928dda963d3e57b597f4a3
