Dec 07 11:19:30.805 INFO testing hdrhistogram-6.1.1 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514 Dec 07 11:19:30.806 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 11:19:31.221 INFO [stdout] 19d0b9b4aa661e55a3c895b02e962178425666469ddb54bddc134a5cd1380e2c Dec 07 11:19:31.226 INFO running `"docker" "start" "-a" "19d0b9b4aa661e55a3c895b02e962178425666469ddb54bddc134a5cd1380e2c"` Dec 07 11:19:32.279 INFO [stderr] usermod: no changes Dec 07 11:19:32.453 INFO [stderr] Compiling hdrhistogram v6.1.1 (/source) Dec 07 11:19:34.964 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 2.65s Dec 07 11:19:34.972 INFO [stderr] su: No module specific data is present Dec 07 11:19:35.574 INFO running `"docker" "inspect" "19d0b9b4aa661e55a3c895b02e962178425666469ddb54bddc134a5cd1380e2c"` Dec 07 11:19:35.808 INFO running `"docker" "rm" "-f" "19d0b9b4aa661e55a3c895b02e962178425666469ddb54bddc134a5cd1380e2c"` Dec 07 11:19:36.031 INFO [stdout] 19d0b9b4aa661e55a3c895b02e962178425666469ddb54bddc134a5cd1380e2c Dec 07 11:19:36.038 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 11:19:36.558 INFO [stdout] a013e131d52bc255c4d86f13e6320fbaad01bb73bcdec3b92289aff26aad6800 Dec 07 11:19:36.559 INFO running `"docker" "start" "-a" "a013e131d52bc255c4d86f13e6320fbaad01bb73bcdec3b92289aff26aad6800"` Dec 07 11:19:37.932 INFO [stderr] usermod: no changes Dec 07 11:19:38.194 INFO [stderr] Compiling gmp-mpfr-sys v1.1.9 Dec 07 11:19:38.208 INFO [stderr] Compiling rug v1.2.2 Dec 07 11:23:30.690 INFO [stderr] Compiling hdrhistogram v6.1.1 (/source) Dec 07 11:23:50.752 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 4m 12s Dec 07 11:23:50.764 INFO [stderr] su: No module specific data is present Dec 07 11:23:51.396 INFO running `"docker" "inspect" "a013e131d52bc255c4d86f13e6320fbaad01bb73bcdec3b92289aff26aad6800"` Dec 07 11:23:51.756 INFO running `"docker" "rm" "-f" "a013e131d52bc255c4d86f13e6320fbaad01bb73bcdec3b92289aff26aad6800"` Dec 07 11:23:51.935 INFO [stdout] a013e131d52bc255c4d86f13e6320fbaad01bb73bcdec3b92289aff26aad6800 Dec 07 11:23:51.937 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 11:23:52.336 INFO [stdout] 08c4b37e3a487e6302fdbfec86fcb1009b0c5be09d938326eb644bb19b328408 Dec 07 11:23:52.342 INFO running `"docker" "start" "-a" "08c4b37e3a487e6302fdbfec86fcb1009b0c5be09d938326eb644bb19b328408"` Dec 07 11:23:53.924 INFO [stderr] usermod: no changes Dec 07 11:23:54.037 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.09s Dec 07 11:23:54.044 INFO [stderr] Running /target/debug/deps/hdrhistogram-96d5fae03c4f6b05 Dec 07 11:23:54.052 INFO [stdout] Dec 07 11:23:54.052 INFO [stdout] running 160 tests Dec 07 11:23:54.052 INFO [stdout] test serialization::interval_log::tests::iter_without_ignored_prefix ... ok Dec 07 11:23:54.052 INFO [stdout] test serialization::interval_log::tests::iter_with_ignored_prefix ... ok Dec 07 11:23:54.053 INFO [stdout] test serialization::interval_log::tests::iter_multiple_entrties_with_interleaved_ignored ... ok Dec 07 11:23:54.053 INFO [stdout] test serialization::interval_log::tests::parse_duration_scale_ns ... ok Dec 07 11:23:54.053 INFO [stdout] test serialization::interval_log::tests::parse_duration_too_many_ns ... ok Dec 07 11:23:54.053 INFO [stdout] test serialization::interval_log::tests::parse_interval_hist_no_tag ... ok Dec 07 11:23:54.053 INFO [stdout] test serialization::interval_log::tests::parse_interval_hist_with_tag ... ok Dec 07 11:23:54.053 INFO [stdout] test serialization::interval_log::tests::parse_legend ... ok Dec 07 11:23:54.053 INFO [stdout] test serialization::interval_log::tests::parse_start_time_with_human_date ... ok Dec 07 11:23:54.053 INFO [stdout] test serialization::interval_log::tests::parse_start_time_without_human_date ... ok Dec 07 11:23:54.053 INFO [stdout] test serialization::interval_log::tests::write_base_time ... ok Dec 07 11:23:54.053 INFO [stdout] test serialization::interval_log::tests::write_comment_control_characters_still_parseable ... ok Dec 07 11:23:54.053 INFO [stdout] test serialization::interval_log::tests::write_comment_newline_wraps ... ok Dec 07 11:23:54.053 INFO [stdout] test serialization::interval_log::tests::write_header_comment ... ok Dec 07 11:23:54.054 INFO [stdout] test serialization::interval_log::tests::write_header_then_interval_comment ... ok Dec 07 11:23:54.054 INFO [stdout] test serialization::interval_log::tests::write_headers_multiple_times_only_last_is_used ... ok Dec 07 11:23:54.064 INFO [stdout] test serialization::interval_log::tests::write_interval_histo_no_tag ... ok Dec 07 11:23:54.065 INFO [stdout] test serialization::interval_log::tests::iter_all_ignored_empty_iter ... ok Dec 07 11:23:54.065 INFO [stdout] test serialization::interval_log::tests::parse_base_time ... ok Dec 07 11:23:54.065 INFO [stdout] test serialization::interval_log::tests::parse_duration_full_ns ... ok Dec 07 11:23:54.065 INFO [stdout] test serialization::interval_log::tests::parse_comment ... ok Dec 07 11:23:54.071 INFO [stdout] test serialization::interval_log::tests::write_start_time ... ok Dec 07 11:23:54.071 INFO [stdout] test serialization::tests::encode_counts_count_too_big ... ok Dec 07 11:23:54.071 INFO [stdout] test serialization::tests::rand_varint::largest_number_in_7_bit_chunk_correct ... ok Dec 07 11:23:54.071 INFO [stdout] test serialization::tests::encode_counts_all_zeros ... ok Dec 07 11:23:54.076 INFO [stdout] test serialization::tests::serialize_all_zeros ... ok Dec 07 11:23:54.084 INFO [stdout] test serialization::interval_log::tests::write_interval_histo_with_tag ... ok Dec 07 11:23:54.084 INFO [stdout] test serialization::tests::encode_counts_first_count_incremented ... ok Dec 07 11:23:54.084 INFO [stdout] test serialization::tests::encode_counts_first_and_last_count_incremented ... ok Dec 07 11:23:54.084 INFO [stdout] test serialization::tests::serialize_roundtrip_all_zeros ... ok Dec 07 11:23:54.084 INFO [stdout] test serialization::tests::serialize_roundtrip_1_count_for_every_value_1_bucket ... ok Dec 07 11:23:54.084 INFO [stdout] test serialization::tests::encode_counts_last_count_incremented ... ok Dec 07 11:23:54.084 INFO [stdout] test serialization::tests::serialize_roundtrip_1_count_for_every_value_2_buckets ... ok Dec 07 11:23:54.932 INFO [stdout] test serialization::interval_log::tests::duration_fp_roundtrip_accuracy ... ok Dec 07 11:24:01.492 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u32 ... ok Dec 07 11:24:01.532 INFO [stdout] test serialization::tests::varint_read_u64_max ... ok Dec 07 11:24:01.532 INFO [stdout] test serialization::tests::varint_read_u64_zero ... ok Dec 07 11:24:01.536 INFO [stdout] test serialization::tests::varint_write_3_bit_value ... ok Dec 07 11:24:01.536 INFO [stdout] test serialization::tests::varint_write_7_bit_value ... ok Dec 07 11:24:01.536 INFO [stdout] test serialization::tests::varint_write_9_bit_value ... ok Dec 07 11:24:02.455 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_1_byte ... ok Dec 07 11:24:03.268 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_2_byte ... ok Dec 07 11:24:04.389 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_3_byte ... ok Dec 07 11:24:04.626 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u64 ... ok Dec 07 11:24:05.412 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_4_byte ... ok Dec 07 11:24:06.028 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_5_byte ... ok Dec 07 11:24:06.932 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u16 ... ok Dec 07 11:24:06.968 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_6_byte ... ok Dec 07 11:24:07.656 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_7_byte ... ok Dec 07 11:24:08.000 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_1_byte ... ok Dec 07 11:24:08.270 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_2_byte ... ok Dec 07 11:24:08.299 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u32 ... ok Dec 07 11:24:08.566 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_8_byte ... ok Dec 07 11:24:08.716 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u8 ... ok Dec 07 11:24:08.756 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_9_byte ... ok Dec 07 11:24:09.232 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_3_byte ... ok Dec 07 11:24:09.260 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_4_byte ... ok Dec 07 11:24:09.432 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_9_byte ... ok Dec 07 11:24:09.444 INFO [stdout] test serialization::tests::varint_write_u64_max ... ok Dec 07 11:24:09.452 INFO [stdout] test serialization::tests::zig_zag_decode_0 ... ok Dec 07 11:24:09.456 INFO [stdout] test serialization::tests::zig_zag_decode_1 ... ok Dec 07 11:24:09.456 INFO [stdout] test serialization::tests::zig_zag_decode_2 ... ok Dec 07 11:24:09.456 INFO [stdout] test serialization::tests::zig_zag_decode_u64_max_penultimate_to_i64_max ... ok Dec 07 11:24:09.456 INFO [stdout] test serialization::tests::zig_zag_decode_u64_max_to_i64_min ... ok Dec 07 11:24:09.456 INFO [stdout] test serialization::tests::zig_zag_encode_0 ... ok Dec 07 11:24:09.456 INFO [stdout] test serialization::tests::zig_zag_encode_1 ... ok Dec 07 11:24:09.456 INFO [stdout] test serialization::tests::zig_zag_encode_i64_max ... ok Dec 07 11:24:09.456 INFO [stdout] test serialization::tests::zig_zag_encode_i64_min ... ok Dec 07 11:24:09.456 INFO [stdout] test serialization::tests::zig_zag_encode_neg_1 ... ok Dec 07 11:24:09.567 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_7_byte ... ok Dec 07 11:24:09.588 INFO [stdout] test tests::correct_original_min ... ok Dec 07 11:24:09.612 INFO [stdout] test tests::index_calculation::bucket_for_biggest_value_in_first_bucket ... ok Dec 07 11:24:09.632 INFO [stdout] test tests::index_calculation::bucket_for_biggest_value_in_second_bucket ... ok Dec 07 11:24:09.652 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_first_bucket ... ok Dec 07 11:24:09.660 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_last_bucket ... ok Dec 07 11:24:09.672 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_5_byte ... ok Dec 07 11:24:09.700 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_third_bucket ... ok Dec 07 11:24:09.716 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_second_bucket ... ok Dec 07 11:24:09.724 INFO [stdout] test tests::index_calculation::bucket_for_value_below_smallest_clamps_to_zero ... ok Dec 07 11:24:09.740 INFO [stdout] test tests::index_calculation::bucket_for_value_above_biggest_isnt_clamped_at_max_bucket ... ok Dec 07 11:24:09.748 INFO [stdout] test tests::index_calculation::index_for_below_smallest ... ok Dec 07 11:24:09.748 INFO [stdout] test tests::index_calculation::index_for_first_bucket_first_distinguishable_entry ... ok Dec 07 11:24:09.760 INFO [stdout] test tests::index_calculation::index_for_first_bucket_first_entry ... ok Dec 07 11:24:09.760 INFO [stdout] test tests::index_calculation::index_for_first_bucket_last_entry ... ok Dec 07 11:24:09.776 INFO [stdout] test tests::index_calculation::index_for_second_bucket_first_entry ... ok Dec 07 11:24:09.776 INFO [stdout] test tests::index_calculation::index_for_second_bucket_last_entry ... ok Dec 07 11:24:09.776 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_6_byte ... ok Dec 07 11:24:09.783 INFO [stdout] test tests::index_calculation::index_for_second_bucket_last_entry_indistinguishable ... ok Dec 07 11:24:09.783 INFO [stdout] test tests::index_calculation::index_for_way_past_largest_value_exceeds_length ... ok Dec 07 11:24:09.783 INFO [stdout] test tests::index_calculation::sub_bucket_for_biggest_value_in_second_bucket ... ok Dec 07 11:24:09.783 INFO [stdout] test tests::index_calculation::sub_bucket_for_largest_value_in_first_bucket ... ok Dec 07 11:24:09.804 INFO [stdout] test tests::index_calculation::sub_bucket_for_largest_value_in_first_bucket_unit_magnitude_2 ... ok Dec 07 11:24:09.804 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_distinguishable_value_in_first_bucket_unit_magnitude_2 ... ok Dec 07 11:24:09.804 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_second_bucket ... ok Dec 07 11:24:09.804 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_second_bucket_unit_magnitude_2 ... ok Dec 07 11:24:09.804 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_third_bucket ... ok Dec 07 11:24:09.804 INFO [stdout] test tests::index_calculation::sub_bucket_for_value_above_biggest_still_works ... ok Dec 07 11:24:09.804 INFO [stdout] test tests::index_calculation::sub_bucket_for_value_below_smallest_clamps_to_zero ... ok Dec 07 11:24:09.804 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_distinguishable_value_in_first_bucket ... ok Dec 07 11:24:09.804 INFO [stdout] test tests::index_calculation::sub_bucket_for_zero_value_in_first_bucket ... ok Dec 07 11:24:09.804 INFO [stdout] test tests::index_calculation::sub_bucket_for_smaller_than_distinguishable_value_in_first_bucket_unit_magnitude_2 ... ok Dec 07 11:24:09.817 INFO [stdout] test tests::index_calculation::unit_magnitude_0_index_calculations ... ok Dec 07 11:24:09.818 INFO [stdout] test tests::index_calculation::sub_bucket_for_zero_value_in_first_bucket_unit_magnitude_2 ... ok Dec 07 11:24:09.818 INFO [stdout] test tests::index_calculation::unit_magnitude_4_index_calculations ... ok Dec 07 11:24:09.818 INFO [stdout] test tests::index_calculation::unit_magnitude_53_sub_bucket_magnitude_11_throws ... ok Dec 07 11:24:09.818 INFO [stdout] test tests::index_calculation::unit_magnitude_52_sub_bucket_magnitude_11_index_calculations ... ok Dec 07 11:24:09.818 INFO [stdout] test tests::index_calculation::unit_magnitude_55_sub_bucket_magnitude_8_ok ... ok Dec 07 11:24:09.820 INFO [stdout] test tests::init::init_fields_10m_max_1k_min_middle_precision ... ok Dec 07 11:24:09.820 INFO [stdout] test tests::index_calculation::unit_magnitude_62_sub_bucket_magnitude_1_ok ... ok Dec 07 11:24:09.820 INFO [stdout] test tests::init::init_fields_max_value_0_precision_increased_min_value ... ok Dec 07 11:24:09.820 INFO [stdout] test tests::init::init_fields_max_value_0_precision_most_buckets ... ok Dec 07 11:24:09.820 INFO [stdout] test serialization::tests::zig_zag_roundtrip_random ... ok Dec 07 11:24:09.820 INFO [stdout] test tests::init::init_fields_max_value_max_unit_magnitude_0_precision ... ok Dec 07 11:24:09.820 INFO [stdout] test tests::init::init_fields_1_bucket_medium_precision ... ok Dec 07 11:24:09.844 INFO [stdout] test tests::init::init_fields_max_value_medium_precision ... ok Dec 07 11:24:09.859 INFO [stdout] test tests::init::init_fields_smallest_possible_array ... ok Dec 07 11:24:09.872 INFO [stdout] test tests::new_err_high_not_double_low ... ok Dec 07 11:24:10.020 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u64 ... ok Dec 07 11:24:10.047 INFO [stdout] test tests::init::init_fields_max_value_max_unit_magnitude_max_precision ... ok Dec 07 11:24:10.168 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_8_byte ... ok Dec 07 11:24:10.272 INFO [stdout] test tests::subtract::subtract_after_add ... ok Dec 07 11:24:10.324 INFO [stdout] test tests::subtract::subtract_subtrahend_values_outside_minuend_range_error ... ok Dec 07 11:24:10.432 INFO [stdout] test tests::subtract::subtract_to_negative_counts_error ... ok Dec 07 11:24:10.460 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u8 ... ok Dec 07 11:24:10.620 INFO [stdout] test tests::subtract::subtract_to_zero_counts ... ok Dec 07 11:24:10.830 INFO [stdout] test tests::subtract::subtract_values_at_extent_of_minuend_nonzero_count_range_recalculates_same_min_max ... ok Dec 07 11:24:10.836 INFO [stdout] test tests::subtract::subtract_values_at_extent_of_minuend_zero_count_range_recalculates_min_max ... ok Dec 07 11:24:10.896 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u16 ... ok Dec 07 11:24:10.972 INFO [stdout] test tests::subtract::subtract_values_minuend_saturated_total_recalculates_not_saturated ... ok Dec 07 11:24:11.012 INFO [stdout] test tests::subtract::subtract_values_strictly_inside_minuend_range_yields_same_min_max_no_restat ... ok Dec 07 11:24:11.211 INFO [stdout] test tests::subtract::subtract_values_minuend_saturated_total_recalculates_saturated ... ok Dec 07 11:24:11.213 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0 ... ok Dec 07 11:24:11.237 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_max_buckets ... ok Dec 07 11:24:11.335 INFO [stdout] test tests::subtract::subtract_values_inside_minuend_range_works ... ok Dec 07 11:24:11.344 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_min_precision_max_buckets ... ok Dec 07 11:24:11.375 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_2 ... ok Dec 07 11:24:11.375 INFO [stdout] test tests::init::init_fields_max_value_max_precision_increased_min_value ... ok Dec 07 11:24:11.420 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_50_max_buckets ... ok Dec 07 11:24:11.420 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_2_max_buckets ... ok Dec 07 11:24:11.427 INFO [stdout] test tests::value_calculation::highest_equivalent_unit_magnitude_0 ... ok Dec 07 11:24:11.449 INFO [stdout] test tests::value_calculation::highest_equivalent_u64_max_value_saturates ... ok Dec 07 11:24:11.453 INFO [stdout] test tests::value_calculation::lowest_equivalent_unit_magnitude_0 ... ok Dec 07 11:24:11.469 INFO [stdout] test tests::value_calculation::lowest_equivalent_unit_magnitude_2 ... ok Dec 07 11:24:11.476 INFO [stdout] test tests::value_calculation::next_non_equivalent_u64_max_value_saturates ... ok Dec 07 11:24:11.529 INFO [stdout] test tests::value_calculation::highest_equivalent_unit_magnitude_2 ... ok Dec 07 11:24:11.533 INFO [stdout] test tests::value_calculation::next_non_equivalent_unit_magnitude_2 ... ok Dec 07 11:24:11.533 INFO [stdout] test tests::value_calculation::next_non_equivalent_unit_magnitude_0 ... ok Dec 07 11:24:11.564 INFO [stdout] test tests::value_calculation::value_for_beyond_histogram_max_still_works ... ok Dec 07 11:24:11.576 INFO [stdout] test tests::value_calculation::value_for_impossible_index ... ok Dec 07 11:24:11.625 INFO [stdout] test tests::value_calculation::value_for_unit_magnitude_0 ... ok Dec 07 11:24:11.677 INFO [stdout] test tests::value_calculation::value_for_unit_magnitude_2 ... ok Dec 07 11:24:11.697 INFO [stdout] test tests::value_calculation::value_from_loc_unit_magnitude_0 ... ok Dec 07 11:24:11.697 INFO [stdout] test tests::value_calculation::value_from_loc_unit_magnitude_2 ... ok Dec 07 11:24:11.804 INFO [stdout] test tests::init::init_fields_max_value_max_precision_largest_possible_array ... ok Dec 07 11:24:12.013 INFO [stdout] test tests::value_calculation::value_for_at_each_index ... ok Dec 07 11:24:12.633 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_max_precision_max_buckets ... ok Dec 07 11:24:17.174 INFO [stdout] test tests::subtract::subtract_values_at_minuend_max_recalculates_min_max ... ok Dec 07 11:24:17.536 INFO [stdout] test tests::subtract::subtract_values_within_bucket_precision_of_of_minuend_min_recalculates_min_max ... ok Dec 07 11:24:17.693 INFO [stdout] test tests::subtract::subtract_values_at_minuend_min_recalculates_min_max ... ok Dec 07 11:24:18.272 INFO [stdout] test tests::subtract::subtract_values_within_bucket_precision_of_of_minuend_max_recalculates_min_max ... ok Dec 07 11:24:18.272 INFO [stderr] Running /target/debug/deps/auto_resize-90c7f21ffde12a51 Dec 07 11:24:18.272 INFO [stdout] Dec 07 11:24:18.272 INFO [stdout] test result: ok. 160 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 11:24:18.272 INFO [stdout] Dec 07 11:24:18.280 INFO [stdout] Dec 07 11:24:18.280 INFO [stdout] running 4 tests Dec 07 11:24:18.281 INFO [stdout] test autosizing_add ... ok Dec 07 11:24:18.305 INFO [stdout] test histogram_autosizing ... ok Dec 07 11:24:18.305 INFO [stdout] test histogram_autosizing_edges ... ok Dec 07 11:24:20.675 INFO [stdout] test autosizing_across_continuous_range ... ok Dec 07 11:24:20.675 INFO [stdout] Dec 07 11:24:20.675 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 11:24:20.675 INFO [stdout] Dec 07 11:24:20.676 INFO [stderr] Running /target/debug/deps/data_access-3d85fd820bdaed11 Dec 07 11:24:20.683 INFO [stdout] Dec 07 11:24:20.683 INFO [stdout] running 26 tests Dec 07 11:24:20.737 INFO [stdout] test count_at_beyond_max_value ... ok Dec 07 11:24:20.743 INFO [stdout] test count_between_high_beyond_max ... ok Dec 07 11:24:20.761 INFO [stdout] test count_between_low_and_high_beyond_max ... ok Dec 07 11:24:20.852 INFO [stdout] test count_between_saturates ... ok Dec 07 11:24:20.936 INFO [stdout] test get_max_value ... ok Dec 07 11:24:20.976 INFO [stdout] test get_min_value ... ok Dec 07 11:24:20.991 INFO [stdout] test count_at ... ok Dec 07 11:24:21.104 INFO [stdout] test count_between ... ok Dec 07 11:24:21.124 INFO [stdout] test iter_log ... ok Dec 07 11:24:21.144 INFO [stdout] test linear_iter_steps ... ok Dec 07 11:24:21.152 INFO [stdout] test get_stdev ... ok Dec 07 11:24:21.164 INFO [stdout] test iter_recorded ... ok Dec 07 11:24:21.188 INFO [stdout] test quantile_below_saturates ... ok Dec 07 11:24:21.188 INFO [stdout] test quantile_below_value_beyond_max ... ok Dec 07 11:24:21.208 INFO [stdout] test quantile_atorbelow ... ok Dec 07 11:24:21.228 INFO [stdout] test get_mean ... ok Dec 07 11:24:21.264 INFO [stdout] test linear_iter_corrected ... ok Dec 07 11:24:21.264 INFO [stdout] test total_count_exceeds_bucket_type ... ok Dec 07 11:24:21.304 INFO [stdout] test quantiles ... ok Dec 07 11:24:21.336 INFO [stdout] test total_count ... ok Dec 07 11:24:21.356 INFO [stdout] test iter_all ... ok Dec 07 11:24:21.388 INFO [stdout] test linear_iter_raw ... ok Dec 07 11:24:21.443 INFO [stdout] test value_duplication ... ok Dec 07 11:24:21.484 INFO [stdout] test scaling_equivalence ... ok Dec 07 11:24:21.584 INFO [stdout] test quantile_iter ... ok Dec 07 11:24:21.991 INFO [stdout] test large_quantile ... ok Dec 07 11:24:21.991 INFO [stdout] Dec 07 11:24:21.991 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 11:24:21.991 INFO [stdout] Dec 07 11:24:21.995 INFO [stderr] Running /target/debug/deps/histogram-94ab5aa89ea560f2 Dec 07 11:24:22.011 INFO [stdout] Dec 07 11:24:22.011 INFO [stdout] running 37 tests Dec 07 11:24:22.032 INFO [stdout] test construction_arg_gets ... ok Dec 07 11:24:22.040 INFO [stdout] test empty_histogram ... ok Dec 07 11:24:22.040 INFO [stdout] test construction_arg_ranges ... ok Dec 07 11:24:22.056 INFO [stdout] test highest_equivalent ... ok Dec 07 11:24:22.056 INFO [stdout] test equivalent_range ... ok Dec 07 11:24:22.056 INFO [stdout] test lowest_equivalent ... ok Dec 07 11:24:22.056 INFO [stdout] test record ... ok Dec 07 11:24:22.064 INFO [stdout] test median_equivalent ... ok Dec 07 11:24:22.077 INFO [stdout] test record_past_trackable_max ... ok Dec 07 11:24:22.077 INFO [stdout] test median_equivalent_doesnt_panic_at_extremes ... ok Dec 07 11:24:22.084 INFO [stdout] test add ... ok Dec 07 11:24:22.084 INFO [stdout] test record_in_interval ... ok Dec 07 11:24:22.087 INFO [stdout] test scaled_equivalent_range ... ok Dec 07 11:24:22.090 INFO [stdout] test reset ... ok Dec 07 11:24:22.092 INFO [stdout] test saturating_record ... ok Dec 07 11:24:22.096 INFO [stdout] test scaled_median_equivalent ... ok Dec 07 11:24:22.096 INFO [stdout] test scaled_lowest_equivalent ... ok Dec 07 11:24:22.097 INFO [stdout] test scaled_highest_equivalent ... ok Dec 07 11:24:22.161 INFO [stdout] test subtract_underflow_guarded_by_per_value_count_check ... ok Dec 07 11:24:22.161 INFO [stdout] test scaled_set_to ... ok Dec 07 11:24:22.196 INFO [stdout] test clone ... ok Dec 07 11:24:22.216 INFO [stdout] test total_count_overflow_from_add_same_dimensions_saturates_calculating_other_addend_total ... ok Dec 07 11:24:22.240 INFO [stdout] test total_count_overflow_from_add_with_resize_saturates ... ok Dec 07 11:24:22.248 INFO [stdout] test scaled_clone ... ok Dec 07 11:24:22.256 INFO [stdout] test total_count_overflow_from_record_saturates ... ok Dec 07 11:24:22.300 INFO [stdout] test set_to ... ok Dec 07 11:24:22.332 INFO [stdout] test value_count_overflow_from_add_same_dimensions_saturates ... ok Dec 07 11:24:22.332 INFO [stdout] test value_count_overflow_from_add_with_resize_to_same_dimensions_saturates ... ok Dec 07 11:24:22.334 INFO [stdout] test value_count_overflow_from_record_autoresize_doesnt_panic_saturates ... ok Dec 07 11:24:22.334 INFO [stdout] test value_count_overflow_from_record_saturates_u16 ... ok Dec 07 11:24:22.339 INFO [stdout] test total_count_overflow_from_add_same_dimensions_saturates_when_added_to_orig_total_count ... ok Dec 07 11:24:22.340 INFO [stdout] test value_count_overflow_from_record_saturates_u64 ... ok Dec 07 11:24:22.388 INFO [stdout] test value_count_overflow_from_add_different_precision_saturates ... ok Dec 07 11:24:22.505 INFO [stdout] test total_count_overflow_from_add_different_precision_saturates ... ok Dec 07 11:24:22.772 INFO [stdout] test random_write_full_value_range_precision_0_no_panic ... ok Dec 07 11:24:22.928 INFO [stdout] test random_write_middle_of_value_range_precision_3_no_panic ... ok Dec 07 11:24:23.204 INFO [stdout] test random_write_full_value_range_precision_5_no_panic ... ok Dec 07 11:24:23.204 INFO [stdout] Dec 07 11:24:23.204 INFO [stdout] test result: ok. 37 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 11:24:23.204 INFO [stdout] Dec 07 11:24:23.204 INFO [stderr] Running /target/debug/deps/interval_log-21875f19d1ba5e75 Dec 07 11:24:23.208 INFO [stdout] Dec 07 11:24:23.208 INFO [stdout] running 6 tests Dec 07 11:24:23.224 INFO [stdout] test tests::parse_interval_log_syntax_error_then_returns_none ... ok Dec 07 11:24:23.228 INFO [stdout] test tests::parse_sample_tagged_interval_log_interval_count ... ok Dec 07 11:24:23.239 INFO [stdout] test tests::parse_sample_tagged_interval_log_start_timestamp ... ok Dec 07 11:24:23.254 INFO [stdout] test tests::parse_sample_tagged_interval_log_interval_metadata ... ok Dec 07 11:24:23.281 INFO [stdout] test tests::parse_sample_tagged_interval_log_rewrite_identical ... ok Dec 07 11:24:26.444 INFO [stdout] test tests::write_random_histograms_to_interval_log_then_read ... ok Dec 07 11:24:26.444 INFO [stderr] Running /target/debug/deps/iterators-35718e84cea558fa Dec 07 11:24:26.444 INFO [stdout] Dec 07 11:24:26.444 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 11:24:26.444 INFO [stdout] Dec 07 11:24:26.452 INFO [stdout] Dec 07 11:24:26.452 INFO [stdout] running 20 tests Dec 07 11:24:26.464 INFO [stdout] test iter_linear_bucket_values_size_8_all_buckets ... ok Dec 07 11:24:26.464 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_10_all_buckets ... ok Dec 07 11:24:26.464 INFO [stdout] test iter_linear_visits_buckets_wider_than_step_size_multiple_times ... ok Dec 07 11:24:26.472 INFO [stdout] test iter_logarithmic_bucket_values_min_4_base_2_all_buckets ... ok Dec 07 11:24:26.472 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_2_all_buckets_unit_magnitude_2 ... ok Dec 07 11:24:26.472 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_2_all_buckets ... ok Dec 07 11:24:26.472 INFO [stdout] test iter_quantiles_iterates_to_end_skips_intermediate_at_final_value ... ok Dec 07 11:24:26.484 INFO [stdout] test iter_quantiles_empty ... ok Dec 07 11:24:26.484 INFO [stdout] test iter_quantiles_saturated_count_before_max_value ... ok Dec 07 11:24:26.496 INFO [stdout] test iter_quantiles_one_value ... ok Dec 07 11:24:26.496 INFO [stdout] test iter_quantiles_smorgasboard ... ok Dec 07 11:24:26.496 INFO [stdout] test iter_quantiles_iterates_to_quantile_10_as_it_reaches_last_bucket ... ok Dec 07 11:24:26.497 INFO [stdout] test iter_recorded_values_all_buckets ... ok Dec 07 11:24:26.497 INFO [stdout] test iter_all_values_all_buckets_unit_magnitude_2 ... ok Dec 07 11:24:26.506 INFO [stdout] test iter_all_values_all_buckets ... ok Dec 07 11:24:26.516 INFO [stdout] test iter_linear_count_since_last_iteration_saturates ... ok Dec 07 11:24:26.557 INFO [stdout] test iter_recorded_saturated_total_count ... ok Dec 07 11:24:26.557 INFO [stdout] test iter_linear_visits_buckets_once_when_step_size_equals_bucket_size ... ok Dec 07 11:24:26.557 INFO [stdout] test iter_recorded_values_all_buckets_unit_magnitude_2 ... ok Dec 07 11:24:26.557 INFO [stdout] test iter_recorded_non_saturated_total_count ... ok Dec 07 11:24:26.557 INFO [stdout] Dec 07 11:24:26.557 INFO [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 11:24:26.557 INFO [stdout] Dec 07 11:24:26.557 INFO [stdout] Dec 07 11:24:26.557 INFO [stdout] running 10 tests Dec 07 11:24:26.557 INFO [stderr] Running /target/debug/deps/quantile-51994475a28d6593 Dec 07 11:24:26.612 INFO [stdout] test value_at_quantile_internal_count_exceeds_bucket_type ... ok Dec 07 11:24:26.616 INFO [stdout] test value_at_quantile_2_values ... ok Dec 07 11:24:26.620 INFO [stdout] test value_at_quantile_5_values ... ok Dec 07 11:24:26.620 INFO [stdout] test value_at_quantile_20k ... ok Dec 07 11:24:26.752 INFO [stdout] test value_at_quantile_large_numbers ... ok Dec 07 11:24:28.363 INFO [stdout] test value_at_quantile_matches_quantile_iter_sequence_values ... ok Dec 07 11:24:32.812 INFO [stdout] test value_at_quantile_matches_quantile_at_each_value_sequence_values ... ok Dec 07 11:24:49.257 INFO [stdout] test value_at_quantile_matches_quantile_iter_random_values ... ok Dec 07 11:24:52.756 INFO [stdout] test value_at_quantile_matches_random_quantile_random_values ... ok Dec 07 11:25:07.308 INFO [stdout] test value_at_quantile_matches_quantile_at_each_value_random_values ... ok Dec 07 11:25:07.308 INFO [stderr] Running /target/debug/deps/serialization-aa104ff3ffd204f7 Dec 07 11:25:07.308 INFO [stdout] Dec 07 11:25:07.308 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 11:25:07.308 INFO [stdout] Dec 07 11:25:07.316 INFO [stdout] Dec 07 11:25:07.316 INFO [stdout] running 4 tests Dec 07 11:25:07.396 INFO [stdout] test tests::total_count_overflow_from_deserialize_saturates ... ok Dec 07 11:25:07.704 INFO [stdout] test tests::deserialize_compression_matches_java ... ok Dec 07 11:25:07.720 INFO [stdout] test tests::serialize_no_compression_matches_java_impl ... ok Dec 07 11:25:07.760 INFO [stdout] test tests::deserialize_no_compression_matches_java ... ok Dec 07 11:25:07.760 INFO [stdout] Dec 07 11:25:07.760 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 11:25:07.760 INFO [stdout] Dec 07 11:25:07.761 INFO [stderr] Doc-tests hdrhistogram Dec 07 11:25:09.314 INFO [stdout] Dec 07 11:25:09.314 INFO [stdout] running 15 tests Dec 07 11:25:14.348 INFO [stdout] test src/lib.rs - (line 71) ... ok Dec 07 11:25:15.468 INFO [stdout] test src/lib.rs - (line 97) ... ok Dec 07 11:25:15.679 INFO [stdout] test src/lib.rs - Histogram::iter_recorded (line 1131) ... ok Dec 07 11:25:18.028 INFO [stdout] test src/lib.rs - Histogram::iter_all (line 1170) ... ok Dec 07 11:25:18.641 INFO [stdout] test src/lib.rs - (line 110) ... ok Dec 07 11:25:18.984 INFO [stdout] test src/lib.rs - Histogram::iter_log (line 1093) ... ok Dec 07 11:25:19.288 INFO [stdout] test src/lib.rs - Histogram::iter_linear (line 1035) ... ok Dec 07 11:25:19.510 INFO [stdout] test src/lib.rs - Histogram::iter_quantiles (line 977) ... ok Dec 07 11:25:22.052 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 145) ... ok Dec 07 11:25:22.370 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 122) ... ok Dec 07 11:25:22.824 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 175) ... ok Dec 07 11:25:23.122 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log::IntervalLogWriter (line 339) ... ok Dec 07 11:25:23.492 INFO [stdout] test src/serialization/mod.rs - serialization (line 75) ... ok Dec 07 11:25:24.275 INFO [stdout] test src/serialization/mod.rs - serialization (line 119) ... ok Dec 07 11:25:25.312 INFO [stdout] test src/serialization/mod.rs - serialization (line 134) ... ok Dec 07 11:25:25.312 INFO [stdout] Dec 07 11:25:25.312 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 11:25:25.312 INFO [stdout] Dec 07 11:25:25.348 INFO [stderr] su: No module specific data is present Dec 07 11:25:25.924 INFO running `"docker" "inspect" "08c4b37e3a487e6302fdbfec86fcb1009b0c5be09d938326eb644bb19b328408"` Dec 07 11:25:26.288 INFO running `"docker" "rm" "-f" "08c4b37e3a487e6302fdbfec86fcb1009b0c5be09d938326eb644bb19b328408"` Dec 07 11:25:26.668 INFO [stdout] 08c4b37e3a487e6302fdbfec86fcb1009b0c5be09d938326eb644bb19b328408