[INFO] fetching crate rudb-compress 0.8.1...
[INFO] testing rudb-compress-0.8.1 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate rudb-compress 0.8.1 into /workspace/builds/worker-4-tc2/source
[INFO] started tweaking crates.io crate rudb-compress 0.8.1
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate rudb-compress 0.8.1
[INFO] tweaked toml for crates.io crate rudb-compress 0.8.1 written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate rudb-compress 0.8.1 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 rudb-compress 0.8.1 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:32:12
[INFO] [stderr]    |
[INFO] [stderr] 32 | homepage = "https://github.com/tamnd/rudb"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 37 | repository = "https://github.com/tamnd/rudb"
[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: `rudb-compress` (manifest) generated 1 warning
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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] bba8e092a785377a99caed82ed8ea4b39d09d5c485a96775e84cb3956db904d0
[INFO] running `Command { std: "docker" "start" "bba8e092a785377a99caed82ed8ea4b39d09d5c485a96775e84cb3956db904d0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "bba8e092a785377a99caed82ed8ea4b39d09d5c485a96775e84cb3956db904d0", 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" "bba8e092a785377a99caed82ed8ea4b39d09d5c485a96775e84cb3956db904d0" "/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" "bba8e092a785377a99caed82ed8ea4b39d09d5c485a96775e84cb3956db904d0", 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" "bba8e092a785377a99caed82ed8ea4b39d09d5c485a96775e84cb3956db904d0" "/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:32:12
[INFO] [stderr]    |
[INFO] [stderr] 32 | homepage = "https://github.com/tamnd/rudb"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 37 | repository = "https://github.com/tamnd/rudb"
[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: `rudb-compress` (manifest) generated 1 warning
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling siphasher v1.0.3
[INFO] [stderr]    Compiling chrono-tz v0.10.4
[INFO] [stderr]    Compiling phf_shared v0.12.1
[INFO] [stderr]    Compiling phf v0.12.1
[INFO] [stderr]    Compiling chrono v0.4.45
[INFO] [stderr]    Compiling rudb-common v0.8.1
[INFO] [stderr]    Compiling rudb-compress v0.8.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 11.23s
[INFO] running `Command { std: "docker" "inspect" "bba8e092a785377a99caed82ed8ea4b39d09d5c485a96775e84cb3956db904d0", 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" "bba8e092a785377a99caed82ed8ea4b39d09d5c485a96775e84cb3956db904d0" "/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:32:12
[INFO] [stderr]    |
[INFO] [stderr] 32 | homepage = "https://github.com/tamnd/rudb"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 37 | repository = "https://github.com/tamnd/rudb"
[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: `rudb-compress` (manifest) generated 1 warning
[INFO] [stderr]    Compiling rudb-compress v0.8.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.71s
[INFO] running `Command { std: "docker" "inspect" "bba8e092a785377a99caed82ed8ea4b39d09d5c485a96775e84cb3956db904d0", 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" "bba8e092a785377a99caed82ed8ea4b39d09d5c485a96775e84cb3956db904d0" "/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:32:12
[INFO] [stderr]    |
[INFO] [stderr] 32 | homepage = "https://github.com/tamnd/rudb"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 37 | repository = "https://github.com/tamnd/rudb"
[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: `rudb-compress` (manifest) generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/rudb-compress/6a7120b0762d57b9/out/rudb_compress-6a7120b0762d57b9)
[INFO] [stdout] 
[INFO] [stdout] running 68 tests
[INFO] [stdout] test snappy::tests::a_block_whose_elements_produce_less_than_the_header_says_is_an_error ... ok
[INFO] [stdout] test snappy::tests::a_block_refused_for_its_length_leaves_the_buffer_alone ... ok
[INFO] [stdout] test snappy::tests::a_bad_copy_in_the_middle_of_a_long_block_is_an_error_and_not_a_read_before_the_start ... ok
[INFO] [stdout] test snappy::tests::a_buffer_that_already_holds_a_longer_block_does_not_leak_it_into_a_shorter_one ... ok
[INFO] [stdout] test snappy::tests::a_copy_reaching_back_further_than_anything_produced_is_an_error ... ok
[INFO] [stdout] test snappy::tests::a_copy_repeats_what_came_before_it ... ok
[INFO] [stdout] test snappy::tests::a_block_that_is_one_literal_is_that_literal ... ok
[INFO] [stdout] test snappy::tests::a_block_whose_elements_produce_more_than_the_header_says_is_an_error ... ok
[INFO] [stdout] test snappy::tests::a_copy_shorter_than_its_own_length_repeats_the_pattern_it_overlaps ... ok
[INFO] [stdout] test snappy::tests::a_literal_that_runs_past_the_end_of_the_block_is_an_error ... ok
[INFO] [stdout] test snappy::tests::a_one_byte_offset_copy_uses_the_three_offset_bits_in_its_tag ... ok
[INFO] [stdout] test snappy::tests::a_long_literal_takes_its_length_from_the_bytes_after_the_tag ... ok
[INFO] [stdout] test snappy::tests::a_copy_with_an_offset_of_zero_is_an_error_and_not_an_infinite_pattern ... ok
[INFO] [stdout] test snappy::tests::a_corrupt_length_is_refused_rather_than_allocated ... ok
[INFO] [stdout] test snappy::tests::a_run_of_a_thousand_bytes_round_trips_through_the_overlapping_copy_path ... ok
[INFO] [stdout] test snappy::tests::a_short_element_at_the_very_end_of_a_block_takes_the_exact_width_path ... ok
[INFO] [stdout] test snappy::tests::a_short_copy_near_the_end_of_a_block_lands_exactly_where_it_should ... ok
[INFO] [stdout] test snappy::tests::a_varint_that_never_terminates_is_not_a_snappy_block ... ok
[INFO] [stdout] test snappy::tests::an_empty_input_is_not_a_snappy_block_either ... ok
[INFO] [stdout] test snappy::tests::a_short_element_that_writes_wide_has_its_extra_bytes_overwritten ... ok
[INFO] [stdout] test snappy::tests::an_empty_block_decompresses_to_nothing ... ok
[INFO] [stdout] test tests::a_block_that_is_not_the_length_the_metadata_claims_is_an_error ... ok
[INFO] [stdout] test tests::a_codec_number_that_does_not_exist_is_an_error_and_not_a_guess ... ok
[INFO] [stdout] test snappy::tests::the_length_can_be_read_without_decompressing ... ok
[INFO] [stdout] test snappy::tests::an_overlapping_copy_with_a_multi_byte_pattern_repeats_the_whole_pattern ... ok
[INFO] [stdout] test snappy::tests::the_one_byte_offset_copy_form_works ... ok
[INFO] [stdout] test tests::a_codec_we_cannot_read_says_so_by_name ... ok
[INFO] [stdout] test snappy::tests::the_blocks_the_walks_are_compared_on_are_long_enough_to_reach_the_fast_one ... ok
[INFO] [stdout] test tests::an_uncompressed_block_comes_back_as_itself ... ok
[INFO] [stdout] test snappy::tests::the_two_walks_agree_on_every_block ... ok
[INFO] [stdout] test tests::the_codec_numbers_are_the_ones_parquet_writes ... ok
[INFO] [stdout] test zstd::bits::tests::a_forward_reader_takes_the_low_bits_of_the_first_byte_first ... ok
[INFO] [stdout] test snappy::tests::a_short_copy_that_writes_wide_has_its_extra_bytes_overwritten ... ok
[INFO] [stdout] test zstd::bits::tests::a_backward_reader_pads_with_zeros_and_says_that_it_did ... ok
[INFO] [stdout] test tests::what_this_build_can_read_is_answerable_without_trying_it ... ok
[INFO] [stdout] test zstd::bits::tests::a_backward_reader_crosses_a_byte_boundary_the_way_the_encoder_wrote_it ... ok
[INFO] [stdout] test zstd::bits::tests::a_backward_reader_starts_below_the_marker_bit_and_not_at_the_top_of_the_byte ... ok
[INFO] [stdout] test zstd::block::tests::a_plain_offset_pushes_the_three_recent_ones_along ... ok
[INFO] [stdout] test zstd::block::tests::a_sequence_count_grows_its_own_header_as_it_gets_bigger ... ok
[INFO] [stdout] test zstd::block::tests::a_repeat_code_in_a_sequence_with_no_literals_means_the_one_before ... ok
[INFO] [stdout] test zstd::block::tests::the_code_tables_are_as_long_as_the_distributions_that_index_them ... ok
[INFO] [stdout] test zstd::block::tests::the_first_repeat_code_reuses_the_last_offset_and_changes_nothing ... ok
[INFO] [stdout] test zstd::block::tests::the_three_default_distributions_add_up_to_the_tables_they_claim ... ok
[INFO] [stdout] test zstd::fse::tests::a_description_claiming_more_accuracy_than_its_section_allows_is_refused ... ok
[INFO] [stdout] test zstd::checksum::tests::the_empty_input_hashes_the_way_the_specification_says ... ok
[INFO] [stdout] test zstd::checksum::tests::every_length_takes_a_different_path_and_none_of_them_agree_by_accident ... ok
[INFO] [stdout] test zstd::bits::tests::a_forward_reader_that_runs_out_reads_zeros_and_admits_it ... ok
[INFO] [stdout] test zstd::bits::tests::a_last_byte_with_no_marker_is_corruption_rather_than_an_empty_stream ... ok
[INFO] [stdout] test zstd::block::tests::a_code_and_the_next_one_are_a_field_of_extra_bits_apart ... ok
[INFO] [stdout] test zstd::fse::tests::a_table_gives_every_slot_to_exactly_one_symbol ... ok
[INFO] [stdout] test zstd::fse::tests::a_rare_symbol_goes_at_the_top_of_the_table_where_it_costs_the_most_to_reach ... ok
[INFO] [stdout] test zstd::huffman::tests::a_code_wider_than_zstd_allows_is_refused ... ok
[INFO] [stdout] test zstd::huffman::tests::decoding_a_stream_gives_back_what_the_code_says_it_should ... ok
[INFO] [stdout] test zstd::fse::tests::an_rle_table_reads_its_one_symbol_forever_and_costs_nothing ... ok
[INFO] [stdout] test zstd::fse::tests::counts_that_do_not_fill_the_table_are_an_error_rather_than_a_short_table ... ok
[INFO] [stdout] test zstd::huffman::tests::a_direct_description_reads_its_weights_a_nibble_at_a_time_high_half_first ... ok
[INFO] [stdout] test zstd::huffman::tests::the_weight_that_is_not_written_is_the_one_that_completes_the_code ... ok
[INFO] [stdout] test zstd::huffman::tests::weights_that_do_not_complete_a_code_are_refused_rather_than_rounded ... ok
[INFO] [stdout] test zstd::tests::a_frame_that_produces_a_different_length_from_the_one_it_promised_is_an_error ... ok
[INFO] [stdout] test zstd::tests::a_frame_written_against_a_dictionary_is_refused_and_not_decoded_without_one ... ok
[INFO] [stdout] test zstd::tests::a_two_byte_content_size_is_the_number_plus_the_two_hundred_and_fifty_six_it_saves ... ok
[INFO] [stdout] test zstd::tests::a_frame_of_one_raw_block_comes_back_as_itself ... ok
[INFO] [stdout] test zstd::tests::a_skippable_frame_is_stepped_over_rather_than_read ... ok
[INFO] [stdout] test zstd::tests::a_frame_that_says_what_it_hashes_to_is_checked_against_it ... ok
[INFO] [stdout] test zstd::tests::two_frames_one_after_the_other_are_both_read ... ok
[INFO] [stdout] test zstd::tests::a_frame_that_is_not_zstd_says_so_with_the_bytes_it_found ... ok
[INFO] [stdout] test zstd::block::tests::the_third_repeat_code_with_no_literals_is_the_last_offset_less_one ... ok
[INFO] [stdout] test snappy::tests::a_block_larger_than_the_old_constant_is_read_when_its_container_says_so ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 68 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.22s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/real_blocks.rs (/opt/rustwide/target/debug/build/rudb-compress/a3c695c6d5bb4938/out/real_blocks-a3c695c6d5bb4938)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test a_real_block_with_a_byte_changed_is_caught_rather_than_decoded ... ok
[INFO] [stdout] test runs_and_literals_alternating ... ok
[INFO] [stdout] test five_thousand_bytes_a_compressor_could_not_shrink ... ok
[INFO] [stdout] test thirty_runs_of_three_hundred_bytes_each ... ok
[INFO] [stdout] test a_column_of_repeated_urls ... ok
[INFO] [stdout] test a_line_of_text_too_short_to_compress ... ok
[INFO] [stdout] test an_empty_block_from_a_real_compressor ... ok
[INFO] [stdout] test four_kilobytes_of_zeroes ... ok
[INFO] [stdout] test a_real_block_truncated_anywhere_is_an_error_and_never_a_hang ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/real_frames.rs (/opt/rustwide/target/debug/build/rudb-compress/4595160ded2925c0/out/real_frames-4595160ded2925c0)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test five_thousand_bytes_a_compressor_could_not_shrink ... ok
[INFO] [stdout] test a_column_of_repeated_urls ... ok
[INFO] [stdout] test an_empty_frame_from_a_real_compressor ... ok
[INFO] [stdout] test a_line_of_text_too_short_to_compress ... ok
[INFO] [stdout] test runs_and_literals_alternating ... ok
[INFO] [stdout] test four_kilobytes_of_zeroes ... ok
[INFO] [stdout] test a_real_frame_truncated_anywhere_is_an_error_and_never_a_hang ... ok
[INFO] [stdout] test a_frame_that_carries_no_checksum_is_read_and_not_demanded_of ... ok
[INFO] [stdout] test thirty_runs_of_three_hundred_bytes_each ... ok
[INFO] [stdout] test two_frames_in_a_row_are_both_read_and_not_just_the_first ... ok
[INFO] [stdout] test the_same_log_written_by_a_compressor_trying_much_harder ... ok
[INFO] [stdout] test a_log_that_is_longer_than_one_block_holds ... ok
[INFO] [stdout] test a_real_frame_with_a_byte_changed_is_caught_rather_than_decoded ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.19s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests rudb_compress
[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" "bba8e092a785377a99caed82ed8ea4b39d09d5c485a96775e84cb3956db904d0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bba8e092a785377a99caed82ed8ea4b39d09d5c485a96775e84cb3956db904d0", kill_on_drop: false }`
[INFO] [stdout] bba8e092a785377a99caed82ed8ea4b39d09d5c485a96775e84cb3956db904d0
