[INFO] fetching crate yo-format 0.3.33...
[INFO] testing yo-format-0.3.33 against 1.99.0-beta.8 for beta-1.100-2
[INFO] extracting crate yo-format 0.3.33 into /workspace/builds/worker-5-tc1/source
[INFO] started tweaking crates.io crate yo-format 0.3.33
[INFO] finished tweaking crates.io crate yo-format 0.3.33
[INFO] tweaked toml for crates.io crate yo-format 0.3.33 written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate yo-format 0.3.33 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate yo-format 0.3.33 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-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] f298474367dd523e4f925e1c1a0f34d396f8c389c71caa039ab93996ffa2f675
[INFO] running `Command { std: "docker" "start" "f298474367dd523e4f925e1c1a0f34d396f8c389c71caa039ab93996ffa2f675", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f298474367dd523e4f925e1c1a0f34d396f8c389c71caa039ab93996ffa2f675", 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" "f298474367dd523e4f925e1c1a0f34d396f8c389c71caa039ab93996ffa2f675" "/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" "f298474367dd523e4f925e1c1a0f34d396f8c389c71caa039ab93996ffa2f675", 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" "f298474367dd523e4f925e1c1a0f34d396f8c389c71caa039ab93996ffa2f675" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling yo-common v0.3.33
[INFO] [stderr]    Compiling yo-alloc v0.3.33
[INFO] [stderr]    Compiling yo-format v0.3.33 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.22s
[INFO] running `Command { std: "docker" "inspect" "f298474367dd523e4f925e1c1a0f34d396f8c389c71caa039ab93996ffa2f675", 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" "f298474367dd523e4f925e1c1a0f34d396f8c389c71caa039ab93996ffa2f675" "/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 yo-format v0.3.33 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.99s
[INFO] running `Command { std: "docker" "inspect" "f298474367dd523e4f925e1c1a0f34d396f8c389c71caa039ab93996ffa2f675", 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" "f298474367dd523e4f925e1c1a0f34d396f8c389c71caa039ab93996ffa2f675" "/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.01s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/yo_format-a41c91d85e8bd94b)
[INFO] [stdout] 
[INFO] [stdout] running 98 tests
[INFO] [stdout] test catalog::tests::a_value_type_only_means_something_for_the_kv_model ... ok
[INFO] [stdout] test catalog::tests::an_entry_that_claims_to_be_longer_than_its_buffer_is_refused ... ok
[INFO] [stdout] test catalog::tests::an_untagged_collection_is_one_a_resp_client_made ... ok
[INFO] [stdout] test catalog::tests::a_chain_of_entries_walks ... ok
[INFO] [stdout] test catalog::tests::a_flipped_bit_anywhere_in_an_entry_is_caught ... ok
[INFO] [stdout] test catalog::tests::a_two_way_partition_split_is_not_a_thing ... ok
[INFO] [stdout] test catalog::tests::an_entry_round_trips ... ok
[INFO] [stdout] test catalog::tests::a_buffer_with_no_room_says_how_much_it_needed ... ok
[INFO] [stdout] test catalog::tests::a_short_buffer_is_an_error_and_not_a_panic ... ok
[INFO] [stdout] test catalog::tests::partition_counts_are_powers_of_two_from_four_up ... ok
[INFO] [stdout] test catalog::tests::lengths_that_do_not_add_up_are_refused_even_with_a_good_checksum ... ok
[INFO] [stdout] test catalog::tests::the_schema_is_stored_whole_and_not_hashed ... ok
[INFO] [stdout] test catalog::tests::unknown_bytes_are_questions_with_no_answer_rather_than_errors ... ok
[INFO] [stdout] test document::tests::a_container_is_not_walked_here ... ok
[INFO] [stdout] test document::tests::a_scalar_that_lost_bytes_is_corrupt ... ok
[INFO] [stdout] test document::tests::a_value_shorter_than_a_header_is_corrupt ... ok
[INFO] [stdout] test document::tests::every_tag_round_trips_through_its_byte ... ok
[INFO] [stdout] test image::tests::a_root_comes_back_field_for_field ... ok
[INFO] [stdout] test image::tests::a_posting_that_is_not_the_length_it_claims_is_refused ... ok
[INFO] [stdout] test image::tests::the_key_table_walks_back_in_order ... ok
[INFO] [stdout] test image::tests::floats_go_down_and_come_back_bit_for_bit ... ok
[INFO] [stdout] test image::tests::the_partition_table_is_addressed_and_not_walked ... ok
[INFO] [stdout] test document::tests::a_scalar_of_a_length_its_type_cannot_have_is_corrupt ... ok
[INFO] [stdout] test page::tests::a_page_header_round_trips ... ok
[INFO] [stdout] test catalog::tests::type_replies_the_way_redis_replies ... ok
[INFO] [stdout] test document::tests::a_scalar_is_its_header_and_its_payload ... ok
[INFO] [stdout] test page::tests::a_segment_that_is_not_a_log_page_says_so ... ok
[INFO] [stdout] test catalog::tests::the_enums_round_trip_and_stop_where_the_specification_stops ... ok
[INFO] [stdout] test page::tests::a_short_buffer_is_an_error_and_not_a_panic ... ok
[INFO] [stdout] test image::tests::a_root_that_is_not_a_root_is_refused ... ok
[INFO] [stdout] test image::tests::a_partition_is_four_runs_that_do_not_overlap ... ok
[INFO] [stdout] test catalog::tests::every_field_lands_where_the_specification_says ... ok
[INFO] [stdout] test document::tests::an_array_and_an_interned_object_say_so ... ok
[INFO] [stdout] test document::tests::an_unknown_tag_is_corrupt_rather_than_a_guess ... ok
[INFO] [stdout] test image::tests::a_truncated_key_table_stops_rather_than_reading_past_it ... ok
[INFO] [stdout] test page::tests::every_field_lands_where_the_specification_says ... ok
[INFO] [stdout] test image::tests::an_empty_partition_is_a_header_and_nothing_else ... ok
[INFO] [stdout] test page::tests::more_dead_than_written_is_refused ... ok
[INFO] [stdout] test image::tests::the_layout_is_the_one_written_down ... ok
[INFO] [stdout] test page::tests::the_checksum_covers_the_header_and_stops_there ... ok
[INFO] [stdout] test record::tests::a_buffer_with_no_room_says_how_much_it_needed ... ok
[INFO] [stdout] test page::tests::the_compaction_trigger_is_a_dead_fraction_over_a_half ... ok
[INFO] [stdout] test record::tests::a_flipped_bit_anywhere_in_a_checksummed_record_is_caught ... ok
[INFO] [stdout] test record::tests::a_key_larger_than_a_u16_is_refused_rather_than_truncated ... ok
[INFO] [stdout] test record::tests::a_length_that_is_shorter_than_the_header_is_corruption ... ok
[INFO] [stdout] test page::tests::the_magic_reads_as_yolg_in_a_hex_dump ... ok
[INFO] [stdout] test record::tests::a_record_cut_off_by_a_torn_write_is_corruption ... ok
[INFO] [stdout] test record::tests::a_record_round_trips ... ok
[INFO] [stdout] test record::tests::a_record_with_its_checksum_flag_cleared_is_corruption ... ok
[INFO] [stdout] test record::tests::a_ttl_costs_eight_bytes_and_moves_the_key ... ok
[INFO] [stdout] test record::tests::a_tombstone_is_a_record_with_no_value ... ok
[INFO] [stdout] test record::tests::an_unknown_kind_is_skipped_rather_than_refused ... ok
[INFO] [stdout] test record::tests::every_field_lands_where_the_specification_says ... ok
[INFO] [stdout] test record::tests::kinds_round_trip_and_chunks_have_no_key ... ok
[INFO] [stdout] test record::tests::a_zero_length_is_the_end_of_the_log_and_not_an_error ... ok
[INFO] [stdout] test record::tests::len_is_exact_so_a_value_of_any_length_survives ... ok
[INFO] [stdout] test record::tests::the_iterator_reports_where_it_stopped ... ok
[INFO] [stdout] test record::tests::the_stride_is_aligned_even_when_the_length_is_not ... ok
[INFO] [stdout] test record::tests::walking_a_page_by_stride_stays_in_step ... ok
[INFO] [stdout] test superblock::tests::a_checkpoint_entry_round_trips_and_fills_one_cache_line ... ok
[INFO] [stdout] test record::tests::a_header_written_without_the_checksum_flag_gets_one_anyway ... ok
[INFO] [stdout] test superblock::tests::a_file_from_the_future_is_refused_by_name ... ok
[INFO] [stdout] test superblock::tests::a_contiguous_shard_table_costs_four_bytes_per_shard ... ok
[INFO] [stdout] test superblock::tests::a_flipped_bit_in_a_checkpoint_entry_is_caught ... ok
[INFO] [stdout] test superblock::tests::a_nonsense_page_size_is_refused_even_with_a_good_checksum ... ok
[INFO] [stdout] test superblock::tests::a_zero_length_run_is_corruption_and_not_an_infinite_loop ... ok
[INFO] [stdout] test superblock::tests::corruption_is_reported_before_the_version_is_believed ... ok
[INFO] [stdout] test superblock::tests::a_slot_pointing_at_a_shard_that_is_not_there_is_corruption ... ok
[INFO] [stdout] test superblock::tests::a_superblock_round_trips_field_for_field ... ok
[INFO] [stdout] test superblock::tests::a_table_that_does_not_cover_every_slot_is_corruption ... ok
[INFO] [stdout] test superblock::tests::equal_sequence_numbers_pick_a_deterministically ... ok
[INFO] [stdout] test superblock::tests::out_of_order_log_addresses_are_corruption_not_an_empty_log ... ok
[INFO] [stdout] test superblock::tests::every_field_lands_at_the_offset_the_specification_names ... ok
[INFO] [stdout] test superblock::tests::the_worst_case_table_is_refused_rather_than_truncated ... ok
[INFO] [stdout] test superblock::tests::the_higher_sequence_number_wins_and_a_bad_slot_does_not_vote ... ok
[INFO] [stdout] test tests::a_float_goes_down_and_comes_back_bit_for_bit ... ok
[INFO] [stdout] test tests::data_starts_after_both_superblock_slots ... ok
[INFO] [stdout] test tests::the_magic_is_what_the_specification_says ... ok
[INFO] [stdout] test vector::tests::a_vector_comes_back_bit_for_bit ... ok
[INFO] [stdout] test tests::short_reads_give_zero_rather_than_panicking ... ok
[INFO] [stdout] test tests::the_checksum_reads_its_own_field_as_zero ... ok
[INFO] [stdout] test tests::short_writes_do_nothing_rather_than_panicking ... ok
[INFO] [stdout] test vector::tests::a_record_shorter_than_it_claims_is_corrupt ... ok
[INFO] [stdout] test superblock::tests::one_shard_is_one_run ... ok
[INFO] [stdout] test superblock::tests::the_checkpoint_entries_have_to_fit_where_the_header_says_they_do ... ok
[INFO] [stdout] test vector::tests::a_long_vector_is_fine ... ok
[INFO] [stdout] test tests::alignment_rounds_up_and_leaves_aligned_values_alone ... ok
[INFO] [stdout] test vector::tests::reserved_bytes_have_to_be_zero ... ok
[INFO] [stdout] test vector::tests::reading_into_the_wrong_length_says_so ... ok
[INFO] [stdout] test vector::tests::coordinates_can_be_read_one_at_a_time ... ok
[INFO] [stdout] test tests::a_log_page_is_a_whole_number_of_segments_at_every_legal_size ... ok
[INFO] [stdout] test vector::tests::the_element_byte_maps_both_ways ... ok
[INFO] [stdout] test tests::page_sizes_are_powers_of_two_in_range ... ok
[INFO] [stdout] test vector::tests::a_vector_that_is_not_a_vector_is_refused ... ok
[INFO] [stdout] test vector::tests::an_element_type_this_version_does_not_know_is_refused ... ok
[INFO] [stdout] test vector::tests::a_dimension_that_could_not_fit_anywhere_is_refused_before_it_is_believed ... ok
[INFO] [stdout] test tests::round_trips_are_little_endian_on_every_machine ... ok
[INFO] [stdout] test superblock::tests::a_flipped_bit_anywhere_in_the_slot_is_caught ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 98 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.36s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests yo_format
[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" "f298474367dd523e4f925e1c1a0f34d396f8c389c71caa039ab93996ffa2f675", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f298474367dd523e4f925e1c1a0f34d396f8c389c71caa039ab93996ffa2f675", kill_on_drop: false }`
[INFO] [stdout] f298474367dd523e4f925e1c1a0f34d396f8c389c71caa039ab93996ffa2f675
