[INFO] fetching crate hdrhistogram 7.5.2...
[INFO] testing hdrhistogram-7.5.2 against master#67da586efe13aa66eef576ba095e1875ba65fd20 for pr-112849
[INFO] extracting crate hdrhistogram 7.5.2 into /workspace/builds/worker-0-tc1/source
[INFO] validating manifest of crates.io crate hdrhistogram 7.5.2 on toolchain 67da586efe13aa66eef576ba095e1875ba65fd20
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+67da586efe13aa66eef576ba095e1875ba65fd20" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate hdrhistogram 7.5.2
[INFO] removed 0 missing examples
[INFO] finished tweaking crates.io crate hdrhistogram 7.5.2
[INFO] tweaked toml for crates.io crate hdrhistogram 7.5.2 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] crate crates.io crate hdrhistogram 7.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" "+67da586efe13aa66eef576ba095e1875ba65fd20" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded textwrap v0.15.1
[INFO] [stderr]   Downloaded once_cell v1.14.0
[INFO] [stderr]   Downloaded clap v3.2.22
[INFO] [stderr]   Downloaded rug v1.17.0
[INFO] [stderr]   Downloaded gmp-mpfr-sys v1.4.10
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:19e73879b68f455e41552ea35293514db52ea292d993f571636dbffedb77a1ee" "/opt/rustwide/cargo-home/bin/cargo" "+67da586efe13aa66eef576ba095e1875ba65fd20" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] bb058d92441de36d4ede60702b5f062d32ea736abe1382ddbde437cd9618997a
[INFO] running `Command { std: "docker" "start" "-a" "bb058d92441de36d4ede60702b5f062d32ea736abe1382ddbde437cd9618997a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "bb058d92441de36d4ede60702b5f062d32ea736abe1382ddbde437cd9618997a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bb058d92441de36d4ede60702b5f062d32ea736abe1382ddbde437cd9618997a", kill_on_drop: false }`
[INFO] [stdout] bb058d92441de36d4ede60702b5f062d32ea736abe1382ddbde437cd9618997a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:19e73879b68f455e41552ea35293514db52ea292d993f571636dbffedb77a1ee" "/opt/rustwide/cargo-home/bin/cargo" "+67da586efe13aa66eef576ba095e1875ba65fd20" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 600ad4a9481144f4196c46697a3113d9caa32838c1b040d2ac156e912e14e396
[INFO] running `Command { std: "docker" "start" "-a" "600ad4a9481144f4196c46697a3113d9caa32838c1b040d2ac156e912e14e396", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling crc32fast v1.3.2
[INFO] [stderr]    Compiling crossbeam-utils v0.8.11
[INFO] [stderr]    Compiling once_cell v1.14.0
[INFO] [stderr]    Compiling adler v1.0.2
[INFO] [stderr]    Compiling minimal-lexical v0.2.1
[INFO] [stderr]    Compiling base64 v0.13.0
[INFO] [stderr]    Compiling num-traits v0.2.15
[INFO] [stderr]    Compiling byteorder v1.4.3
[INFO] [stderr]    Compiling miniz_oxide v0.5.4
[INFO] [stderr]    Compiling nom v7.1.1
[INFO] [stderr]    Compiling crossbeam-channel v0.5.6
[INFO] [stderr]    Compiling flate2 v1.0.24
[INFO] [stderr]    Compiling hdrhistogram v7.5.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.56s
[INFO] running `Command { std: "docker" "inspect" "600ad4a9481144f4196c46697a3113d9caa32838c1b040d2ac156e912e14e396", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "600ad4a9481144f4196c46697a3113d9caa32838c1b040d2ac156e912e14e396", kill_on_drop: false }`
[INFO] [stdout] 600ad4a9481144f4196c46697a3113d9caa32838c1b040d2ac156e912e14e396
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:19e73879b68f455e41552ea35293514db52ea292d993f571636dbffedb77a1ee" "/opt/rustwide/cargo-home/bin/cargo" "+67da586efe13aa66eef576ba095e1875ba65fd20" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] adbcdbfe30c7f6fe1622691ad7a8e5ba441cda0af796ccece4a8ca180af983a1
[INFO] running `Command { std: "docker" "start" "-a" "adbcdbfe30c7f6fe1622691ad7a8e5ba441cda0af796ccece4a8ca180af983a1", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.132
[INFO] [stderr]    Compiling gmp-mpfr-sys v1.4.10
[INFO] [stderr]    Compiling indexmap v1.9.1
[INFO] [stderr]    Compiling az v1.2.1
[INFO] [stderr]    Compiling os_str_bytes v6.3.0
[INFO] [stderr]    Compiling rug v1.17.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.16
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling clap_lex v0.2.4
[INFO] [stderr]    Compiling termcolor v1.1.3
[INFO] [stderr]    Compiling textwrap v0.15.1
[INFO] [stderr]    Compiling ieee754 v0.2.6
[INFO] [stderr]    Compiling getrandom v0.2.7
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling clap v3.2.22
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling hdrhistogram v7.5.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3m 55s
[INFO] running `Command { std: "docker" "inspect" "adbcdbfe30c7f6fe1622691ad7a8e5ba441cda0af796ccece4a8ca180af983a1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "adbcdbfe30c7f6fe1622691ad7a8e5ba441cda0af796ccece4a8ca180af983a1", kill_on_drop: false }`
[INFO] [stdout] adbcdbfe30c7f6fe1622691ad7a8e5ba441cda0af796ccece4a8ca180af983a1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:19e73879b68f455e41552ea35293514db52ea292d993f571636dbffedb77a1ee" "/opt/rustwide/cargo-home/bin/cargo" "+67da586efe13aa66eef576ba095e1875ba65fd20" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] b3e212ae606a6d19b69b7bad5481aeb9763cccce48bd0dcdabfdea68a5cfb8ae
[INFO] running `Command { std: "docker" "start" "-a" "b3e212ae606a6d19b69b7bad5481aeb9763cccce48bd0dcdabfdea68a5cfb8ae", kill_on_drop: false }`
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stdout] running 160 tests
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/hdrhistogram-f4d42ad4e4d6ff98)
[INFO] [stdout] test serialization::interval_log::tests::iter_all_ignored_empty_iter ... ok
[INFO] [stdout] test serialization::interval_log::tests::iter_with_ignored_prefix ... ok
[INFO] [stdout] test serialization::interval_log::tests::iter_multiple_entrties_with_interleaved_ignored ... ok
[INFO] [stdout] test serialization::interval_log::tests::parse_base_time ... ok
[INFO] [stdout] test serialization::interval_log::tests::parse_comment ... ok
[INFO] [stdout] test serialization::interval_log::tests::parse_duration_full_ns ... ok
[INFO] [stdout] test serialization::interval_log::tests::parse_duration_scale_ns ... ok
[INFO] [stdout] test serialization::interval_log::tests::parse_duration_too_many_ns ... ok
[INFO] [stdout] test serialization::interval_log::tests::parse_interval_hist_no_tag ... ok
[INFO] [stdout] test serialization::interval_log::tests::parse_interval_hist_with_tag ... ok
[INFO] [stdout] test serialization::interval_log::tests::parse_legend ... ok
[INFO] [stdout] test serialization::interval_log::tests::parse_start_time_with_human_date ... ok
[INFO] [stdout] test serialization::interval_log::tests::parse_start_time_without_human_date ... ok
[INFO] [stdout] test serialization::interval_log::tests::write_base_time ... ok
[INFO] [stdout] test serialization::interval_log::tests::write_comment_newline_wraps ... ok
[INFO] [stdout] test serialization::interval_log::tests::write_comment_control_characters_still_parseable ... ok
[INFO] [stdout] test serialization::interval_log::tests::write_header_comment ... ok
[INFO] [stdout] test serialization::interval_log::tests::write_header_then_interval_comment ... ok
[INFO] [stdout] test serialization::interval_log::tests::write_headers_multiple_times_only_last_is_used ... ok
[INFO] [stdout] test serialization::tests::encode_counts_count_too_big ... ok
[INFO] [stdout] test serialization::interval_log::tests::write_start_time ... ok
[INFO] [stdout] test serialization::tests::encode_counts_first_and_last_count_incremented ... ok
[INFO] [stdout] test serialization::interval_log::tests::write_interval_histo_no_tag ... ok
[INFO] [stdout] test serialization::tests::encode_counts_first_count_incremented ... ok
[INFO] [stdout] test serialization::tests::encode_counts_all_zeros ... ok
[INFO] [stdout] test serialization::interval_log::tests::iter_without_ignored_prefix ... ok
[INFO] [stdout] test serialization::interval_log::tests::write_interval_histo_with_tag ... ok
[INFO] [stdout] test serialization::tests::encode_counts_last_count_incremented ... ok
[INFO] [stdout] test serialization::tests::rand_varint::largest_number_in_7_bit_chunk_correct ... ok
[INFO] [stdout] test serialization::tests::serialize_roundtrip_all_zeros ... ok
[INFO] [stdout] test serialization::tests::serialize_roundtrip_1_count_for_every_value_1_bucket ... ok
[INFO] [stdout] test serialization::tests::serialize_all_zeros ... ok
[INFO] [stdout] test serialization::tests::serialize_roundtrip_1_count_for_every_value_2_buckets ... ok
[INFO] [stdout] test serialization::tests::serialize_roundtrip_random_v2_u16 ... ok
[INFO] [stdout] test serialization::interval_log::tests::duration_fp_roundtrip_accuracy ... ok
[INFO] [stdout] test serialization::tests::varint_read_u64_max ... ok
[INFO] [stdout] test serialization::tests::varint_read_u64_zero ... ok
[INFO] [stdout] test serialization::tests::varint_write_3_bit_value ... ok
[INFO] [stdout] test serialization::tests::varint_write_7_bit_value ... ok
[INFO] [stdout] test serialization::tests::varint_write_9_bit_value ... ok
[INFO] [stdout] test serialization::tests::serialize_roundtrip_random_v2_u32 ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_roundtrip_rand_1_byte ... ok
[INFO] [stdout] test serialization::tests::serialize_roundtrip_random_v2_u64 ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_roundtrip_rand_2_byte ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_roundtrip_rand_3_byte ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_roundtrip_rand_4_byte ... ok
[INFO] [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u16 ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_roundtrip_rand_5_byte ... ok
[INFO] [stdout] test serialization::tests::serialize_roundtrip_random_v2_u8 ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_roundtrip_rand_6_byte ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_1_byte ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_2_byte ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_roundtrip_rand_8_byte ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_3_byte ... ok
[INFO] [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u8 ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_roundtrip_rand_7_byte ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_5_byte ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_4_byte ... ok
[INFO] [stdout] test serialization::tests::varint_write_u64_max ... ok
[INFO] [stdout] test serialization::tests::zig_zag_decode_0 ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_6_byte ... ok
[INFO] [stdout] test serialization::tests::zig_zag_decode_1 ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_9_byte ... ok
[INFO] [stdout] test serialization::tests::zig_zag_decode_u64_max_to_i64_min ... ok
[INFO] [stdout] test serialization::tests::zig_zag_encode_0 ... ok
[INFO] [stdout] test serialization::tests::zig_zag_encode_1 ... ok
[INFO] [stdout] test serialization::tests::zig_zag_encode_i64_max ... ok
[INFO] [stdout] test serialization::tests::zig_zag_decode_u64_max_penultimate_to_i64_max ... ok
[INFO] [stdout] test serialization::tests::zig_zag_encode_i64_min ... ok
[INFO] [stdout] test serialization::tests::zig_zag_decode_2 ... ok
[INFO] [stdout] test tests::correct_original_min ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_7_byte ... ok
[INFO] [stdout] test tests::index_calculation::bucket_for_biggest_value_in_second_bucket ... ok
[INFO] [stdout] test tests::index_calculation::bucket_for_biggest_value_in_first_bucket ... ok
[INFO] [stdout] test tests::index_calculation::bucket_for_smallest_value_in_first_bucket ... ok
[INFO] [stdout] test tests::index_calculation::bucket_for_smallest_value_in_last_bucket ... ok
[INFO] [stdout] test serialization::tests::zig_zag_encode_neg_1 ... ok
[INFO] [stdout] test tests::index_calculation::bucket_for_smallest_value_in_third_bucket ... ok
[INFO] [stdout] test tests::index_calculation::bucket_for_smallest_value_in_second_bucket ... ok
[INFO] [stdout] test tests::index_calculation::index_for_below_smallest ... ok
[INFO] [stdout] test tests::index_calculation::index_for_first_bucket_first_distinguishable_entry ... ok
[INFO] [stdout] test tests::index_calculation::index_for_first_bucket_first_entry ... ok
[INFO] [stdout] test tests::index_calculation::index_for_first_bucket_last_entry ... ok
[INFO] [stdout] test tests::index_calculation::bucket_for_value_below_smallest_clamps_to_zero ... ok
[INFO] [stdout] test tests::index_calculation::bucket_for_value_above_biggest_isnt_clamped_at_max_bucket ... ok
[INFO] [stdout] test tests::index_calculation::index_for_second_bucket_last_entry ... ok
[INFO] [stdout] test tests::index_calculation::index_for_way_past_largest_value_exceeds_length ... ok
[INFO] [stdout] test tests::index_calculation::index_for_second_bucket_last_entry_indistinguishable ... ok
[INFO] [stdout] test tests::index_calculation::index_for_second_bucket_first_entry ... ok
[INFO] [stdout] test tests::index_calculation::sub_bucket_for_biggest_value_in_second_bucket ... ok
[INFO] [stdout] test tests::index_calculation::sub_bucket_for_largest_value_in_first_bucket_unit_magnitude_2 ... ok
[INFO] [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u32 ... ok
[INFO] [stdout] test tests::index_calculation::sub_bucket_for_smaller_than_distinguishable_value_in_first_bucket_unit_magnitude_2 ... ok
[INFO] [stdout] test tests::index_calculation::sub_bucket_for_smallest_distinguishable_value_in_first_bucket ... ok
[INFO] [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_second_bucket_unit_magnitude_2 ... ok
[INFO] [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_second_bucket ... ok
[INFO] [stdout] test tests::index_calculation::sub_bucket_for_largest_value_in_first_bucket ... ok
[INFO] [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_third_bucket ... ok
[INFO] [stdout] test tests::index_calculation::sub_bucket_for_smallest_distinguishable_value_in_first_bucket_unit_magnitude_2 ... ok
[INFO] [stdout] test tests::index_calculation::sub_bucket_for_value_below_smallest_clamps_to_zero ... ok
[INFO] [stdout] test tests::index_calculation::unit_magnitude_0_index_calculations ... ok
[INFO] [stdout] test serialization::tests::zig_zag_roundtrip_random ... ok
[INFO] [stdout] test tests::index_calculation::sub_bucket_for_zero_value_in_first_bucket_unit_magnitude_2 ... ok
[INFO] [stdout] test tests::index_calculation::unit_magnitude_52_sub_bucket_magnitude_11_index_calculations ... ok
[INFO] [stdout] test tests::index_calculation::unit_magnitude_4_index_calculations ... ok
[INFO] [stdout] test tests::index_calculation::unit_magnitude_55_sub_bucket_magnitude_8_ok ... ok
[INFO] [stdout] test tests::index_calculation::unit_magnitude_62_sub_bucket_magnitude_1_ok ... ok
[INFO] [stdout] test tests::index_calculation::unit_magnitude_53_sub_bucket_magnitude_11_throws ... ok
[INFO] [stdout] test tests::init::init_fields_1_bucket_medium_precision ... ok
[INFO] [stdout] test tests::init::init_fields_max_value_0_precision_increased_min_value ... ok
[INFO] [stdout] test tests::init::init_fields_10m_max_1k_min_middle_precision ... ok
[INFO] [stdout] test tests::init::init_fields_max_value_0_precision_most_buckets ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_roundtrip_rand_9_byte ... ok
[INFO] [stdout] test tests::index_calculation::sub_bucket_for_zero_value_in_first_bucket ... ok
[INFO] [stdout] test tests::init::init_fields_max_value_max_unit_magnitude_max_precision ... ok
[INFO] [stdout] test tests::init::init_fields_max_value_max_unit_magnitude_0_precision ... ok
[INFO] [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_8_byte ... ok
[INFO] [stdout] test tests::index_calculation::sub_bucket_for_value_above_biggest_still_works ... ok
[INFO] [stdout] test tests::init::init_fields_smallest_possible_array ... ok
[INFO] [stdout] test tests::init::init_fields_max_value_medium_precision ... ok
[INFO] [stdout] test tests::new_err_high_not_double_low ... ok
[INFO] [stdout] test tests::subtract::subtract_to_zero_counts ... ok
[INFO] [stdout] test tests::subtract::subtract_values_at_extent_of_minuend_nonzero_count_range_recalculates_same_min_max ... ok
[INFO] [stdout] test tests::subtract::subtract_to_negative_counts_error ... ok
[INFO] [stdout] test tests::subtract::subtract_subtrahend_values_outside_minuend_range_error ... ok
[INFO] [stdout] test tests::subtract::subtract_after_add ... ok
[INFO] [stdout] test tests::subtract::subtract_values_at_extent_of_minuend_zero_count_range_recalculates_min_max ... ok
[INFO] [stdout] test tests::subtract::subtract_values_minuend_saturated_total_recalculates_not_saturated ... ok
[INFO] [stdout] test tests::subtract::subtract_values_strictly_inside_minuend_range_yields_same_min_max_no_restat ... ok
[INFO] [stdout] test tests::subtract::subtract_values_minuend_saturated_total_recalculates_saturated ... ok
[INFO] [stdout] test tests::subtract::subtract_values_inside_minuend_range_works ... ok
[INFO] [stdout] test tests::init::init_fields_max_value_max_precision_increased_min_value ... ok
[INFO] [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0 ... ok
[INFO] [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_max_buckets ... ok
[INFO] [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u64 ... ok
[INFO] [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_min_precision_max_buckets ... ok
[INFO] [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_2 ... ok
[INFO] [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_50_max_buckets ... ok
[INFO] [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_2_max_buckets ... ok
[INFO] [stdout] test tests::value_calculation::highest_equivalent_u64_max_value_saturates ... ok
[INFO] [stdout] test tests::init::init_fields_max_value_max_precision_largest_possible_array ... ok
[INFO] [stdout] test tests::value_calculation::lowest_equivalent_unit_magnitude_0 ... ok
[INFO] [stdout] test tests::value_calculation::lowest_equivalent_unit_magnitude_2 ... ok
[INFO] [stdout] test tests::value_calculation::highest_equivalent_unit_magnitude_0 ... ok
[INFO] [stdout] test tests::value_calculation::highest_equivalent_unit_magnitude_2 ... ok
[INFO] [stdout] test tests::value_calculation::next_non_equivalent_unit_magnitude_0 ... ok
[INFO] [stdout] test tests::value_calculation::next_non_equivalent_u64_max_value_saturates ... ok
[INFO] [stdout] test tests::value_calculation::next_non_equivalent_unit_magnitude_2 ... ok
[INFO] [stdout] test tests::value_calculation::value_for_beyond_histogram_max_still_works ... ok
[INFO] [stdout] test tests::value_calculation::value_for_impossible_index ... ok
[INFO] [stdout] test tests::value_calculation::value_for_unit_magnitude_0 ... ok
[INFO] [stdout] test tests::value_calculation::value_for_unit_magnitude_2 ... ok
[INFO] [stdout] test tests::value_calculation::value_from_loc_unit_magnitude_0 ... ok
[INFO] [stdout] test tests::value_calculation::value_from_loc_unit_magnitude_2 ... ok
[INFO] [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_max_precision_max_buckets ... ok
[INFO] [stdout] test tests::value_calculation::value_for_at_each_index ... ok
[INFO] [stdout] test tests::subtract::subtract_values_within_bucket_precision_of_of_minuend_min_recalculates_min_max ... ok
[INFO] [stdout] test tests::subtract::subtract_values_at_minuend_max_recalculates_min_max ... ok
[INFO] [stdout] test tests::subtract::subtract_values_within_bucket_precision_of_of_minuend_max_recalculates_min_max ... ok
[INFO] [stderr]      Running tests/auto_resize.rs (/opt/rustwide/target/debug/deps/auto_resize-54968f4eabab737e)
[INFO] [stdout] test tests::subtract::subtract_values_at_minuend_min_recalculates_min_max ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 160 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.11s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test autosizing_add ... ok
[INFO] [stdout] test can_acess_autoresize_setting ... ok
[INFO] [stdout] test histogram_autosizing ... ok
[INFO] [stdout] test histogram_autosizing_edges ... ok
[INFO] [stdout] test autosizing_across_continuous_range ... ok
[INFO] [stderr]      Running tests/data_access.rs (/opt/rustwide/target/debug/deps/data_access-dda4834f3c4adbfe)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.94s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 26 tests
[INFO] [stdout] test count_at_beyond_max_value ... ok
[INFO] [stdout] test count_between_high_beyond_max ... ok
[INFO] [stdout] test count_between_saturates ... ok
[INFO] [stdout] test count_between_low_and_high_beyond_max ... ok
[INFO] [stdout] test count_between ... ok
[INFO] [stdout] test iter_recorded ... ok
[INFO] [stdout] test get_min_value ... ok
[INFO] [stdout] test get_stdev ... ok
[INFO] [stdout] test count_at ... ok
[INFO] [stdout] test iter_log ... ok
[INFO] [stdout] test iter_all ... ok
[INFO] [stdout] test get_mean ... ok
[INFO] [stdout] test linear_iter_steps ... ok
[INFO] [stdout] test linear_iter_raw ... ok
[INFO] [stdout] test quantile_below_saturates ... ok
[INFO] [stdout] test get_max_value ... ok
[INFO] [stdout] test quantile_below_value_beyond_max ... ok
[INFO] [stdout] test total_count_exceeds_bucket_type ... ok
[INFO] [stdout] test quantile_atorbelow ... ok
[INFO] [stdout] test total_count ... ok
[INFO] [stdout] test quantiles ... ok
[INFO] [stdout] test linear_iter_corrected ... ok
[INFO] [stdout] test quantile_iter ... ok
[INFO] [stdout] test value_duplication ... ok
[INFO] [stdout] test scaling_equivalence ... ok
[INFO] [stdout] test large_quantile ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.32s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/histogram.rs (/opt/rustwide/target/debug/deps/histogram-857743792959e7a9)
[INFO] [stdout] 
[INFO] [stdout] running 37 tests
[INFO] [stdout] test construction_arg_gets ... ok
[INFO] [stdout] test median_equivalent ... ok
[INFO] [stdout] test median_equivalent_doesnt_panic_at_extremes ... ok
[INFO] [stdout] test highest_equivalent ... ok
[INFO] [stdout] test lowest_equivalent ... ok
[INFO] [stdout] test empty_histogram ... ok
[INFO] [stdout] test construction_arg_ranges ... ok
[INFO] [stdout] test equivalent_range ... ok
[INFO] [stdout] test record ... ok
[INFO] [stdout] test record_past_trackable_max ... ok
[INFO] [stdout] test reset ... ok
[INFO] [stdout] test record_in_interval ... ok
[INFO] [stdout] test scaled_equivalent_range ... ok
[INFO] [stdout] test saturating_record ... ok
[INFO] [stdout] test scaled_lowest_equivalent ... ok
[INFO] [stdout] test scaled_median_equivalent ... ok
[INFO] [stdout] test scaled_highest_equivalent ... ok
[INFO] [stdout] test add ... ok
[INFO] [stdout] test subtract_underflow_guarded_by_per_value_count_check ... ok
[INFO] [stdout] test scaled_set_to ... ok
[INFO] [stdout] test clone ... ok
[INFO] [stdout] test total_count_overflow_from_add_different_precision_saturates ... ok
[INFO] [stdout] test total_count_overflow_from_add_same_dimensions_saturates_when_added_to_orig_total_count ... ok
[INFO] [stdout] test total_count_overflow_from_add_same_dimensions_saturates_calculating_other_addend_total ... ok
[INFO] [stdout] test total_count_overflow_from_record_saturates ... ok
[INFO] [stdout] test total_count_overflow_from_add_with_resize_saturates ... ok
[INFO] [stdout] test random_write_full_value_range_precision_0_no_panic ... ok
[INFO] [stdout] test value_count_overflow_from_add_same_dimensions_saturates ... ok
[INFO] [stdout] test value_count_overflow_from_add_with_resize_to_same_dimensions_saturates ... ok
[INFO] [stdout] test value_count_overflow_from_record_autoresize_doesnt_panic_saturates ... ok
[INFO] [stdout] test scaled_clone ... ok
[INFO] [stdout] test value_count_overflow_from_record_saturates_u64 ... ok
[INFO] [stdout] test value_count_overflow_from_add_different_precision_saturates ... ok
[INFO] [stdout] test value_count_overflow_from_record_saturates_u16 ... ok
[INFO] [stdout] test set_to ... ok
[INFO] [stdout] test random_write_middle_of_value_range_precision_3_no_panic ... ok
[INFO] [stdout] test random_write_full_value_range_precision_5_no_panic ... ok
[INFO] [stderr]      Running tests/interval_log.rs (/opt/rustwide/target/debug/deps/interval_log-fafb052bd31cc95b)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 37 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.39s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test tests::parse_sample_tagged_interval_log_interval_count ... ok
[INFO] [stdout] test tests::parse_interval_log_syntax_error_then_returns_none ... ok
[INFO] [stdout] test tests::parse_sample_tagged_interval_log_interval_metadata ... ok
[INFO] [stdout] test tests::parse_sample_tagged_interval_log_rewrite_identical ... ok
[INFO] [stdout] test tests::parse_sample_tagged_interval_log_start_timestamp ... ok
[INFO] [stderr]      Running tests/iterators.rs (/opt/rustwide/target/debug/deps/iterators-9249ad46257e4f96)
[INFO] [stdout] test tests::write_random_histograms_to_interval_log_then_read ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.62s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test iter_linear_count_since_last_iteration_saturates ... ok
[INFO] [stdout] test iter_linear_bucket_values_size_8_all_buckets ... ok
[INFO] [stdout] test iter_all_values_all_buckets_unit_magnitude_2 ... ok
[INFO] [stdout] test iter_all_values_all_buckets ... ok
[INFO] [stdout] test iter_linear_visits_buckets_wider_than_step_size_multiple_times ... ok
[INFO] [stdout] test iter_quantiles_iterates_to_end_skips_intermediate_at_final_value ... ok
[INFO] [stdout] test iter_logarithmic_bucket_values_min_4_base_2_all_buckets ... ok
[INFO] [stdout] test iter_quantiles_iterates_to_quantile_10_as_it_reaches_last_bucket ... ok
[INFO] [stdout] test iter_quantiles_empty ... ok
[INFO] [stdout] test iter_logarithmic_bucket_values_min_1_base_2_all_buckets_unit_magnitude_2 ... ok
[INFO] [stdout] test iter_logarithmic_bucket_values_min_1_base_10_all_buckets ... ok
[INFO] [stdout] test iter_quantiles_saturated_count_before_max_value ... ok
[INFO] [stdout] test iter_recorded_saturated_total_count ... ok
[INFO] [stdout] test iter_recorded_values_all_buckets ... ok
[INFO] [stdout] test iter_recorded_values_all_buckets_unit_magnitude_2 ... ok
[INFO] [stdout] test iter_logarithmic_bucket_values_min_1_base_2_all_buckets ... ok
[INFO] [stdout] test iter_quantiles_one_value ... ok
[INFO] [stdout] test iter_quantiles_smorgasboard ... ok
[INFO] [stdout] test iter_linear_visits_buckets_once_when_step_size_equals_bucket_size ... ok
[INFO] [stdout] test iter_recorded_non_saturated_total_count ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/quantile.rs (/opt/rustwide/target/debug/deps/quantile-6630ebc13bc5e499)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test value_at_quantile_2_values ... ok
[INFO] [stdout] test value_at_quantile_large_numbers ... ok
[INFO] [stdout] test value_at_quantile_5_values ... ok
[INFO] [stdout] test value_at_quantile_internal_count_exceeds_bucket_type ... ok
[INFO] [stdout] test value_at_quantile_20k ... ok
[INFO] [stdout] test value_at_quantile_matches_quantile_iter_sequence_values ... ok
[INFO] [stdout] test value_at_quantile_matches_quantile_at_each_value_sequence_values ... ok
[INFO] [stdout] test value_at_quantile_matches_quantile_iter_random_values ... ok
[INFO] [stdout] test value_at_quantile_matches_random_quantile_random_values ... ok
[INFO] [stdout] test value_at_quantile_matches_quantile_at_each_value_random_values ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 10.34s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/serialization.rs (/opt/rustwide/target/debug/deps/serialization-f5291a6e8b0bed77)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test tests::total_count_overflow_from_deserialize_saturates ... ok
[INFO] [stdout] test tests::serialize_no_compression_matches_java_impl ... ok
[INFO] [stdout] test tests::deserialize_no_compression_matches_java ... ok
[INFO] [stdout] test tests::deserialize_compression_matches_java ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/sync.rs (/opt/rustwide/target/debug/deps/sync-6ab6831fd627b7aa)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test sync::phase_no_wait_after_drop ... ok
[INFO] [stdout] test sync::idle_recorder ... ok
[INFO] [stdout] test sync::record_through ... ok
[INFO] [stdout] test sync::record_nodrop ... ok
[INFO] [stdout] test sync::recorder_drop ... ok
[INFO] [stdout] test sync::recorder_drop_staged ... ok
[INFO] [stdout] test sync::clone_idle_recorder ... ok
[INFO] [stdout] test sync::mt_record_static ... ok
[INFO] [stdout] test sync::concurrent_writes ... ok
[INFO] [stdout] test sync::phase_timeout ... ok
[INFO] [stdout] test sync::refresh_times_out ... ok
[INFO] [stdout] test sync::mt_record_dynamic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.52s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests hdrhistogram
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test src/lib.rs - (line 110) ... ok
[INFO] [stdout] test src/lib.rs - (line 71) ... ok
[INFO] [stdout] test src/lib.rs - Histogram<T>::iter_log (line 1117) ... ok
[INFO] [stdout] test src/lib.rs - Histogram<T>::iter_recorded (line 1155) ... ok
[INFO] [stdout] test src/lib.rs - (line 97) ... ok
[INFO] [stdout] test src/lib.rs - Histogram<T>::iter_all (line 1194) ... ok
[INFO] [stdout] test src/lib.rs - Histogram<T>::iter_linear (line 1059) ... ok
[INFO] [stdout] test src/lib.rs - Histogram<T>::iter_quantiles (line 1001) ... ok
[INFO] [stdout] test src/serialization/mod.rs - serialization (line 75) ... ok
[INFO] [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 122) ... ok
[INFO] [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 145) ... ok
[INFO] [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log::IntervalLogWriter (line 354) ... ok
[INFO] [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 175) ... ok
[INFO] [stdout] test src/serialization/mod.rs - serialization (line 119) ... ok
[INFO] [stdout] test src/serialization/mod.rs - serialization (line 134) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.79s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "b3e212ae606a6d19b69b7bad5481aeb9763cccce48bd0dcdabfdea68a5cfb8ae", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b3e212ae606a6d19b69b7bad5481aeb9763cccce48bd0dcdabfdea68a5cfb8ae", kill_on_drop: false }`
[INFO] [stdout] b3e212ae606a6d19b69b7bad5481aeb9763cccce48bd0dcdabfdea68a5cfb8ae