Dec 15 09:01:07.650 INFO testing hdrhistogram-6.1.1 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 09:01:07.651 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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:08.011 INFO [stdout] edd7518e8c9c1631dff38defc14a9907d096f720456f2fd1b09f65635113bd7b
Dec 15 09:01:08.017 INFO running `"docker" "start" "-a" "edd7518e8c9c1631dff38defc14a9907d096f720456f2fd1b09f65635113bd7b"`
Dec 15 09:01:09.469 INFO [stderr] usermod: no changes
Dec 15 09:01:09.607 INFO [stderr]    Compiling hdrhistogram v6.1.1 (/source)
Dec 15 09:01:12.309 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.82s
Dec 15 09:01:12.317 INFO [stderr] su: No module specific data is present
Dec 15 09:01:13.012 INFO running `"docker" "inspect" "edd7518e8c9c1631dff38defc14a9907d096f720456f2fd1b09f65635113bd7b"`
Dec 15 09:01:13.341 INFO running `"docker" "rm" "-f" "edd7518e8c9c1631dff38defc14a9907d096f720456f2fd1b09f65635113bd7b"`
Dec 15 09:01:13.562 INFO [stdout] edd7518e8c9c1631dff38defc14a9907d096f720456f2fd1b09f65635113bd7b
Dec 15 09:01:13.571 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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:14.116 INFO [stdout] 987a9faedc94760c591971576274443825fba9109571e7d9770db2c98b3c182a
Dec 15 09:01:14.119 INFO running `"docker" "start" "-a" "987a9faedc94760c591971576274443825fba9109571e7d9770db2c98b3c182a"`
Dec 15 09:01:15.302 INFO [stderr] usermod: no changes
Dec 15 09:01:15.522 INFO [stderr]    Compiling gmp-mpfr-sys v1.1.9
Dec 15 09:01:15.522 INFO [stderr]    Compiling rug v1.2.2
Dec 15 09:01:15.526 INFO [stderr]    Compiling ieee754 v0.2.2
Dec 15 09:05:09.606 INFO [stderr]    Compiling hdrhistogram v6.1.1 (/source)
Dec 15 09:05:28.289 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4m 12s
Dec 15 09:05:28.302 INFO [stderr] su: No module specific data is present
Dec 15 09:05:29.012 INFO running `"docker" "inspect" "987a9faedc94760c591971576274443825fba9109571e7d9770db2c98b3c182a"`
Dec 15 09:05:29.539 INFO running `"docker" "rm" "-f" "987a9faedc94760c591971576274443825fba9109571e7d9770db2c98b3c182a"`
Dec 15 09:05:29.907 INFO [stdout] 987a9faedc94760c591971576274443825fba9109571e7d9770db2c98b3c182a
Dec 15 09:05:29.915 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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:30.301 INFO [stdout] 460abb9fce6ac9b612c0dfb45f3a25537667686a3de19ed60ecaca91dde465a1
Dec 15 09:05:30.305 INFO running `"docker" "start" "-a" "460abb9fce6ac9b612c0dfb45f3a25537667686a3de19ed60ecaca91dde465a1"`
Dec 15 09:05:31.871 INFO [stderr] usermod: no changes
Dec 15 09:05:32.051 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.15s
Dec 15 09:05:32.095 INFO [stderr]      Running /target/debug/deps/hdrhistogram-33c768621f502b80
Dec 15 09:05:32.095 INFO [stdout] 
Dec 15 09:05:32.095 INFO [stdout] running 160 tests
Dec 15 09:05:32.095 INFO [stdout] test serialization::interval_log::tests::parse_comment ... ok
Dec 15 09:05:32.095 INFO [stdout] test serialization::interval_log::tests::parse_base_time ... ok
Dec 15 09:05:32.095 INFO [stdout] test serialization::interval_log::tests::iter_without_ignored_prefix ... ok
Dec 15 09:05:32.099 INFO [stdout] test serialization::interval_log::tests::parse_duration_scale_ns ... ok
Dec 15 09:05:32.099 INFO [stdout] test serialization::interval_log::tests::parse_duration_too_many_ns ... ok
Dec 15 09:05:32.099 INFO [stdout] test serialization::interval_log::tests::parse_interval_hist_no_tag ... ok
Dec 15 09:05:32.099 INFO [stdout] test serialization::interval_log::tests::parse_duration_full_ns ... ok
Dec 15 09:05:32.099 INFO [stdout] test serialization::interval_log::tests::iter_with_ignored_prefix ... ok
Dec 15 09:05:32.099 INFO [stdout] test serialization::interval_log::tests::iter_multiple_entrties_with_interleaved_ignored ... ok
Dec 15 09:05:32.099 INFO [stdout] test serialization::interval_log::tests::iter_all_ignored_empty_iter ... ok
Dec 15 09:05:32.107 INFO [stdout] test serialization::interval_log::tests::parse_legend ... ok
Dec 15 09:05:32.107 INFO [stdout] test serialization::interval_log::tests::parse_start_time_with_human_date ... ok
Dec 15 09:05:32.107 INFO [stdout] test serialization::interval_log::tests::write_comment_control_characters_still_parseable ... ok
Dec 15 09:05:32.107 INFO [stdout] test serialization::interval_log::tests::parse_start_time_without_human_date ... ok
Dec 15 09:05:32.107 INFO [stdout] test serialization::interval_log::tests::write_comment_newline_wraps ... ok
Dec 15 09:05:32.107 INFO [stdout] test serialization::interval_log::tests::write_base_time ... ok
Dec 15 09:05:32.107 INFO [stdout] test serialization::interval_log::tests::write_header_then_interval_comment ... ok
Dec 15 09:05:32.107 INFO [stdout] test serialization::interval_log::tests::write_headers_multiple_times_only_last_is_used ... ok
Dec 15 09:05:32.115 INFO [stdout] test serialization::interval_log::tests::parse_interval_hist_with_tag ... ok
Dec 15 09:05:32.115 INFO [stdout] test serialization::interval_log::tests::write_header_comment ... ok
Dec 15 09:05:32.115 INFO [stdout] test serialization::interval_log::tests::write_start_time ... ok
Dec 15 09:05:32.119 INFO [stdout] test serialization::interval_log::tests::write_interval_histo_no_tag ... ok
Dec 15 09:05:32.119 INFO [stdout] test serialization::tests::encode_counts_first_and_last_count_incremented ... ok
Dec 15 09:05:32.119 INFO [stdout] test serialization::tests::encode_counts_last_count_incremented ... ok
Dec 15 09:05:32.119 INFO [stdout] test serialization::tests::encode_counts_first_count_incremented ... ok
Dec 15 09:05:32.119 INFO [stdout] test serialization::tests::encode_counts_count_too_big ... ok
Dec 15 09:05:32.123 INFO [stdout] test serialization::tests::rand_varint::largest_number_in_7_bit_chunk_correct ... ok
Dec 15 09:05:32.131 INFO [stdout] test serialization::tests::encode_counts_all_zeros ... ok
Dec 15 09:05:32.131 INFO [stdout] test serialization::interval_log::tests::write_interval_histo_with_tag ... ok
Dec 15 09:05:32.131 INFO [stdout] test serialization::tests::serialize_all_zeros ... ok
Dec 15 09:05:32.131 INFO [stdout] test serialization::tests::serialize_roundtrip_1_count_for_every_value_1_bucket ... ok
Dec 15 09:05:32.139 INFO [stdout] test serialization::tests::serialize_roundtrip_all_zeros ... ok
Dec 15 09:05:32.156 INFO [stdout] test serialization::tests::serialize_roundtrip_1_count_for_every_value_2_buckets ... ok
Dec 15 09:05:33.036 INFO [stdout] test serialization::interval_log::tests::duration_fp_roundtrip_accuracy ... ok
Dec 15 09:05:49.371 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u16 ... ok
Dec 15 09:05:49.372 INFO [stdout] test serialization::tests::varint_read_u64_max ... ok
Dec 15 09:05:49.372 INFO [stdout] test serialization::tests::varint_read_u64_zero ... ok
Dec 15 09:05:49.403 INFO [stdout] test serialization::tests::varint_write_3_bit_value ... ok
Dec 15 09:05:49.415 INFO [stdout] test serialization::tests::varint_write_7_bit_value ... ok
Dec 15 09:05:49.415 INFO [stdout] test serialization::tests::varint_write_9_bit_value ... ok
Dec 15 09:05:50.084 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_1_byte ... ok
Dec 15 09:05:50.856 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u16 ... ok
Dec 15 09:05:51.098 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_2_byte ... ok
Dec 15 09:05:51.723 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_3_byte ... ok
Dec 15 09:05:52.153 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_4_byte ... ok
Dec 15 09:05:52.535 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_5_byte ... ok
Dec 15 09:05:52.555 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u8 ... ok
Dec 15 09:05:53.595 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_6_byte ... ok
Dec 15 09:05:53.759 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u32 ... ok
Dec 15 09:05:53.779 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_7_byte ... ok
Dec 15 09:05:54.159 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_2_byte ... ok
Dec 15 09:05:54.207 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_1_byte ... ok
Dec 15 09:05:54.316 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_8_byte ... ok
Dec 15 09:05:54.695 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_5_byte ... ok
Dec 15 09:05:54.799 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_4_byte ... ok
Dec 15 09:05:54.911 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_6_byte ... ok
Dec 15 09:05:54.955 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u64 ... ok
Dec 15 09:05:55.059 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_3_byte ... ok
Dec 15 09:05:55.059 INFO [stdout] test serialization::tests::varint_write_u64_max ... ok
Dec 15 09:05:55.059 INFO [stdout] test serialization::tests::zig_zag_decode_0 ... ok
Dec 15 09:05:55.071 INFO [stdout] test serialization::tests::zig_zag_decode_1 ... ok
Dec 15 09:05:55.075 INFO [stdout] test serialization::tests::zig_zag_decode_2 ... ok
Dec 15 09:05:55.075 INFO [stdout] test serialization::tests::zig_zag_decode_u64_max_penultimate_to_i64_max ... ok
Dec 15 09:05:55.075 INFO [stdout] test serialization::tests::zig_zag_decode_u64_max_to_i64_min ... ok
Dec 15 09:05:55.075 INFO [stdout] test serialization::tests::zig_zag_encode_0 ... ok
Dec 15 09:05:55.075 INFO [stdout] test serialization::tests::zig_zag_encode_1 ... ok
Dec 15 09:05:55.083 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_7_byte ... ok
Dec 15 09:05:55.083 INFO [stdout] test serialization::tests::zig_zag_encode_i64_max ... ok
Dec 15 09:05:55.083 INFO [stdout] test serialization::tests::zig_zag_encode_i64_min ... ok
Dec 15 09:05:55.083 INFO [stdout] test serialization::tests::zig_zag_encode_neg_1 ... ok
Dec 15 09:05:55.103 INFO [stdout] test tests::correct_original_min ... ok
Dec 15 09:05:55.103 INFO [stdout] test tests::index_calculation::bucket_for_biggest_value_in_first_bucket ... ok
Dec 15 09:05:55.103 INFO [stdout] test tests::index_calculation::bucket_for_biggest_value_in_second_bucket ... ok
Dec 15 09:05:55.103 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_first_bucket ... ok
Dec 15 09:05:55.115 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_last_bucket ... ok
Dec 15 09:05:55.159 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_second_bucket ... ok
Dec 15 09:05:55.171 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_third_bucket ... ok
Dec 15 09:05:55.179 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_9_byte ... ok
Dec 15 09:05:55.179 INFO [stdout] test tests::index_calculation::bucket_for_value_above_biggest_isnt_clamped_at_max_bucket ... ok
Dec 15 09:05:55.179 INFO [stdout] test tests::index_calculation::bucket_for_value_below_smallest_clamps_to_zero ... ok
Dec 15 09:05:55.179 INFO [stdout] test tests::index_calculation::index_for_below_smallest ... ok
Dec 15 09:05:55.183 INFO [stdout] test tests::index_calculation::index_for_first_bucket_first_distinguishable_entry ... ok
Dec 15 09:05:55.183 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_9_byte ... ok
Dec 15 09:05:55.187 INFO [stdout] test tests::index_calculation::index_for_second_bucket_first_entry ... ok
Dec 15 09:05:55.187 INFO [stdout] test tests::index_calculation::index_for_second_bucket_last_entry ... ok
Dec 15 09:05:55.187 INFO [stdout] test tests::index_calculation::index_for_second_bucket_last_entry_indistinguishable ... ok
Dec 15 09:05:55.187 INFO [stdout] test tests::index_calculation::index_for_way_past_largest_value_exceeds_length ... ok
Dec 15 09:05:55.187 INFO [stdout] test tests::index_calculation::sub_bucket_for_biggest_value_in_second_bucket ... ok
Dec 15 09:05:55.187 INFO [stdout] test tests::index_calculation::sub_bucket_for_largest_value_in_first_bucket ... ok
Dec 15 09:05:55.187 INFO [stdout] test tests::index_calculation::sub_bucket_for_largest_value_in_first_bucket_unit_magnitude_2 ... ok
Dec 15 09:05:55.188 INFO [stdout] test tests::index_calculation::sub_bucket_for_smaller_than_distinguishable_value_in_first_bucket_unit_magnitude_2 ... ok
Dec 15 09:05:55.188 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_distinguishable_value_in_first_bucket ... ok
Dec 15 09:05:55.195 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_distinguishable_value_in_first_bucket_unit_magnitude_2 ... ok
Dec 15 09:05:55.211 INFO [stdout] test tests::index_calculation::index_for_first_bucket_first_entry ... ok
Dec 15 09:05:55.211 INFO [stdout] test tests::index_calculation::index_for_first_bucket_last_entry ... ok
Dec 15 09:05:55.211 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_second_bucket ... ok
Dec 15 09:05:55.211 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_second_bucket_unit_magnitude_2 ... ok
Dec 15 09:05:55.211 INFO [stdout] test tests::index_calculation::sub_bucket_for_value_below_smallest_clamps_to_zero ... ok
Dec 15 09:05:55.223 INFO [stdout] test tests::index_calculation::sub_bucket_for_zero_value_in_first_bucket ... ok
Dec 15 09:05:55.223 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_third_bucket ... ok
Dec 15 09:05:55.223 INFO [stdout] test tests::index_calculation::sub_bucket_for_value_above_biggest_still_works ... ok
Dec 15 09:05:55.224 INFO [stdout] test tests::index_calculation::sub_bucket_for_zero_value_in_first_bucket_unit_magnitude_2 ... ok
Dec 15 09:05:55.227 INFO [stdout] test tests::index_calculation::unit_magnitude_4_index_calculations ... ok
Dec 15 09:05:55.228 INFO [stdout] test tests::index_calculation::unit_magnitude_0_index_calculations ... ok
Dec 15 09:05:55.229 INFO [stdout] test tests::index_calculation::unit_magnitude_52_sub_bucket_magnitude_11_index_calculations ... ok
Dec 15 09:05:55.239 INFO [stdout] test tests::index_calculation::unit_magnitude_53_sub_bucket_magnitude_11_throws ... ok
Dec 15 09:05:55.239 INFO [stdout] test tests::index_calculation::unit_magnitude_62_sub_bucket_magnitude_1_ok ... ok
Dec 15 09:05:55.247 INFO [stdout] test tests::init::init_fields_10m_max_1k_min_middle_precision ... ok
Dec 15 09:05:55.247 INFO [stdout] test tests::init::init_fields_1_bucket_medium_precision ... ok
Dec 15 09:05:55.251 INFO [stdout] test tests::init::init_fields_max_value_0_precision_most_buckets ... ok
Dec 15 09:05:55.251 INFO [stdout] test tests::init::init_fields_max_value_0_precision_increased_min_value ... ok
Dec 15 09:05:55.267 INFO [stdout] test tests::index_calculation::unit_magnitude_55_sub_bucket_magnitude_8_ok ... ok
Dec 15 09:05:55.286 INFO [stdout] test tests::init::init_fields_max_value_max_unit_magnitude_0_precision ... ok
Dec 15 09:05:55.549 INFO [stdout] test tests::init::init_fields_max_value_max_unit_magnitude_max_precision ... ok
Dec 15 09:05:55.578 INFO [stdout] test tests::init::init_fields_max_value_medium_precision ... ok
Dec 15 09:05:55.594 INFO [stdout] test tests::init::init_fields_smallest_possible_array ... ok
Dec 15 09:05:55.595 INFO [stdout] test tests::new_err_high_not_double_low ... ok
Dec 15 09:05:55.674 INFO [stdout] test serialization::tests::zig_zag_roundtrip_random ... ok
Dec 15 09:05:55.727 INFO [stdout] test tests::subtract::subtract_subtrahend_values_outside_minuend_range_error ... ok
Dec 15 09:05:55.786 INFO [stdout] test tests::subtract::subtract_to_negative_counts_error ... ok
Dec 15 09:05:55.813 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_8_byte ... ok
Dec 15 09:05:55.943 INFO [stdout] test tests::subtract::subtract_to_zero_counts ... ok
Dec 15 09:05:56.003 INFO [stdout] test tests::subtract::subtract_after_add ... ok
Dec 15 09:05:56.027 INFO [stdout] test tests::subtract::subtract_values_at_extent_of_minuend_nonzero_count_range_recalculates_same_min_max ... ok
Dec 15 09:05:56.153 INFO [stdout] test tests::subtract::subtract_values_at_extent_of_minuend_zero_count_range_recalculates_min_max ... ok
Dec 15 09:05:56.607 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u8 ... ok
Dec 15 09:05:56.647 INFO [stdout] test tests::subtract::subtract_values_inside_minuend_range_works ... ok
Dec 15 09:05:56.891 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u64 ... ok
Dec 15 09:05:57.005 INFO [stdout] test tests::subtract::subtract_values_minuend_saturated_total_recalculates_saturated ... ok
Dec 15 09:05:57.055 INFO [stdout] test tests::init::init_fields_max_value_max_precision_increased_min_value ... ok
Dec 15 09:05:57.095 INFO [stdout] test tests::subtract::subtract_values_minuend_saturated_total_recalculates_not_saturated ... ok
Dec 15 09:05:57.111 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0 ... ok
Dec 15 09:05:57.127 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_max_buckets ... ok
Dec 15 09:05:57.367 INFO [stdout] test tests::subtract::subtract_values_strictly_inside_minuend_range_yields_same_min_max_no_restat ... ok
Dec 15 09:05:57.385 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_min_precision_max_buckets ... ok
Dec 15 09:05:57.427 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_2 ... ok
Dec 15 09:05:57.463 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_2_max_buckets ... ok
Dec 15 09:05:57.475 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_50_max_buckets ... ok
Dec 15 09:05:57.503 INFO [stdout] test tests::value_calculation::highest_equivalent_u64_max_value_saturates ... ok
Dec 15 09:05:57.511 INFO [stdout] test tests::value_calculation::highest_equivalent_unit_magnitude_0 ... ok
Dec 15 09:05:57.523 INFO [stdout] test tests::value_calculation::highest_equivalent_unit_magnitude_2 ... ok
Dec 15 09:05:57.539 INFO [stdout] test tests::value_calculation::lowest_equivalent_unit_magnitude_0 ... ok
Dec 15 09:05:57.571 INFO [stdout] test tests::value_calculation::lowest_equivalent_unit_magnitude_2 ... ok
Dec 15 09:05:57.707 INFO [stdout] test tests::value_calculation::next_non_equivalent_u64_max_value_saturates ... ok
Dec 15 09:05:57.715 INFO [stdout] test tests::value_calculation::next_non_equivalent_unit_magnitude_0 ... ok
Dec 15 09:05:57.715 INFO [stdout] test tests::value_calculation::next_non_equivalent_unit_magnitude_2 ... ok
Dec 15 09:05:57.987 INFO [stdout] test tests::init::init_fields_max_value_max_precision_largest_possible_array ... ok
Dec 15 09:05:57.999 INFO [stdout] test tests::value_calculation::value_for_beyond_histogram_max_still_works ... ok
Dec 15 09:05:57.999 INFO [stdout] test tests::value_calculation::value_for_impossible_index ... ok
Dec 15 09:05:58.003 INFO [stdout] test tests::value_calculation::value_for_unit_magnitude_0 ... ok
Dec 15 09:05:58.003 INFO [stdout] test tests::value_calculation::value_for_unit_magnitude_2 ... ok
Dec 15 09:05:58.003 INFO [stdout] test tests::value_calculation::value_from_loc_unit_magnitude_0 ... ok
Dec 15 09:05:58.003 INFO [stdout] test tests::value_calculation::value_from_loc_unit_magnitude_2 ... ok
Dec 15 09:05:58.623 INFO [stdout] test tests::value_calculation::value_for_at_each_index ... ok
Dec 15 09:05:58.670 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u32 ... ok
Dec 15 09:05:59.376 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_max_precision_max_buckets ... ok
Dec 15 09:06:06.063 INFO [stdout] test tests::subtract::subtract_values_within_bucket_precision_of_of_minuend_max_recalculates_min_max ... ok
Dec 15 09:06:07.187 INFO [stdout] test tests::subtract::subtract_values_at_minuend_min_recalculates_min_max ... ok
Dec 15 09:06:07.647 INFO [stdout] test tests::subtract::subtract_values_at_minuend_max_recalculates_min_max ... ok
Dec 15 09:06:08.047 INFO [stdout] test tests::subtract::subtract_values_within_bucket_precision_of_of_minuend_min_recalculates_min_max ... ok
Dec 15 09:06:08.047 INFO [stdout] 
Dec 15 09:06:08.047 INFO [stdout] test result: ok. 160 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:06:08.047 INFO [stdout] 
Dec 15 09:06:08.048 INFO [stderr]      Running /target/debug/deps/auto_resize-8092e54801173d49
Dec 15 09:06:08.056 INFO [stdout] 
Dec 15 09:06:08.056 INFO [stdout] running 4 tests
Dec 15 09:06:08.067 INFO [stdout] test autosizing_add ... ok
Dec 15 09:06:08.080 INFO [stdout] test histogram_autosizing_edges ... ok
Dec 15 09:06:08.080 INFO [stdout] test histogram_autosizing ... ok
Dec 15 09:06:10.597 INFO [stdout] test autosizing_across_continuous_range ... ok
Dec 15 09:06:10.597 INFO [stdout] 
Dec 15 09:06:10.597 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:06:10.597 INFO [stdout] 
Dec 15 09:06:10.599 INFO [stderr]      Running /target/debug/deps/data_access-c8b1b2f63919a924
Dec 15 09:06:10.607 INFO [stdout] 
Dec 15 09:06:10.607 INFO [stdout] running 26 tests
Dec 15 09:06:10.683 INFO [stdout] test count_between_low_and_high_beyond_max ... ok
Dec 15 09:06:10.743 INFO [stdout] test count_between_high_beyond_max ... ok
Dec 15 09:06:10.759 INFO [stdout] test count_at_beyond_max_value ... ok
Dec 15 09:06:10.787 INFO [stdout] test count_between_saturates ... ok
Dec 15 09:06:10.915 INFO [stdout] test count_at ... ok
Dec 15 09:06:10.923 INFO [stdout] test get_max_value ... ok
Dec 15 09:06:10.935 INFO [stdout] test count_between ... ok
Dec 15 09:06:11.029 INFO [stdout] test get_mean ... ok
Dec 15 09:06:11.111 INFO [stdout] test get_stdev ... ok
Dec 15 09:06:11.111 INFO [stdout] test get_min_value ... ok
Dec 15 09:06:11.111 INFO [stdout] test linear_iter_steps ... ok
Dec 15 09:06:11.139 INFO [stdout] test quantile_below_saturates ... ok
Dec 15 09:06:11.155 INFO [stdout] test quantile_below_value_beyond_max ... ok
Dec 15 09:06:11.266 INFO [stdout] test quantile_atorbelow ... ok
Dec 15 09:06:11.291 INFO [stdout] test iter_log ... ok
Dec 15 09:06:11.291 INFO [stdout] test iter_recorded ... ok
Dec 15 09:06:11.343 INFO [stdout] test linear_iter_raw ... ok
Dec 15 09:06:11.347 INFO [stdout] test total_count_exceeds_bucket_type ... ok
Dec 15 09:06:11.347 INFO [stdout] test iter_all ... ok
Dec 15 09:06:11.523 INFO [stdout] test total_count ... ok
Dec 15 09:06:11.545 INFO [stdout] test value_duplication ... ok
Dec 15 09:06:11.595 INFO [stdout] test quantiles ... ok
Dec 15 09:06:11.616 INFO [stdout] test linear_iter_corrected ... ok
Dec 15 09:06:11.659 INFO [stdout] test scaling_equivalence ... ok
Dec 15 09:06:11.704 INFO [stdout] test quantile_iter ... ok
Dec 15 09:06:12.106 INFO [stdout] test large_quantile ... ok
Dec 15 09:06:12.107 INFO [stderr]      Running /target/debug/deps/histogram-62a25084fe6dea99
Dec 15 09:06:12.107 INFO [stdout] 
Dec 15 09:06:12.107 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:06:12.107 INFO [stdout] 
Dec 15 09:06:12.107 INFO [stdout] 
Dec 15 09:06:12.107 INFO [stdout] running 37 tests
Dec 15 09:06:12.126 INFO [stdout] test construction_arg_ranges ... ok
Dec 15 09:06:12.138 INFO [stdout] test empty_histogram ... ok
Dec 15 09:06:12.146 INFO [stdout] test construction_arg_gets ... ok
Dec 15 09:06:12.159 INFO [stdout] test lowest_equivalent ... ok
Dec 15 09:06:12.159 INFO [stdout] test equivalent_range ... ok
Dec 15 09:06:12.166 INFO [stdout] test highest_equivalent ... ok
Dec 15 09:06:12.175 INFO [stdout] test median_equivalent_doesnt_panic_at_extremes ... ok
Dec 15 09:06:12.193 INFO [stdout] test median_equivalent ... ok
Dec 15 09:06:12.199 INFO [stdout] test record ... ok
Dec 15 09:06:12.203 INFO [stdout] test record_past_trackable_max ... ok
Dec 15 09:06:12.215 INFO [stdout] test reset ... ok
Dec 15 09:06:12.215 INFO [stdout] test saturating_record ... ok
Dec 15 09:06:12.215 INFO [stdout] test add ... ok
Dec 15 09:06:12.219 INFO [stdout] test record_in_interval ... ok
Dec 15 09:06:12.219 INFO [stdout] test scaled_equivalent_range ... ok
Dec 15 09:06:12.219 INFO [stdout] test scaled_highest_equivalent ... ok
Dec 15 09:06:12.223 INFO [stdout] test scaled_lowest_equivalent ... ok
Dec 15 09:06:12.231 INFO [stdout] test scaled_median_equivalent ... ok
Dec 15 09:06:12.271 INFO [stdout] test subtract_underflow_guarded_by_per_value_count_check ... ok
Dec 15 09:06:12.379 INFO [stdout] test clone ... ok
Dec 15 09:06:12.543 INFO [stdout] test total_count_overflow_from_add_same_dimensions_saturates_calculating_other_addend_total ... ok
Dec 15 09:06:12.563 INFO [stdout] test scaled_clone ... ok
Dec 15 09:06:12.587 INFO [stdout] test scaled_set_to ... ok
Dec 15 09:06:12.599 INFO [stdout] test total_count_overflow_from_record_saturates ... ok
Dec 15 09:06:12.607 INFO [stdout] test total_count_overflow_from_add_with_resize_saturates ... ok
Dec 15 09:06:12.643 INFO [stdout] test total_count_overflow_from_add_same_dimensions_saturates_when_added_to_orig_total_count ... ok
Dec 15 09:06:12.663 INFO [stdout] test set_to ... ok
Dec 15 09:06:12.671 INFO [stdout] test value_count_overflow_from_add_with_resize_to_same_dimensions_saturates ... ok
Dec 15 09:06:12.679 INFO [stdout] test value_count_overflow_from_record_saturates_u16 ... ok
Dec 15 09:06:12.679 INFO [stdout] test total_count_overflow_from_add_different_precision_saturates ... ok
Dec 15 09:06:12.703 INFO [stdout] test value_count_overflow_from_record_autoresize_doesnt_panic_saturates ... ok
Dec 15 09:06:12.715 INFO [stdout] test value_count_overflow_from_record_saturates_u64 ... ok
Dec 15 09:06:12.739 INFO [stdout] test value_count_overflow_from_add_same_dimensions_saturates ... ok
Dec 15 09:06:12.967 INFO [stdout] test value_count_overflow_from_add_different_precision_saturates ... ok
Dec 15 09:06:13.111 INFO [stdout] test random_write_full_value_range_precision_0_no_panic ... ok
Dec 15 09:06:13.171 INFO [stdout] test random_write_middle_of_value_range_precision_3_no_panic ... ok
Dec 15 09:06:13.710 INFO [stdout] test random_write_full_value_range_precision_5_no_panic ... ok
Dec 15 09:06:13.710 INFO [stderr]      Running /target/debug/deps/interval_log-c66af870101ab236
Dec 15 09:06:13.710 INFO [stdout] 
Dec 15 09:06:13.710 INFO [stdout] test result: ok. 37 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:06:13.710 INFO [stdout] 
Dec 15 09:06:13.712 INFO [stdout] 
Dec 15 09:06:13.712 INFO [stdout] running 6 tests
Dec 15 09:06:13.743 INFO [stdout] test tests::parse_interval_log_syntax_error_then_returns_none ... ok
Dec 15 09:06:13.743 INFO [stdout] test tests::parse_sample_tagged_interval_log_interval_count ... ok
Dec 15 09:06:13.751 INFO [stdout] test tests::parse_sample_tagged_interval_log_start_timestamp ... ok
Dec 15 09:06:13.775 INFO [stdout] test tests::parse_sample_tagged_interval_log_interval_metadata ... ok
Dec 15 09:06:13.819 INFO [stdout] test tests::parse_sample_tagged_interval_log_rewrite_identical ... ok
Dec 15 09:06:17.447 INFO [stdout] test tests::write_random_histograms_to_interval_log_then_read ... ok
Dec 15 09:06:17.447 INFO [stdout] 
Dec 15 09:06:17.447 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:06:17.447 INFO [stdout] 
Dec 15 09:06:17.448 INFO [stderr]      Running /target/debug/deps/iterators-45ede3b3e0a05313
Dec 15 09:06:17.450 INFO [stdout] 
Dec 15 09:06:17.451 INFO [stdout] running 20 tests
Dec 15 09:06:17.453 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_2_all_buckets ... ok
Dec 15 09:06:17.454 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_10_all_buckets ... ok
Dec 15 09:06:17.455 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_2_all_buckets_unit_magnitude_2 ... ok
Dec 15 09:06:17.456 INFO [stdout] test iter_logarithmic_bucket_values_min_4_base_2_all_buckets ... ok
Dec 15 09:06:17.456 INFO [stdout] test iter_quantiles_empty ... ok
Dec 15 09:06:17.461 INFO [stdout] test iter_quantiles_iterates_to_quantile_10_as_it_reaches_last_bucket ... ok
Dec 15 09:06:17.461 INFO [stdout] test iter_quantiles_one_value ... ok
Dec 15 09:06:17.463 INFO [stdout] test iter_linear_bucket_values_size_8_all_buckets ... ok
Dec 15 09:06:17.464 INFO [stdout] test iter_quantiles_saturated_count_before_max_value ... ok
Dec 15 09:06:17.468 INFO [stdout] test iter_quantiles_smorgasboard ... ok
Dec 15 09:06:17.482 INFO [stdout] test iter_linear_visits_buckets_once_when_step_size_equals_bucket_size ... ok
Dec 15 09:06:17.485 INFO [stdout] test iter_linear_count_since_last_iteration_saturates ... ok
Dec 15 09:06:17.492 INFO [stdout] test iter_recorded_values_all_buckets ... ok
Dec 15 09:06:17.492 INFO [stdout] test iter_quantiles_iterates_to_end_skips_intermediate_at_final_value ... ok
Dec 15 09:06:17.493 INFO [stdout] test iter_linear_visits_buckets_wider_than_step_size_multiple_times ... ok
Dec 15 09:06:17.496 INFO [stdout] test iter_all_values_all_buckets ... ok
Dec 15 09:06:17.503 INFO [stdout] test iter_all_values_all_buckets_unit_magnitude_2 ... ok
Dec 15 09:06:17.511 INFO [stdout] test iter_recorded_values_all_buckets_unit_magnitude_2 ... ok
Dec 15 09:06:17.536 INFO [stdout] test iter_recorded_non_saturated_total_count ... ok
Dec 15 09:06:17.543 INFO [stdout] test iter_recorded_saturated_total_count ... ok
Dec 15 09:06:17.543 INFO [stdout] 
Dec 15 09:06:17.543 INFO [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:06:17.543 INFO [stdout] 
Dec 15 09:06:17.544 INFO [stderr]      Running /target/debug/deps/quantile-0aa82a73bc5f2ab7
Dec 15 09:06:17.546 INFO [stdout] 
Dec 15 09:06:17.546 INFO [stdout] running 10 tests
Dec 15 09:06:17.555 INFO [stdout] test value_at_quantile_internal_count_exceeds_bucket_type ... ok
Dec 15 09:06:17.609 INFO [stdout] test value_at_quantile_2_values ... ok
Dec 15 09:06:17.610 INFO [stdout] test value_at_quantile_5_values ... ok
Dec 15 09:06:17.661 INFO [stdout] test value_at_quantile_20k ... ok
Dec 15 09:06:17.703 INFO [stdout] test value_at_quantile_large_numbers ... ok
Dec 15 09:06:22.575 INFO [stdout] test value_at_quantile_matches_quantile_iter_sequence_values ... ok
Dec 15 09:06:27.307 INFO [stdout] test value_at_quantile_matches_quantile_at_each_value_sequence_values ... ok
Dec 15 09:06:43.411 INFO [stdout] test value_at_quantile_matches_quantile_iter_random_values ... ok
Dec 15 09:06:52.135 INFO [stdout] test value_at_quantile_matches_random_quantile_random_values ... ok
Dec 15 09:07:05.291 INFO [stdout] test value_at_quantile_matches_quantile_at_each_value_random_values ... ok
Dec 15 09:07:05.291 INFO [stderr]      Running /target/debug/deps/serialization-23c06fe3151cc09e
Dec 15 09:07:05.291 INFO [stdout] 
Dec 15 09:07:05.291 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:07:05.291 INFO [stdout] 
Dec 15 09:07:05.295 INFO [stdout] 
Dec 15 09:07:05.295 INFO [stdout] running 4 tests
Dec 15 09:07:05.343 INFO [stdout] test tests::total_count_overflow_from_deserialize_saturates ... ok
Dec 15 09:07:05.875 INFO [stdout] test tests::deserialize_no_compression_matches_java ... ok
Dec 15 09:07:05.971 INFO [stdout] test tests::serialize_no_compression_matches_java_impl ... ok
Dec 15 09:07:05.999 INFO [stdout] test tests::deserialize_compression_matches_java ... ok
Dec 15 09:07:05.999 INFO [stdout] 
Dec 15 09:07:05.999 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:07:05.999 INFO [stdout] 
Dec 15 09:07:05.999 INFO [stderr]    Doc-tests hdrhistogram
Dec 15 09:07:07.907 INFO [stdout] 
Dec 15 09:07:07.907 INFO [stdout] running 15 tests
Dec 15 09:07:15.075 INFO [stdout] test src/lib.rs - Histogram<T>::iter_all (line 1170) ... ok
Dec 15 09:07:15.511 INFO [stdout] test src/lib.rs -  (line 97) ... ok
Dec 15 09:07:18.119 INFO [stdout] test src/lib.rs - Histogram<T>::iter_recorded (line 1131) ... ok
Dec 15 09:07:18.382 INFO [stdout] test src/lib.rs - Histogram<T>::iter_log (line 1093) ... ok
Dec 15 09:07:18.907 INFO [stdout] test src/lib.rs - Histogram<T>::iter_quantiles (line 977) ... ok
Dec 15 09:07:18.971 INFO [stdout] test src/lib.rs -  (line 71) ... ok
Dec 15 09:07:19.329 INFO [stdout] test src/lib.rs - Histogram<T>::iter_linear (line 1035) ... ok
Dec 15 09:07:19.495 INFO [stdout] test src/lib.rs -  (line 110) ... ok
Dec 15 09:07:21.651 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 122) ... ok
Dec 15 09:07:23.063 INFO [stdout] test src/serialization/mod.rs - serialization (line 75) ... ok
Dec 15 09:07:23.262 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 145) ... ok
Dec 15 09:07:25.062 INFO [stdout] test src/serialization/mod.rs - serialization (line 134) ... ok
Dec 15 09:07:25.356 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log::IntervalLogWriter (line 339) ... ok
Dec 15 09:07:25.359 INFO [stdout] test src/serialization/mod.rs - serialization (line 119) ... ok
Dec 15 09:07:25.659 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 175) ... ok
Dec 15 09:07:25.659 INFO [stdout] 
Dec 15 09:07:25.659 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:07:25.659 INFO [stdout] 
Dec 15 09:07:25.687 INFO [stderr] su: No module specific data is present
Dec 15 09:07:26.087 INFO running `"docker" "inspect" "460abb9fce6ac9b612c0dfb45f3a25537667686a3de19ed60ecaca91dde465a1"`
Dec 15 09:07:26.249 INFO running `"docker" "rm" "-f" "460abb9fce6ac9b612c0dfb45f3a25537667686a3de19ed60ecaca91dde465a1"`
Dec 15 09:07:26.383 INFO [stdout] 460abb9fce6ac9b612c0dfb45f3a25537667686a3de19ed60ecaca91dde465a1