Dec 15 09:01:28.459 INFO testing hdrhistogram-6.1.1 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 09:01:28.459 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +bd47d6825bf4090517549d33cfef10d3300b4a75-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 15 09:01:28.975 INFO [stdout] a28b72b5607cbb470570009c8856afe94e79bd478c064541f6a73edf0f5035e3
Dec 15 09:01:28.983 INFO running `"docker" "start" "-a" "a28b72b5607cbb470570009c8856afe94e79bd478c064541f6a73edf0f5035e3"`
Dec 15 09:01:30.207 INFO [stderr] usermod: no changes
Dec 15 09:01:30.379 INFO [stderr]    Compiling hdrhistogram v6.1.1 (/source)
Dec 15 09:01:33.180 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.95s
Dec 15 09:01:33.187 INFO [stderr] su: No module specific data is present
Dec 15 09:01:34.374 INFO running `"docker" "inspect" "a28b72b5607cbb470570009c8856afe94e79bd478c064541f6a73edf0f5035e3"`
Dec 15 09:01:34.760 INFO running `"docker" "rm" "-f" "a28b72b5607cbb470570009c8856afe94e79bd478c064541f6a73edf0f5035e3"`
Dec 15 09:01:35.019 INFO [stdout] a28b72b5607cbb470570009c8856afe94e79bd478c064541f6a73edf0f5035e3
Dec 15 09:01:35.029 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +bd47d6825bf4090517549d33cfef10d3300b4a75-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 15 09:01:35.417 INFO [stdout] 091fb353d8e01383ea6f8e4bae0986cc9d886302034399a416e776367f1753b6
Dec 15 09:01:35.421 INFO running `"docker" "start" "-a" "091fb353d8e01383ea6f8e4bae0986cc9d886302034399a416e776367f1753b6"`
Dec 15 09:01:36.562 INFO [stderr] usermod: no changes
Dec 15 09:01:36.711 INFO [stderr]    Compiling gmp-mpfr-sys v1.1.9
Dec 15 09:01:36.711 INFO [stderr]    Compiling rug v1.2.2
Dec 15 09:05:25.937 INFO [stderr]    Compiling hdrhistogram v6.1.1 (/source)
Dec 15 09:05:52.885 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4m 16s
Dec 15 09:05:52.896 INFO [stderr] su: No module specific data is present
Dec 15 09:05:54.141 INFO running `"docker" "inspect" "091fb353d8e01383ea6f8e4bae0986cc9d886302034399a416e776367f1753b6"`
Dec 15 09:05:54.459 INFO running `"docker" "rm" "-f" "091fb353d8e01383ea6f8e4bae0986cc9d886302034399a416e776367f1753b6"`
Dec 15 09:05:54.763 INFO [stdout] 091fb353d8e01383ea6f8e4bae0986cc9d886302034399a416e776367f1753b6
Dec 15 09:05:54.769 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +bd47d6825bf4090517549d33cfef10d3300b4a75-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 15 09:05:55.292 INFO [stdout] ce751853f36fbf501c8fe7a135150adf0f52105d07593d24246f705f266276f6
Dec 15 09:05:55.294 INFO running `"docker" "start" "-a" "ce751853f36fbf501c8fe7a135150adf0f52105d07593d24246f705f266276f6"`
Dec 15 09:05:56.575 INFO [stderr] usermod: no changes
Dec 15 09:05:56.774 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.16s
Dec 15 09:05:56.775 INFO [stderr]      Running /target/debug/deps/hdrhistogram-9050841f5c345560
Dec 15 09:05:56.775 INFO [stdout] 
Dec 15 09:05:56.775 INFO [stdout] running 160 tests
Dec 15 09:05:56.775 INFO [stdout] test serialization::interval_log::tests::parse_duration_full_ns ... ok
Dec 15 09:05:56.775 INFO [stdout] test serialization::interval_log::tests::parse_comment ... ok
Dec 15 09:05:56.775 INFO [stdout] test serialization::interval_log::tests::parse_base_time ... ok
Dec 15 09:05:56.775 INFO [stdout] test serialization::interval_log::tests::iter_without_ignored_prefix ... ok
Dec 15 09:05:56.775 INFO [stdout] test serialization::interval_log::tests::iter_with_ignored_prefix ... ok
Dec 15 09:05:56.775 INFO [stdout] test serialization::interval_log::tests::parse_duration_scale_ns ... ok
Dec 15 09:05:56.775 INFO [stdout] test serialization::interval_log::tests::parse_duration_too_many_ns ... ok
Dec 15 09:05:56.775 INFO [stdout] test serialization::interval_log::tests::parse_interval_hist_no_tag ... ok
Dec 15 09:05:56.775 INFO [stdout] test serialization::interval_log::tests::iter_multiple_entrties_with_interleaved_ignored ... ok
Dec 15 09:05:56.775 INFO [stdout] test serialization::interval_log::tests::parse_interval_hist_with_tag ... ok
Dec 15 09:05:56.775 INFO [stdout] test serialization::interval_log::tests::parse_legend ... ok
Dec 15 09:05:56.790 INFO [stdout] test serialization::interval_log::tests::iter_all_ignored_empty_iter ... ok
Dec 15 09:05:56.791 INFO [stdout] test serialization::interval_log::tests::parse_start_time_with_human_date ... ok
Dec 15 09:05:56.791 INFO [stdout] test serialization::interval_log::tests::parse_start_time_without_human_date ... ok
Dec 15 09:05:56.791 INFO [stdout] test serialization::interval_log::tests::write_base_time ... ok
Dec 15 09:05:56.791 INFO [stdout] test serialization::interval_log::tests::write_comment_control_characters_still_parseable ... ok
Dec 15 09:05:56.791 INFO [stdout] test serialization::interval_log::tests::write_comment_newline_wraps ... ok
Dec 15 09:05:56.791 INFO [stdout] test serialization::interval_log::tests::write_header_comment ... ok
Dec 15 09:05:56.791 INFO [stdout] test serialization::interval_log::tests::write_header_then_interval_comment ... ok
Dec 15 09:05:56.791 INFO [stdout] test serialization::interval_log::tests::write_start_time ... ok
Dec 15 09:05:56.791 INFO [stdout] test serialization::interval_log::tests::write_headers_multiple_times_only_last_is_used ... ok
Dec 15 09:05:56.791 INFO [stdout] test serialization::tests::encode_counts_count_too_big ... ok
Dec 15 09:05:56.799 INFO [stdout] test serialization::tests::encode_counts_all_zeros ... ok
Dec 15 09:05:56.800 INFO [stdout] test serialization::tests::rand_varint::largest_number_in_7_bit_chunk_correct ... ok
Dec 15 09:05:56.800 INFO [stdout] test serialization::interval_log::tests::write_interval_histo_no_tag ... ok
Dec 15 09:05:56.804 INFO [stdout] test serialization::interval_log::tests::write_interval_histo_with_tag ... ok
Dec 15 09:05:56.804 INFO [stdout] test serialization::tests::encode_counts_last_count_incremented ... ok
Dec 15 09:05:56.804 INFO [stdout] test serialization::tests::encode_counts_first_and_last_count_incremented ... ok
Dec 15 09:05:56.818 INFO [stdout] test serialization::tests::serialize_roundtrip_1_count_for_every_value_2_buckets ... ok
Dec 15 09:05:56.819 INFO [stdout] test serialization::tests::serialize_all_zeros ... ok
Dec 15 09:05:56.819 INFO [stdout] test serialization::tests::serialize_roundtrip_1_count_for_every_value_1_bucket ... ok
Dec 15 09:05:56.819 INFO [stdout] test serialization::tests::encode_counts_first_count_incremented ... ok
Dec 15 09:05:56.819 INFO [stdout] test serialization::tests::serialize_roundtrip_all_zeros ... ok
Dec 15 09:05:58.395 INFO [stdout] test serialization::interval_log::tests::duration_fp_roundtrip_accuracy ... ok
Dec 15 09:06:15.175 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u32 ... ok
Dec 15 09:06:15.179 INFO [stdout] test serialization::tests::varint_read_u64_max ... ok
Dec 15 09:06:15.179 INFO [stdout] test serialization::tests::varint_read_u64_zero ... ok
Dec 15 09:06:15.179 INFO [stdout] test serialization::tests::varint_write_3_bit_value ... ok
Dec 15 09:06:15.183 INFO [stdout] test serialization::tests::varint_write_7_bit_value ... ok
Dec 15 09:06:15.187 INFO [stdout] test serialization::tests::varint_write_9_bit_value ... ok
Dec 15 09:06:15.883 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u16 ... ok
Dec 15 09:06:16.066 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_1_byte ... ok
Dec 15 09:06:17.069 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_2_byte ... ok
Dec 15 09:06:17.350 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_3_byte ... ok
Dec 15 09:06:18.255 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_5_byte ... ok
Dec 15 09:06:18.399 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_4_byte ... ok
Dec 15 09:06:18.923 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_6_byte ... ok
Dec 15 09:06:20.063 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_8_byte ... ok
Dec 15 09:06:20.823 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_7_byte ... ok
Dec 15 09:06:21.273 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_1_byte ... ok
Dec 15 09:06:21.515 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u64 ... ok
Dec 15 09:06:21.567 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_9_byte ... ok
Dec 15 09:06:21.911 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u8 ... ok
Dec 15 09:06:21.967 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_2_byte ... ok
Dec 15 09:06:22.275 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_3_byte ... ok
Dec 15 09:06:22.343 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_4_byte ... ok
Dec 15 09:06:22.808 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u64 ... ok
Dec 15 09:06:23.043 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_6_byte ... ok
Dec 15 09:06:23.043 INFO [stdout] test serialization::tests::varint_write_u64_max ... ok
Dec 15 09:06:23.059 INFO [stdout] test serialization::tests::zig_zag_decode_0 ... ok
Dec 15 09:06:23.063 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_5_byte ... ok
Dec 15 09:06:23.063 INFO [stdout] test serialization::tests::zig_zag_decode_1 ... ok
Dec 15 09:06:23.071 INFO [stdout] test serialization::tests::zig_zag_decode_2 ... ok
Dec 15 09:06:23.071 INFO [stdout] test serialization::tests::zig_zag_decode_u64_max_penultimate_to_i64_max ... ok
Dec 15 09:06:23.079 INFO [stdout] test serialization::tests::zig_zag_encode_0 ... ok
Dec 15 09:06:23.119 INFO [stdout] test serialization::tests::zig_zag_decode_u64_max_to_i64_min ... ok
Dec 15 09:06:23.123 INFO [stdout] test serialization::tests::zig_zag_encode_i64_max ... ok
Dec 15 09:06:23.123 INFO [stdout] test serialization::tests::zig_zag_encode_i64_min ... ok
Dec 15 09:06:23.123 INFO [stdout] test serialization::tests::zig_zag_encode_neg_1 ... ok
Dec 15 09:06:23.163 INFO [stdout] test serialization::tests::zig_zag_encode_1 ... ok
Dec 15 09:06:23.163 INFO [stdout] test tests::correct_original_min ... ok
Dec 15 09:06:23.164 INFO [stdout] test tests::index_calculation::bucket_for_biggest_value_in_first_bucket ... ok
Dec 15 09:06:23.165 INFO [stdout] test tests::index_calculation::bucket_for_biggest_value_in_second_bucket ... ok
Dec 15 09:06:23.175 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_first_bucket ... ok
Dec 15 09:06:23.187 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_9_byte ... ok
Dec 15 09:06:23.187 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_last_bucket ... ok
Dec 15 09:06:23.195 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_second_bucket ... ok
Dec 15 09:06:23.197 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_8_byte ... ok
Dec 15 09:06:23.203 INFO [stdout] test tests::index_calculation::bucket_for_value_above_biggest_isnt_clamped_at_max_bucket ... ok
Dec 15 09:06:23.219 INFO [stdout] test tests::index_calculation::index_for_below_smallest ... ok
Dec 15 09:06:23.246 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_third_bucket ... ok
Dec 15 09:06:23.247 INFO [stdout] test tests::index_calculation::index_for_first_bucket_first_distinguishable_entry ... ok
Dec 15 09:06:23.248 INFO [stdout] test tests::index_calculation::index_for_first_bucket_first_entry ... ok
Dec 15 09:06:23.249 INFO [stdout] test tests::index_calculation::index_for_second_bucket_first_entry ... ok
Dec 15 09:06:23.263 INFO [stdout] test tests::index_calculation::index_for_first_bucket_last_entry ... ok
Dec 15 09:06:23.264 INFO [stdout] test tests::index_calculation::index_for_second_bucket_last_entry ... ok
Dec 15 09:06:23.283 INFO [stdout] test tests::index_calculation::index_for_second_bucket_last_entry_indistinguishable ... ok
Dec 15 09:06:23.283 INFO [stdout] test tests::index_calculation::index_for_way_past_largest_value_exceeds_length ... ok
Dec 15 09:06:23.299 INFO [stdout] test tests::index_calculation::sub_bucket_for_largest_value_in_first_bucket ... ok
Dec 15 09:06:23.302 INFO [stdout] test tests::index_calculation::sub_bucket_for_biggest_value_in_second_bucket ... ok
Dec 15 09:06:23.339 INFO [stdout] test tests::index_calculation::sub_bucket_for_largest_value_in_first_bucket_unit_magnitude_2 ... ok
Dec 15 09:06:23.339 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_7_byte ... ok
Dec 15 09:06:23.340 INFO [stdout] test tests::index_calculation::sub_bucket_for_smaller_than_distinguishable_value_in_first_bucket_unit_magnitude_2 ... ok
Dec 15 09:06:23.347 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_distinguishable_value_in_first_bucket_unit_magnitude_2 ... ok
Dec 15 09:06:23.348 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_second_bucket ... ok
Dec 15 09:06:23.348 INFO [stdout] test tests::index_calculation::bucket_for_value_below_smallest_clamps_to_zero ... ok
Dec 15 09:06:23.348 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_second_bucket_unit_magnitude_2 ... ok
Dec 15 09:06:23.349 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_distinguishable_value_in_first_bucket ... ok
Dec 15 09:06:23.349 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_third_bucket ... ok
Dec 15 09:06:23.350 INFO [stdout] test tests::index_calculation::sub_bucket_for_value_above_biggest_still_works ... ok
Dec 15 09:06:23.351 INFO [stdout] test tests::index_calculation::sub_bucket_for_zero_value_in_first_bucket ... ok
Dec 15 09:06:23.366 INFO [stdout] test tests::index_calculation::sub_bucket_for_value_below_smallest_clamps_to_zero ... ok
Dec 15 09:06:23.367 INFO [stdout] test tests::index_calculation::sub_bucket_for_zero_value_in_first_bucket_unit_magnitude_2 ... ok
Dec 15 09:06:23.367 INFO [stdout] test tests::index_calculation::unit_magnitude_53_sub_bucket_magnitude_11_throws ... ok
Dec 15 09:06:23.368 INFO [stdout] test tests::index_calculation::unit_magnitude_55_sub_bucket_magnitude_8_ok ... ok
Dec 15 09:06:23.415 INFO [stdout] test tests::index_calculation::unit_magnitude_52_sub_bucket_magnitude_11_index_calculations ... ok
Dec 15 09:06:23.415 INFO [stdout] test tests::index_calculation::unit_magnitude_4_index_calculations ... ok
Dec 15 09:06:23.415 INFO [stdout] test tests::index_calculation::unit_magnitude_0_index_calculations ... ok
Dec 15 09:06:23.450 INFO [stdout] test tests::index_calculation::unit_magnitude_62_sub_bucket_magnitude_1_ok ... ok
Dec 15 09:06:23.451 INFO [stdout] test tests::init::init_fields_1_bucket_medium_precision ... ok
Dec 15 09:06:23.451 INFO [stdout] test tests::init::init_fields_max_value_0_precision_increased_min_value ... ok
Dec 15 09:06:23.458 INFO [stdout] test tests::init::init_fields_10m_max_1k_min_middle_precision ... ok
Dec 15 09:06:23.459 INFO [stdout] test tests::init::init_fields_max_value_0_precision_most_buckets ... ok
Dec 15 09:06:23.472 INFO [stdout] test tests::init::init_fields_max_value_max_unit_magnitude_0_precision ... ok
Dec 15 09:06:23.522 INFO [stdout] test tests::init::init_fields_max_value_medium_precision ... ok
Dec 15 09:06:23.544 INFO [stdout] test tests::init::init_fields_smallest_possible_array ... ok
Dec 15 09:06:23.570 INFO [stdout] test tests::new_err_high_not_double_low ... ok
Dec 15 09:06:23.724 INFO [stdout] test tests::init::init_fields_max_value_max_unit_magnitude_max_precision ... ok
Dec 15 09:06:23.842 INFO [stdout] test serialization::tests::zig_zag_roundtrip_random ... ok
Dec 15 09:06:23.973 INFO [stdout] test tests::subtract::subtract_subtrahend_values_outside_minuend_range_error ... ok
Dec 15 09:06:24.109 INFO [stdout] test tests::subtract::subtract_to_negative_counts_error ... ok
Dec 15 09:06:24.109 INFO [stdout] test tests::subtract::subtract_after_add ... ok
Dec 15 09:06:24.355 INFO [stdout] test tests::subtract::subtract_to_zero_counts ... ok
Dec 15 09:06:24.422 INFO [stdout] test tests::subtract::subtract_values_at_extent_of_minuend_nonzero_count_range_recalculates_same_min_max ... ok
Dec 15 09:06:24.429 INFO [stdout] test tests::subtract::subtract_values_at_extent_of_minuend_zero_count_range_recalculates_min_max ... ok
Dec 15 09:06:24.804 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u32 ... ok
Dec 15 09:06:24.863 INFO [stdout] test tests::subtract::subtract_values_inside_minuend_range_works ... ok
Dec 15 09:06:24.875 INFO [stdout] test tests::subtract::subtract_values_minuend_saturated_total_recalculates_not_saturated ... ok
Dec 15 09:06:25.155 INFO [stdout] test tests::subtract::subtract_values_minuend_saturated_total_recalculates_saturated ... ok
Dec 15 09:06:25.161 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u8 ... ok
Dec 15 09:06:25.299 INFO [stdout] test tests::subtract::subtract_values_strictly_inside_minuend_range_yields_same_min_max_no_restat ... ok
Dec 15 09:06:25.299 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0 ... ok
Dec 15 09:06:25.307 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_max_buckets ... ok
Dec 15 09:06:25.780 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u16 ... ok
Dec 15 09:06:25.781 INFO [stdout] test tests::init::init_fields_max_value_max_precision_increased_min_value ... ok
Dec 15 09:06:25.799 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_2 ... ok
Dec 15 09:06:25.819 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_min_precision_max_buckets ... ok
Dec 15 09:06:25.823 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_50_max_buckets ... ok
Dec 15 09:06:25.844 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_2_max_buckets ... ok
Dec 15 09:06:25.844 INFO [stdout] test tests::value_calculation::highest_equivalent_unit_magnitude_0 ... ok
Dec 15 09:06:25.847 INFO [stdout] test tests::value_calculation::highest_equivalent_u64_max_value_saturates ... ok
Dec 15 09:06:25.847 INFO [stdout] test tests::value_calculation::highest_equivalent_unit_magnitude_2 ... ok
Dec 15 09:06:25.847 INFO [stdout] test tests::value_calculation::lowest_equivalent_unit_magnitude_0 ... ok
Dec 15 09:06:25.851 INFO [stdout] test tests::value_calculation::lowest_equivalent_unit_magnitude_2 ... ok
Dec 15 09:06:25.867 INFO [stdout] test tests::value_calculation::next_non_equivalent_unit_magnitude_0 ... ok
Dec 15 09:06:25.867 INFO [stdout] test tests::value_calculation::next_non_equivalent_u64_max_value_saturates ... ok
Dec 15 09:06:25.867 INFO [stdout] test tests::value_calculation::next_non_equivalent_unit_magnitude_2 ... ok
Dec 15 09:06:25.867 INFO [stdout] test tests::value_calculation::value_for_beyond_histogram_max_still_works ... ok
Dec 15 09:06:25.908 INFO [stdout] test tests::value_calculation::value_for_impossible_index ... ok
Dec 15 09:06:25.914 INFO [stdout] test tests::value_calculation::value_for_unit_magnitude_0 ... ok
Dec 15 09:06:25.926 INFO [stdout] test tests::value_calculation::value_for_unit_magnitude_2 ... ok
Dec 15 09:06:25.927 INFO [stdout] test tests::value_calculation::value_from_loc_unit_magnitude_0 ... ok
Dec 15 09:06:25.927 INFO [stdout] test tests::value_calculation::value_from_loc_unit_magnitude_2 ... ok
Dec 15 09:06:26.359 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_max_precision_max_buckets ... ok
Dec 15 09:06:26.423 INFO [stdout] test tests::init::init_fields_max_value_max_precision_largest_possible_array ... ok
Dec 15 09:06:26.799 INFO [stdout] test tests::value_calculation::value_for_at_each_index ... ok
Dec 15 09:06:30.099 INFO [stdout] test tests::subtract::subtract_values_within_bucket_precision_of_of_minuend_min_recalculates_min_max ... ok
Dec 15 09:06:33.043 INFO [stdout] test tests::subtract::subtract_values_at_minuend_min_recalculates_min_max ... ok
Dec 15 09:06:34.489 INFO [stdout] test tests::subtract::subtract_values_within_bucket_precision_of_of_minuend_max_recalculates_min_max ... ok
Dec 15 09:06:34.748 INFO [stdout] test tests::subtract::subtract_values_at_minuend_max_recalculates_min_max ... ok
Dec 15 09:06:34.748 INFO [stdout] 
Dec 15 09:06:34.748 INFO [stdout] test result: ok. 160 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:06:34.748 INFO [stdout] 
Dec 15 09:06:34.750 INFO [stderr]      Running /target/debug/deps/auto_resize-9b28231d8d7e5241
Dec 15 09:06:34.752 INFO [stdout] 
Dec 15 09:06:34.752 INFO [stdout] running 4 tests
Dec 15 09:06:34.788 INFO [stdout] test histogram_autosizing ... ok
Dec 15 09:06:34.807 INFO [stdout] test autosizing_add ... ok
Dec 15 09:06:34.807 INFO [stdout] test histogram_autosizing_edges ... ok
Dec 15 09:06:37.475 INFO [stdout] test autosizing_across_continuous_range ... ok
Dec 15 09:06:37.475 INFO [stdout] 
Dec 15 09:06:37.475 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:06:37.475 INFO [stdout] 
Dec 15 09:06:37.475 INFO [stderr]      Running /target/debug/deps/data_access-a9b8209c4431ea97
Dec 15 09:06:37.479 INFO [stdout] 
Dec 15 09:06:37.479 INFO [stdout] running 26 tests
Dec 15 09:06:37.504 INFO [stdout] test count_at_beyond_max_value ... ok
Dec 15 09:06:37.504 INFO [stdout] test count_between_high_beyond_max ... ok
Dec 15 09:06:37.504 INFO [stdout] test count_between_low_and_high_beyond_max ... ok
Dec 15 09:06:37.520 INFO [stdout] test count_between_saturates ... ok
Dec 15 09:06:37.663 INFO [stdout] test get_mean ... ok
Dec 15 09:06:37.717 INFO [stdout] test count_at ... ok
Dec 15 09:06:37.717 INFO [stdout] test get_min_value ... ok
Dec 15 09:06:37.717 INFO [stdout] test iter_all ... ok
Dec 15 09:06:37.717 INFO [stdout] test get_max_value ... ok
Dec 15 09:06:37.717 INFO [stdout] test linear_iter_steps ... ok
Dec 15 09:06:37.731 INFO [stdout] test count_between ... ok
Dec 15 09:06:37.763 INFO [stdout] test iter_log ... ok
Dec 15 09:06:37.763 INFO [stdout] test quantile_below_saturates ... ok
Dec 15 09:06:37.810 INFO [stdout] test quantile_below_value_beyond_max ... ok
Dec 15 09:06:37.819 INFO [stdout] test get_stdev ... ok
Dec 15 09:06:37.823 INFO [stdout] test iter_recorded ... ok
Dec 15 09:06:37.831 INFO [stdout] test linear_iter_raw ... ok
Dec 15 09:06:37.883 INFO [stdout] test total_count_exceeds_bucket_type ... ok
Dec 15 09:06:37.920 INFO [stdout] test quantile_atorbelow ... ok
Dec 15 09:06:37.965 INFO [stdout] test linear_iter_corrected ... ok
Dec 15 09:06:37.965 INFO [stdout] test quantiles ... ok
Dec 15 09:06:37.995 INFO [stdout] test total_count ... ok
Dec 15 09:06:38.042 INFO [stdout] test quantile_iter ... ok
Dec 15 09:06:38.064 INFO [stdout] test scaling_equivalence ... ok
Dec 15 09:06:38.093 INFO [stdout] test value_duplication ... ok
Dec 15 09:06:38.511 INFO [stdout] test large_quantile ... ok
Dec 15 09:06:38.511 INFO [stdout] 
Dec 15 09:06:38.511 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:06:38.511 INFO [stdout] 
Dec 15 09:06:38.516 INFO [stderr]      Running /target/debug/deps/histogram-29ac5fae954934af
Dec 15 09:06:38.523 INFO [stdout] 
Dec 15 09:06:38.523 INFO [stdout] running 37 tests
Dec 15 09:06:38.523 INFO [stdout] test empty_histogram ... ok
Dec 15 09:06:38.523 INFO [stdout] test construction_arg_ranges ... ok
Dec 15 09:06:38.531 INFO [stdout] test lowest_equivalent ... ok
Dec 15 09:06:38.531 INFO [stdout] test highest_equivalent ... ok
Dec 15 09:06:38.547 INFO [stdout] test equivalent_range ... ok
Dec 15 09:06:38.564 INFO [stdout] test construction_arg_gets ... ok
Dec 15 09:06:38.646 INFO [stdout] test median_equivalent ... ok
Dec 15 09:06:38.647 INFO [stdout] test record ... ok
Dec 15 09:06:38.647 INFO [stdout] test record_past_trackable_max ... ok
Dec 15 09:06:38.647 INFO [stdout] test add ... ok
Dec 15 09:06:38.647 INFO [stdout] test median_equivalent_doesnt_panic_at_extremes ... ok
Dec 15 09:06:38.647 INFO [stdout] test record_in_interval ... ok
Dec 15 09:06:38.647 INFO [stdout] test scaled_equivalent_range ... ok
Dec 15 09:06:38.647 INFO [stdout] test reset ... ok
Dec 15 09:06:38.647 INFO [stdout] test scaled_highest_equivalent ... ok
Dec 15 09:06:38.647 INFO [stdout] test scaled_lowest_equivalent ... ok
Dec 15 09:06:38.647 INFO [stdout] test scaled_median_equivalent ... ok
Dec 15 09:06:38.655 INFO [stdout] test saturating_record ... ok
Dec 15 09:06:38.671 INFO [stdout] test clone ... ok
Dec 15 09:06:38.695 INFO [stdout] test subtract_underflow_guarded_by_per_value_count_check ... ok
Dec 15 09:06:38.783 INFO [stdout] test total_count_overflow_from_add_same_dimensions_saturates_calculating_other_addend_total ... ok
Dec 15 09:06:38.815 INFO [stdout] test scaled_set_to ... ok
Dec 15 09:06:38.839 INFO [stdout] test total_count_overflow_from_add_same_dimensions_saturates_when_added_to_orig_total_count ... ok
Dec 15 09:06:38.851 INFO [stdout] test total_count_overflow_from_add_with_resize_saturates ... ok
Dec 15 09:06:38.851 INFO [stdout] test total_count_overflow_from_record_saturates ... ok
Dec 15 09:06:38.869 INFO [stdout] test set_to ... ok
Dec 15 09:06:38.879 INFO [stdout] test value_count_overflow_from_add_with_resize_to_same_dimensions_saturates ... ok
Dec 15 09:06:38.883 INFO [stdout] test value_count_overflow_from_record_autoresize_doesnt_panic_saturates ... ok
Dec 15 09:06:38.899 INFO [stdout] test value_count_overflow_from_record_saturates_u16 ... ok
Dec 15 09:06:38.899 INFO [stdout] test scaled_clone ... ok
Dec 15 09:06:38.917 INFO [stdout] test value_count_overflow_from_record_saturates_u64 ... ok
Dec 15 09:06:38.917 INFO [stdout] test total_count_overflow_from_add_different_precision_saturates ... ok
Dec 15 09:06:38.945 INFO [stdout] test value_count_overflow_from_add_same_dimensions_saturates ... ok
Dec 15 09:06:39.023 INFO [stdout] test random_write_full_value_range_precision_0_no_panic ... ok
Dec 15 09:06:39.027 INFO [stdout] test value_count_overflow_from_add_different_precision_saturates ... ok
Dec 15 09:06:39.129 INFO [stdout] test random_write_middle_of_value_range_precision_3_no_panic ... ok
Dec 15 09:06:39.681 INFO [stdout] test random_write_full_value_range_precision_5_no_panic ... ok
Dec 15 09:06:39.681 INFO [stderr]      Running /target/debug/deps/interval_log-f7bdeb7c4604971f
Dec 15 09:06:39.681 INFO [stdout] 
Dec 15 09:06:39.681 INFO [stdout] test result: ok. 37 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:06:39.681 INFO [stdout] 
Dec 15 09:06:39.685 INFO [stdout] 
Dec 15 09:06:39.685 INFO [stdout] running 6 tests
Dec 15 09:06:39.726 INFO [stdout] test tests::parse_sample_tagged_interval_log_interval_count ... ok
Dec 15 09:06:39.726 INFO [stdout] test tests::parse_sample_tagged_interval_log_start_timestamp ... ok
Dec 15 09:06:39.726 INFO [stdout] test tests::parse_interval_log_syntax_error_then_returns_none ... ok
Dec 15 09:06:39.775 INFO [stdout] test tests::parse_sample_tagged_interval_log_interval_metadata ... ok
Dec 15 09:06:39.807 INFO [stdout] test tests::parse_sample_tagged_interval_log_rewrite_identical ... ok
Dec 15 09:06:43.437 INFO [stdout] test tests::write_random_histograms_to_interval_log_then_read ... ok
Dec 15 09:06:43.437 INFO [stdout] 
Dec 15 09:06:43.437 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:06:43.437 INFO [stdout] 
Dec 15 09:06:43.438 INFO [stderr]      Running /target/debug/deps/iterators-0e83a5649ffba694
Dec 15 09:06:43.444 INFO [stdout] 
Dec 15 09:06:43.444 INFO [stdout] running 20 tests
Dec 15 09:06:43.455 INFO [stdout] test iter_linear_bucket_values_size_8_all_buckets ... ok
Dec 15 09:06:43.467 INFO [stdout] test iter_all_values_all_buckets ... ok
Dec 15 09:06:43.468 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_2_all_buckets ... ok
Dec 15 09:06:43.481 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_10_all_buckets ... ok
Dec 15 09:06:43.481 INFO [stdout] test iter_logarithmic_bucket_values_min_4_base_2_all_buckets ... ok
Dec 15 09:06:43.482 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_2_all_buckets_unit_magnitude_2 ... ok
Dec 15 09:06:43.507 INFO [stdout] test iter_quantiles_iterates_to_quantile_10_as_it_reaches_last_bucket ... ok
Dec 15 09:06:43.507 INFO [stdout] test iter_quantiles_iterates_to_end_skips_intermediate_at_final_value ... ok
Dec 15 09:06:43.508 INFO [stdout] test iter_quantiles_empty ... ok
Dec 15 09:06:43.508 INFO [stdout] test iter_all_values_all_buckets_unit_magnitude_2 ... ok
Dec 15 09:06:43.531 INFO [stdout] test iter_quantiles_one_value ... ok
Dec 15 09:06:43.531 INFO [stdout] test iter_quantiles_smorgasboard ... ok
Dec 15 09:06:43.535 INFO [stdout] test iter_quantiles_saturated_count_before_max_value ... ok
Dec 15 09:06:43.543 INFO [stdout] test iter_recorded_values_all_buckets_unit_magnitude_2 ... ok
Dec 15 09:06:43.547 INFO [stdout] test iter_recorded_values_all_buckets ... ok
Dec 15 09:06:43.555 INFO [stdout] test iter_linear_visits_buckets_once_when_step_size_equals_bucket_size ... ok
Dec 15 09:06:43.555 INFO [stdout] test iter_linear_visits_buckets_wider_than_step_size_multiple_times ... ok
Dec 15 09:06:43.556 INFO [stdout] test iter_linear_count_since_last_iteration_saturates ... ok
Dec 15 09:06:43.579 INFO [stdout] test iter_recorded_saturated_total_count ... ok
Dec 15 09:06:43.579 INFO [stdout] test iter_recorded_non_saturated_total_count ... ok
Dec 15 09:06:43.579 INFO [stdout] 
Dec 15 09:06:43.579 INFO [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:06:43.579 INFO [stdout] 
Dec 15 09:06:43.587 INFO [stderr]      Running /target/debug/deps/quantile-fe6ee44d4d86437d
Dec 15 09:06:43.591 INFO [stdout] 
Dec 15 09:06:43.591 INFO [stdout] running 10 tests
Dec 15 09:06:43.635 INFO [stdout] test value_at_quantile_internal_count_exceeds_bucket_type ... ok
Dec 15 09:06:43.659 INFO [stdout] test value_at_quantile_5_values ... ok
Dec 15 09:06:43.667 INFO [stdout] test value_at_quantile_2_values ... ok
Dec 15 09:06:43.699 INFO [stdout] test value_at_quantile_20k ... ok
Dec 15 09:06:43.739 INFO [stdout] test value_at_quantile_large_numbers ... ok
Dec 15 09:06:46.487 INFO [stdout] test value_at_quantile_matches_quantile_iter_sequence_values ... ok
Dec 15 09:06:52.379 INFO [stdout] test value_at_quantile_matches_quantile_at_each_value_sequence_values ... ok
Dec 15 09:07:09.727 INFO [stdout] test value_at_quantile_matches_quantile_iter_random_values ... ok
Dec 15 09:07:16.786 INFO [stdout] test value_at_quantile_matches_random_quantile_random_values ... ok
Dec 15 09:07:31.861 INFO [stdout] test value_at_quantile_matches_quantile_at_each_value_random_values ... ok
Dec 15 09:07:31.861 INFO [stderr]      Running /target/debug/deps/serialization-aeb398186efcdc64
Dec 15 09:07:31.861 INFO [stdout] 
Dec 15 09:07:31.861 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:07:31.861 INFO [stdout] 
Dec 15 09:07:31.861 INFO [stdout] 
Dec 15 09:07:31.861 INFO [stdout] running 4 tests
Dec 15 09:07:31.927 INFO [stdout] test tests::total_count_overflow_from_deserialize_saturates ... ok
Dec 15 09:07:32.342 INFO [stdout] test tests::deserialize_no_compression_matches_java ... ok
Dec 15 09:07:32.351 INFO [stdout] test tests::serialize_no_compression_matches_java_impl ... ok
Dec 15 09:07:32.404 INFO [stdout] test tests::deserialize_compression_matches_java ... ok
Dec 15 09:07:32.404 INFO [stdout] 
Dec 15 09:07:32.404 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:07:32.404 INFO [stdout] 
Dec 15 09:07:32.405 INFO [stderr]    Doc-tests hdrhistogram
Dec 15 09:07:34.319 INFO [stdout] 
Dec 15 09:07:34.319 INFO [stdout] running 15 tests
Dec 15 09:07:39.712 INFO [stdout] test src/lib.rs -  (line 110) ... ok
Dec 15 09:07:39.898 INFO [stdout] test src/lib.rs -  (line 97) ... ok
Dec 15 09:07:40.634 INFO [stdout] test src/lib.rs - Histogram<T>::iter_log (line 1093) ... ok
Dec 15 09:07:41.336 INFO [stdout] test src/lib.rs -  (line 71) ... ok
Dec 15 09:07:42.221 INFO [stdout] test src/lib.rs - Histogram<T>::iter_recorded (line 1131) ... ok
Dec 15 09:07:42.402 INFO [stdout] test src/lib.rs - Histogram<T>::iter_linear (line 1035) ... ok
Dec 15 09:07:42.681 INFO [stdout] test src/lib.rs - Histogram<T>::iter_all (line 1170) ... ok
Dec 15 09:07:43.831 INFO [stdout] test src/lib.rs - Histogram<T>::iter_quantiles (line 977) ... ok
Dec 15 09:07:45.235 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 122) ... ok
Dec 15 09:07:46.229 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 175) ... ok
Dec 15 09:07:46.651 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 145) ... ok
Dec 15 09:07:47.319 INFO [stdout] test src/serialization/mod.rs - serialization (line 75) ... ok
Dec 15 09:07:47.343 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log::IntervalLogWriter (line 339) ... ok
Dec 15 09:07:47.815 INFO [stdout] test src/serialization/mod.rs - serialization (line 119) ... ok
Dec 15 09:07:48.071 INFO [stdout] test src/serialization/mod.rs - serialization (line 134) ... ok
Dec 15 09:07:48.071 INFO [stdout] 
Dec 15 09:07:48.071 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:07:48.071 INFO [stdout] 
Dec 15 09:07:48.103 INFO [stderr] su: No module specific data is present
Dec 15 09:07:48.637 INFO running `"docker" "inspect" "ce751853f36fbf501c8fe7a135150adf0f52105d07593d24246f705f266276f6"`
Dec 15 09:07:48.889 INFO running `"docker" "rm" "-f" "ce751853f36fbf501c8fe7a135150adf0f52105d07593d24246f705f266276f6"`
Dec 15 09:07:49.046 INFO [stdout] ce751853f36fbf501c8fe7a135150adf0f52105d07593d24246f705f266276f6