Nov 18 09:50:11.165 INFO testing hdrhistogram-6.1.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 09:50:11.165 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 09:50:11.372 INFO [stdout] 9cc6fc8d8fbd6758df650b8c222921cb2d03b6f3ef6d65f5514ba45d1f7ac2ec
Nov 18 09:50:11.374 INFO running `"docker" "start" "-a" "9cc6fc8d8fbd6758df650b8c222921cb2d03b6f3ef6d65f5514ba45d1f7ac2ec"`
Nov 18 09:50:11.786 INFO [stderr] usermod: no changes
Nov 18 09:50:11.877 INFO [stderr]    Compiling hdrhistogram v6.1.0 (/source)
Nov 18 09:50:13.933 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.13s
Nov 18 09:50:13.935 INFO [stderr] su: No module specific data is present
Nov 18 09:50:14.315 INFO running `"docker" "inspect" "9cc6fc8d8fbd6758df650b8c222921cb2d03b6f3ef6d65f5514ba45d1f7ac2ec"`
Nov 18 09:50:14.471 INFO running `"docker" "rm" "-f" "9cc6fc8d8fbd6758df650b8c222921cb2d03b6f3ef6d65f5514ba45d1f7ac2ec"`
Nov 18 09:50:14.572 INFO [stdout] 9cc6fc8d8fbd6758df650b8c222921cb2d03b6f3ef6d65f5514ba45d1f7ac2ec
Nov 18 09:50:14.577 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 09:50:14.793 INFO [stdout] edf78f67369a8cc751c3c1f63ebf6cf12a267a6e7388c01b4a2447324947212f
Nov 18 09:50:14.796 INFO running `"docker" "start" "-a" "edf78f67369a8cc751c3c1f63ebf6cf12a267a6e7388c01b4a2447324947212f"`
Nov 18 09:50:15.251 INFO [stderr] usermod: no changes
Nov 18 09:50:15.383 INFO [stderr]    Compiling gmp-mpfr-sys v1.1.9
Nov 18 09:50:15.383 INFO [stderr]    Compiling rug v1.2.2
Nov 18 09:50:15.385 INFO [stderr]    Compiling ieee754 v0.2.2
Nov 18 09:53:58.765 INFO [stderr]    Compiling hdrhistogram v6.1.0 (/source)
Nov 18 09:54:19.185 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4m 03s
Nov 18 09:54:19.219 INFO [stderr] su: No module specific data is present
Nov 18 09:54:19.966 INFO running `"docker" "inspect" "edf78f67369a8cc751c3c1f63ebf6cf12a267a6e7388c01b4a2447324947212f"`
Nov 18 09:54:20.307 INFO running `"docker" "rm" "-f" "edf78f67369a8cc751c3c1f63ebf6cf12a267a6e7388c01b4a2447324947212f"`
Nov 18 09:54:20.871 INFO [stdout] edf78f67369a8cc751c3c1f63ebf6cf12a267a6e7388c01b4a2447324947212f
Nov 18 09:54:20.881 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 09:54:21.297 INFO [stdout] ddab6a8a2e0d55b71b09bd47c32c7fca53bd97715dcaba275e8c5acda760a08c
Nov 18 09:54:21.298 INFO running `"docker" "start" "-a" "ddab6a8a2e0d55b71b09bd47c32c7fca53bd97715dcaba275e8c5acda760a08c"`
Nov 18 09:54:22.360 INFO [stderr] usermod: no changes
Nov 18 09:54:22.496 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.10s
Nov 18 09:54:22.507 INFO [stderr]      Running /target/debug/deps/hdrhistogram-4b8703dca5500b48
Nov 18 09:54:22.507 INFO [stdout] 
Nov 18 09:54:22.507 INFO [stdout] running 160 tests
Nov 18 09:54:22.508 INFO [stdout] test serialization::interval_log::tests::iter_with_ignored_prefix ... ok
Nov 18 09:54:22.508 INFO [stdout] test serialization::interval_log::tests::iter_multiple_entrties_with_interleaved_ignored ... ok
Nov 18 09:54:22.508 INFO [stdout] test serialization::interval_log::tests::iter_all_ignored_empty_iter ... ok
Nov 18 09:54:22.508 INFO [stdout] test serialization::interval_log::tests::parse_duration_too_many_ns ... ok
Nov 18 09:54:22.509 INFO [stdout] test serialization::interval_log::tests::parse_duration_scale_ns ... ok
Nov 18 09:54:22.515 INFO [stdout] test serialization::interval_log::tests::iter_without_ignored_prefix ... ok
Nov 18 09:54:22.515 INFO [stdout] test serialization::interval_log::tests::parse_base_time ... ok
Nov 18 09:54:22.515 INFO [stdout] test serialization::interval_log::tests::parse_comment ... ok
Nov 18 09:54:22.516 INFO [stdout] test serialization::interval_log::tests::parse_duration_full_ns ... ok
Nov 18 09:54:22.516 INFO [stdout] test serialization::interval_log::tests::write_comment_control_characters_still_parseable ... ok
Nov 18 09:54:22.516 INFO [stdout] test serialization::interval_log::tests::parse_start_time_without_human_date ... ok
Nov 18 09:54:22.516 INFO [stdout] test serialization::interval_log::tests::parse_start_time_with_human_date ... ok
Nov 18 09:54:22.517 INFO [stdout] test serialization::interval_log::tests::write_base_time ... ok
Nov 18 09:54:22.517 INFO [stdout] test serialization::interval_log::tests::write_header_then_interval_comment ... ok
Nov 18 09:54:22.517 INFO [stdout] test serialization::interval_log::tests::write_header_comment ... ok
Nov 18 09:54:22.517 INFO [stdout] test serialization::interval_log::tests::write_comment_newline_wraps ... ok
Nov 18 09:54:22.518 INFO [stdout] test serialization::interval_log::tests::write_headers_multiple_times_only_last_is_used ... ok
Nov 18 09:54:22.518 INFO [stdout] test serialization::interval_log::tests::parse_legend ... ok
Nov 18 09:54:22.527 INFO [stdout] test serialization::interval_log::tests::write_start_time ... ok
Nov 18 09:54:22.527 INFO [stdout] test serialization::interval_log::tests::parse_interval_hist_no_tag ... ok
Nov 18 09:54:22.528 INFO [stdout] test serialization::interval_log::tests::parse_interval_hist_with_tag ... ok
Nov 18 09:54:22.529 INFO [stdout] test serialization::tests::encode_counts_count_too_big ... ok
Nov 18 09:54:22.529 INFO [stdout] test serialization::tests::encode_counts_first_and_last_count_incremented ... ok
Nov 18 09:54:22.529 INFO [stdout] test serialization::interval_log::tests::write_interval_histo_no_tag ... ok
Nov 18 09:54:22.530 INFO [stdout] test serialization::tests::encode_counts_last_count_incremented ... ok
Nov 18 09:54:22.530 INFO [stdout] test serialization::tests::encode_counts_first_count_incremented ... ok
Nov 18 09:54:22.549 INFO [stdout] test serialization::tests::rand_varint::largest_number_in_7_bit_chunk_correct ... ok
Nov 18 09:54:22.549 INFO [stdout] test serialization::tests::serialize_roundtrip_all_zeros ... ok
Nov 18 09:54:22.550 INFO [stdout] test serialization::tests::serialize_roundtrip_1_count_for_every_value_2_buckets ... ok
Nov 18 09:54:22.551 INFO [stdout] test serialization::tests::encode_counts_all_zeros ... ok
Nov 18 09:54:22.551 INFO [stdout] test serialization::tests::serialize_all_zeros ... ok
Nov 18 09:54:22.552 INFO [stdout] test serialization::interval_log::tests::write_interval_histo_with_tag ... ok
Nov 18 09:54:22.552 INFO [stdout] test serialization::tests::serialize_roundtrip_1_count_for_every_value_1_bucket ... ok
Nov 18 09:54:23.342 INFO [stdout] test serialization::interval_log::tests::duration_fp_roundtrip_accuracy ... ok
Nov 18 09:54:43.607 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u8 ... ok
Nov 18 09:54:43.619 INFO [stdout] test serialization::tests::varint_read_u64_max ... ok
Nov 18 09:54:43.639 INFO [stdout] test serialization::tests::varint_read_u64_zero ... ok
Nov 18 09:54:43.651 INFO [stdout] test serialization::tests::varint_write_3_bit_value ... ok
Nov 18 09:54:43.671 INFO [stdout] test serialization::tests::varint_write_7_bit_value ... ok
Nov 18 09:54:43.695 INFO [stdout] test serialization::tests::varint_write_9_bit_value ... ok
Nov 18 09:54:44.010 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u32 ... ok
Nov 18 09:54:44.435 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_1_byte ... ok
Nov 18 09:54:44.920 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_2_byte ... ok
Nov 18 09:54:45.323 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_4_byte ... ok
Nov 18 09:54:45.791 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_3_byte ... ok
Nov 18 09:54:46.219 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_5_byte ... ok
Nov 18 09:54:46.603 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u64 ... ok
Nov 18 09:54:47.027 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u32 ... ok
Nov 18 09:54:47.503 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_6_byte ... ok
Nov 18 09:54:47.687 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u8 ... ok
Nov 18 09:54:47.903 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u16 ... ok
Nov 18 09:54:47.995 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_7_byte ... ok
Nov 18 09:54:48.291 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_1_byte ... ok
Nov 18 09:54:48.580 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_8_byte ... ok
Nov 18 09:54:48.587 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_2_byte ... ok
Nov 18 09:54:48.749 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_9_byte ... ok
Nov 18 09:54:48.859 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_3_byte ... ok
Nov 18 09:54:48.908 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_4_byte ... ok
Nov 18 09:54:48.935 INFO [stdout] test serialization::tests::varint_write_u64_max ... ok
Nov 18 09:54:48.947 INFO [stdout] test serialization::tests::zig_zag_decode_0 ... ok
Nov 18 09:54:48.952 INFO [stdout] test serialization::tests::zig_zag_decode_1 ... ok
Nov 18 09:54:48.975 INFO [stdout] test serialization::tests::zig_zag_decode_2 ... ok
Nov 18 09:54:48.991 INFO [stdout] test serialization::tests::zig_zag_decode_u64_max_penultimate_to_i64_max ... ok
Nov 18 09:54:48.995 INFO [stdout] test serialization::tests::zig_zag_decode_u64_max_to_i64_min ... ok
Nov 18 09:54:49.007 INFO [stdout] test serialization::tests::zig_zag_encode_0 ... ok
Nov 18 09:54:49.015 INFO [stdout] test serialization::tests::zig_zag_encode_1 ... ok
Nov 18 09:54:49.016 INFO [stdout] test serialization::tests::zig_zag_encode_i64_max ... ok
Nov 18 09:54:49.031 INFO [stdout] test serialization::tests::zig_zag_encode_i64_min ... ok
Nov 18 09:54:49.035 INFO [stdout] test serialization::tests::zig_zag_encode_neg_1 ... ok
Nov 18 09:54:49.143 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_5_byte ... ok
Nov 18 09:54:49.147 INFO [stdout] test tests::correct_original_min ... ok
Nov 18 09:54:49.147 INFO [stdout] test tests::index_calculation::bucket_for_biggest_value_in_first_bucket ... ok
Nov 18 09:54:49.148 INFO [stdout] test tests::index_calculation::bucket_for_biggest_value_in_second_bucket ... ok
Nov 18 09:54:49.148 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_first_bucket ... ok
Nov 18 09:54:49.149 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_last_bucket ... ok
Nov 18 09:54:49.150 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_second_bucket ... ok
Nov 18 09:54:49.179 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_third_bucket ... ok
Nov 18 09:54:49.207 INFO [stdout] test tests::index_calculation::bucket_for_value_above_biggest_isnt_clamped_at_max_bucket ... ok
Nov 18 09:54:49.219 INFO [stdout] test tests::index_calculation::bucket_for_value_below_smallest_clamps_to_zero ... ok
Nov 18 09:54:49.231 INFO [stdout] test tests::index_calculation::index_for_below_smallest ... ok
Nov 18 09:54:49.255 INFO [stdout] test tests::index_calculation::index_for_first_bucket_first_distinguishable_entry ... ok
Nov 18 09:54:49.256 INFO [stdout] test tests::index_calculation::index_for_first_bucket_first_entry ... ok
Nov 18 09:54:49.263 INFO [stdout] test tests::index_calculation::index_for_first_bucket_last_entry ... ok
Nov 18 09:54:49.283 INFO [stdout] test tests::index_calculation::index_for_second_bucket_first_entry ... ok
Nov 18 09:54:49.302 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_6_byte ... ok
Nov 18 09:54:49.303 INFO [stdout] test tests::index_calculation::index_for_second_bucket_last_entry_indistinguishable ... ok
Nov 18 09:54:49.303 INFO [stdout] test tests::index_calculation::index_for_second_bucket_last_entry ... ok
Nov 18 09:54:49.304 INFO [stdout] test tests::index_calculation::index_for_way_past_largest_value_exceeds_length ... ok
Nov 18 09:54:49.308 INFO [stdout] test tests::index_calculation::sub_bucket_for_biggest_value_in_second_bucket ... ok
Nov 18 09:54:49.309 INFO [stdout] test tests::index_calculation::sub_bucket_for_largest_value_in_first_bucket ... ok
Nov 18 09:54:49.319 INFO [stdout] test tests::index_calculation::sub_bucket_for_largest_value_in_first_bucket_unit_magnitude_2 ... ok
Nov 18 09:54:49.319 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_distinguishable_value_in_first_bucket ... ok
Nov 18 09:54:49.320 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_distinguishable_value_in_first_bucket_unit_magnitude_2 ... ok
Nov 18 09:54:49.320 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_second_bucket ... ok
Nov 18 09:54:49.321 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_second_bucket_unit_magnitude_2 ... ok
Nov 18 09:54:49.321 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_third_bucket ... ok
Nov 18 09:54:49.322 INFO [stdout] test tests::index_calculation::sub_bucket_for_value_above_biggest_still_works ... ok
Nov 18 09:54:49.323 INFO [stdout] test tests::index_calculation::sub_bucket_for_value_below_smallest_clamps_to_zero ... ok
Nov 18 09:54:49.343 INFO [stdout] test tests::index_calculation::sub_bucket_for_zero_value_in_first_bucket ... ok
Nov 18 09:54:49.347 INFO [stdout] test tests::index_calculation::sub_bucket_for_smaller_than_distinguishable_value_in_first_bucket_unit_magnitude_2 ... ok
Nov 18 09:54:49.364 INFO [stdout] test tests::index_calculation::unit_magnitude_0_index_calculations ... ok
Nov 18 09:54:49.365 INFO [stdout] test tests::index_calculation::sub_bucket_for_zero_value_in_first_bucket_unit_magnitude_2 ... ok
Nov 18 09:54:49.366 INFO [stdout] test tests::index_calculation::unit_magnitude_4_index_calculations ... ok
Nov 18 09:54:49.383 INFO [stdout] test tests::index_calculation::unit_magnitude_52_sub_bucket_magnitude_11_index_calculations ... ok
Nov 18 09:54:49.383 INFO [stdout] test tests::index_calculation::unit_magnitude_53_sub_bucket_magnitude_11_throws ... ok
Nov 18 09:54:49.415 INFO [stdout] test tests::index_calculation::unit_magnitude_55_sub_bucket_magnitude_8_ok ... ok
Nov 18 09:54:49.415 INFO [stdout] test tests::index_calculation::unit_magnitude_62_sub_bucket_magnitude_1_ok ... ok
Nov 18 09:54:49.431 INFO [stdout] test tests::init::init_fields_10m_max_1k_min_middle_precision ... ok
Nov 18 09:54:49.451 INFO [stdout] test tests::init::init_fields_1_bucket_medium_precision ... ok
Nov 18 09:54:49.451 INFO [stdout] test tests::init::init_fields_max_value_0_precision_increased_min_value ... ok
Nov 18 09:54:49.471 INFO [stdout] test tests::init::init_fields_max_value_0_precision_most_buckets ... ok
Nov 18 09:54:49.474 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_7_byte ... ok
Nov 18 09:54:49.495 INFO [stdout] test tests::init::init_fields_max_value_max_unit_magnitude_0_precision ... ok
Nov 18 09:54:49.654 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_8_byte ... ok
Nov 18 09:54:49.671 INFO [stdout] test tests::init::init_fields_max_value_max_unit_magnitude_max_precision ... ok
Nov 18 09:54:49.671 INFO [stdout] test tests::init::init_fields_max_value_medium_precision ... ok
Nov 18 09:54:49.675 INFO [stdout] test tests::init::init_fields_smallest_possible_array ... ok
Nov 18 09:54:49.676 INFO [stdout] test tests::new_err_high_not_double_low ... ok
Nov 18 09:54:49.915 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_9_byte ... ok
Nov 18 09:54:50.031 INFO [stdout] test tests::subtract::subtract_after_add ... ok
Nov 18 09:54:50.087 INFO [stdout] test tests::subtract::subtract_to_negative_counts_error ... ok
Nov 18 09:54:50.091 INFO [stdout] test tests::subtract::subtract_subtrahend_values_outside_minuend_range_error ... ok
Nov 18 09:54:50.212 INFO [stdout] test tests::subtract::subtract_to_zero_counts ... ok
Nov 18 09:54:50.257 INFO [stdout] test serialization::tests::zig_zag_roundtrip_random ... ok
Nov 18 09:54:50.679 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u16 ... ok
Nov 18 09:54:50.695 INFO [stdout] test tests::subtract::subtract_values_at_extent_of_minuend_nonzero_count_range_recalculates_same_min_max ... ok
Nov 18 09:54:50.717 INFO [stdout] test tests::subtract::subtract_values_at_extent_of_minuend_zero_count_range_recalculates_min_max ... ok
Nov 18 09:54:51.020 INFO [stdout] test tests::subtract::subtract_values_minuend_saturated_total_recalculates_saturated ... ok
Nov 18 09:54:51.105 INFO [stdout] test tests::subtract::subtract_values_minuend_saturated_total_recalculates_not_saturated ... ok
Nov 18 09:54:51.131 INFO [stdout] test tests::init::init_fields_max_value_max_precision_increased_min_value ... ok
Nov 18 09:54:51.231 INFO [stdout] test tests::subtract::subtract_values_inside_minuend_range_works ... ok
Nov 18 09:54:51.239 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0 ... ok
Nov 18 09:54:51.247 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_max_buckets ... ok
Nov 18 09:54:51.359 INFO [stdout] test tests::subtract::subtract_values_strictly_inside_minuend_range_yields_same_min_max_no_restat ... ok
Nov 18 09:54:51.359 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_min_precision_max_buckets ... ok
Nov 18 09:54:51.359 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_2 ... ok
Nov 18 09:54:51.379 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_2_max_buckets ... ok
Nov 18 09:54:51.431 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_50_max_buckets ... ok
Nov 18 09:54:51.435 INFO [stdout] test tests::value_calculation::highest_equivalent_u64_max_value_saturates ... ok
Nov 18 09:54:51.464 INFO [stdout] test tests::value_calculation::highest_equivalent_unit_magnitude_0 ... ok
Nov 18 09:54:51.500 INFO [stdout] test tests::value_calculation::highest_equivalent_unit_magnitude_2 ... ok
Nov 18 09:54:51.508 INFO [stdout] test tests::value_calculation::lowest_equivalent_unit_magnitude_0 ... ok
Nov 18 09:54:51.516 INFO [stdout] test tests::value_calculation::lowest_equivalent_unit_magnitude_2 ... ok
Nov 18 09:54:51.531 INFO [stdout] test tests::value_calculation::next_non_equivalent_u64_max_value_saturates ... ok
Nov 18 09:54:51.536 INFO [stdout] test tests::value_calculation::next_non_equivalent_unit_magnitude_0 ... ok
Nov 18 09:54:51.540 INFO [stdout] test tests::value_calculation::next_non_equivalent_unit_magnitude_2 ... ok
Nov 18 09:54:52.555 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u64 ... ok
Nov 18 09:54:52.565 INFO [stdout] test tests::value_calculation::value_for_beyond_histogram_max_still_works ... ok
Nov 18 09:54:52.579 INFO [stdout] test tests::value_calculation::value_for_impossible_index ... ok
Nov 18 09:54:52.596 INFO [stdout] test tests::value_calculation::value_for_unit_magnitude_0 ... ok
Nov 18 09:54:52.616 INFO [stdout] test tests::value_calculation::value_for_unit_magnitude_2 ... ok
Nov 18 09:54:52.691 INFO [stdout] test tests::value_calculation::value_from_loc_unit_magnitude_0 ... ok
Nov 18 09:54:52.692 INFO [stdout] test tests::value_calculation::value_from_loc_unit_magnitude_2 ... ok
Nov 18 09:54:53.059 INFO [stdout] test tests::value_calculation::value_for_at_each_index ... ok
Nov 18 09:54:53.263 INFO [stdout] test tests::init::init_fields_max_value_max_precision_largest_possible_array ... ok
Nov 18 09:54:53.867 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_max_precision_max_buckets ... ok
Nov 18 09:55:00.416 INFO [stdout] test tests::subtract::subtract_values_at_minuend_max_recalculates_min_max ... ok
Nov 18 09:55:00.824 INFO [stdout] test tests::subtract::subtract_values_within_bucket_precision_of_of_minuend_min_recalculates_min_max ... ok
Nov 18 09:55:01.407 INFO [stdout] test tests::subtract::subtract_values_at_minuend_min_recalculates_min_max ... ok
Nov 18 09:55:01.659 INFO [stdout] test tests::subtract::subtract_values_within_bucket_precision_of_of_minuend_max_recalculates_min_max ... ok
Nov 18 09:55:01.659 INFO [stdout] 
Nov 18 09:55:01.660 INFO [stdout] test result: ok. 160 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:55:01.660 INFO [stdout] 
Nov 18 09:55:01.660 INFO [stderr]      Running /target/debug/deps/auto_resize-9377d2a99b6be440
Nov 18 09:55:01.673 INFO [stdout] 
Nov 18 09:55:01.673 INFO [stdout] running 4 tests
Nov 18 09:55:01.687 INFO [stdout] test autosizing_add ... ok
Nov 18 09:55:01.687 INFO [stdout] test histogram_autosizing ... ok
Nov 18 09:55:01.699 INFO [stdout] test histogram_autosizing_edges ... ok
Nov 18 09:55:04.155 INFO [stdout] test autosizing_across_continuous_range ... ok
Nov 18 09:55:04.155 INFO [stdout] 
Nov 18 09:55:04.155 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:55:04.155 INFO [stdout] 
Nov 18 09:55:04.156 INFO [stdout] 
Nov 18 09:55:04.156 INFO [stdout] running 26 tests
Nov 18 09:55:04.157 INFO [stderr]      Running /target/debug/deps/data_access-bda0fefb028e8404
Nov 18 09:55:04.179 INFO [stdout] test count_between_high_beyond_max ... ok
Nov 18 09:55:04.203 INFO [stdout] test count_at_beyond_max_value ... ok
Nov 18 09:55:04.283 INFO [stdout] test count_between_saturates ... ok
Nov 18 09:55:04.283 INFO [stdout] test count_between_low_and_high_beyond_max ... ok
Nov 18 09:55:04.391 INFO [stdout] test get_min_value ... ok
Nov 18 09:55:04.399 INFO [stdout] test count_at ... ok
Nov 18 09:55:04.423 INFO [stdout] test count_between ... ok
Nov 18 09:55:04.457 INFO [stdout] test get_mean ... ok
Nov 18 09:55:04.548 INFO [stdout] test get_max_value ... ok
Nov 18 09:55:04.551 INFO [stdout] test linear_iter_steps ... ok
Nov 18 09:55:04.581 INFO [stdout] test iter_log ... ok
Nov 18 09:55:04.603 INFO [stdout] test iter_recorded ... ok
Nov 18 09:55:04.627 INFO [stdout] test quantile_below_saturates ... ok
Nov 18 09:55:04.633 INFO [stdout] test get_stdev ... ok
Nov 18 09:55:04.647 INFO [stdout] test quantile_below_value_beyond_max ... ok
Nov 18 09:55:04.683 INFO [stdout] test iter_all ... ok
Nov 18 09:55:04.683 INFO [stdout] test linear_iter_raw ... ok
Nov 18 09:55:04.699 INFO [stdout] test total_count_exceeds_bucket_type ... ok
Nov 18 09:55:04.720 INFO [stdout] test quantile_atorbelow ... ok
Nov 18 09:55:04.813 INFO [stdout] test linear_iter_corrected ... ok
Nov 18 09:55:04.843 INFO [stdout] test quantiles ... ok
Nov 18 09:55:04.873 INFO [stdout] test quantile_iter ... ok
Nov 18 09:55:04.889 INFO [stdout] test total_count ... ok
Nov 18 09:55:04.920 INFO [stdout] test scaling_equivalence ... ok
Nov 18 09:55:04.932 INFO [stdout] test value_duplication ... ok
Nov 18 09:55:05.312 INFO [stdout] test large_quantile ... ok
Nov 18 09:55:05.313 INFO [stdout] 
Nov 18 09:55:05.314 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:55:05.314 INFO [stdout] 
Nov 18 09:55:05.316 INFO [stderr]      Running /target/debug/deps/histogram-a6ca0a0a92096163
Nov 18 09:55:05.320 INFO [stdout] 
Nov 18 09:55:05.320 INFO [stdout] running 37 tests
Nov 18 09:55:05.358 INFO [stdout] test construction_arg_gets ... ok
Nov 18 09:55:05.360 INFO [stdout] test equivalent_range ... ok
Nov 18 09:55:05.371 INFO [stdout] test construction_arg_ranges ... ok
Nov 18 09:55:05.376 INFO [stdout] test lowest_equivalent ... ok
Nov 18 09:55:05.378 INFO [stdout] test median_equivalent ... ok
Nov 18 09:55:05.382 INFO [stdout] test median_equivalent_doesnt_panic_at_extremes ... ok
Nov 18 09:55:05.392 INFO [stdout] test highest_equivalent ... ok
Nov 18 09:55:05.392 INFO [stdout] test empty_histogram ... ok
Nov 18 09:55:05.398 INFO [stdout] test record_in_interval ... ok
Nov 18 09:55:05.408 INFO [stdout] test record ... ok
Nov 18 09:55:05.416 INFO [stdout] test record_past_trackable_max ... ok
Nov 18 09:55:05.418 INFO [stdout] test reset ... ok
Nov 18 09:55:05.430 INFO [stdout] test saturating_record ... ok
Nov 18 09:55:05.432 INFO [stdout] test scaled_equivalent_range ... ok
Nov 18 09:55:05.446 INFO [stdout] test add ... ok
Nov 18 09:55:05.451 INFO [stdout] test scaled_highest_equivalent ... ok
Nov 18 09:55:05.455 INFO [stdout] test scaled_lowest_equivalent ... ok
Nov 18 09:55:05.456 INFO [stdout] test scaled_median_equivalent ... ok
Nov 18 09:55:05.530 INFO [stdout] test subtract_underflow_guarded_by_per_value_count_check ... ok
Nov 18 09:55:05.639 INFO [stdout] test scaled_clone ... ok
Nov 18 09:55:05.691 INFO [stdout] test clone ... ok
Nov 18 09:55:05.742 INFO [stdout] test total_count_overflow_from_add_same_dimensions_saturates_when_added_to_orig_total_count ... ok
Nov 18 09:55:05.759 INFO [stdout] test total_count_overflow_from_add_same_dimensions_saturates_calculating_other_addend_total ... ok
Nov 18 09:55:05.763 INFO [stdout] test total_count_overflow_from_add_with_resize_saturates ... ok
Nov 18 09:55:05.779 INFO [stdout] test total_count_overflow_from_record_saturates ... ok
Nov 18 09:55:05.888 INFO [stdout] test scaled_set_to ... ok
Nov 18 09:55:05.931 INFO [stdout] test set_to ... ok
Nov 18 09:55:05.932 INFO [stdout] test value_count_overflow_from_add_with_resize_to_same_dimensions_saturates ... ok
Nov 18 09:55:05.933 INFO [stdout] test value_count_overflow_from_add_same_dimensions_saturates ... ok
Nov 18 09:55:05.959 INFO [stdout] test value_count_overflow_from_record_autoresize_doesnt_panic_saturates ... ok
Nov 18 09:55:05.960 INFO [stdout] test value_count_overflow_from_record_saturates_u16 ... ok
Nov 18 09:55:05.960 INFO [stdout] test value_count_overflow_from_record_saturates_u64 ... ok
Nov 18 09:55:06.087 INFO [stdout] test total_count_overflow_from_add_different_precision_saturates ... ok
Nov 18 09:55:06.171 INFO [stdout] test value_count_overflow_from_add_different_precision_saturates ... ok
Nov 18 09:55:06.375 INFO [stdout] test random_write_full_value_range_precision_0_no_panic ... ok
Nov 18 09:55:06.643 INFO [stdout] test random_write_middle_of_value_range_precision_3_no_panic ... ok
Nov 18 09:55:07.099 INFO [stdout] test random_write_full_value_range_precision_5_no_panic ... ok
Nov 18 09:55:07.099 INFO [stdout] 
Nov 18 09:55:07.099 INFO [stdout] test result: ok. 37 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:55:07.099 INFO [stdout] 
Nov 18 09:55:07.100 INFO [stderr]      Running /target/debug/deps/interval_log-bada7d953ca34863
Nov 18 09:55:07.102 INFO [stdout] 
Nov 18 09:55:07.102 INFO [stdout] running 6 tests
Nov 18 09:55:07.107 INFO [stdout] test tests::parse_sample_tagged_interval_log_start_timestamp ... ok
Nov 18 09:55:07.123 INFO [stdout] test tests::parse_sample_tagged_interval_log_interval_count ... ok
Nov 18 09:55:07.143 INFO [stdout] test tests::parse_interval_log_syntax_error_then_returns_none ... ok
Nov 18 09:55:07.154 INFO [stdout] test tests::parse_sample_tagged_interval_log_interval_metadata ... ok
Nov 18 09:55:07.201 INFO [stdout] test tests::parse_sample_tagged_interval_log_rewrite_identical ... ok
Nov 18 09:55:10.355 INFO [stdout] test tests::write_random_histograms_to_interval_log_then_read ... ok
Nov 18 09:55:10.355 INFO [stderr]      Running /target/debug/deps/iterators-f7c8caac0d8adc96
Nov 18 09:55:10.355 INFO [stdout] 
Nov 18 09:55:10.355 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:55:10.355 INFO [stdout] 
Nov 18 09:55:10.359 INFO [stdout] 
Nov 18 09:55:10.359 INFO [stdout] running 20 tests
Nov 18 09:55:10.360 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_2_all_buckets ... ok
Nov 18 09:55:10.379 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_10_all_buckets ... ok
Nov 18 09:55:10.380 INFO [stdout] test iter_all_values_all_buckets_unit_magnitude_2 ... ok
Nov 18 09:55:10.380 INFO [stdout] test iter_linear_visits_buckets_wider_than_step_size_multiple_times ... ok
Nov 18 09:55:10.380 INFO [stdout] test iter_linear_bucket_values_size_8_all_buckets ... ok
Nov 18 09:55:10.381 INFO [stdout] test iter_linear_visits_buckets_once_when_step_size_equals_bucket_size ... ok
Nov 18 09:55:10.383 INFO [stdout] test iter_quantiles_empty ... ok
Nov 18 09:55:10.383 INFO [stdout] test iter_quantiles_iterates_to_end_skips_intermediate_at_final_value ... ok
Nov 18 09:55:10.384 INFO [stdout] test iter_logarithmic_bucket_values_min_4_base_2_all_buckets ... ok
Nov 18 09:55:10.388 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_2_all_buckets_unit_magnitude_2 ... ok
Nov 18 09:55:10.388 INFO [stdout] test iter_all_values_all_buckets ... ok
Nov 18 09:55:10.388 INFO [stdout] test iter_linear_count_since_last_iteration_saturates ... ok
Nov 18 09:55:10.388 INFO [stdout] test iter_quantiles_one_value ... ok
Nov 18 09:55:10.389 INFO [stdout] test iter_quantiles_iterates_to_quantile_10_as_it_reaches_last_bucket ... ok
Nov 18 09:55:10.389 INFO [stdout] test iter_recorded_values_all_buckets ... ok
Nov 18 09:55:10.391 INFO [stdout] test iter_recorded_values_all_buckets_unit_magnitude_2 ... ok
Nov 18 09:55:10.403 INFO [stdout] test iter_quantiles_saturated_count_before_max_value ... ok
Nov 18 09:55:10.403 INFO [stdout] test iter_quantiles_smorgasboard ... ok
Nov 18 09:55:10.404 INFO [stdout] test iter_recorded_saturated_total_count ... ok
Nov 18 09:55:10.404 INFO [stdout] test iter_recorded_non_saturated_total_count ... ok
Nov 18 09:55:10.404 INFO [stdout] 
Nov 18 09:55:10.404 INFO [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:55:10.405 INFO [stdout] 
Nov 18 09:55:10.405 INFO [stdout] 
Nov 18 09:55:10.405 INFO [stdout] running 10 tests
Nov 18 09:55:10.405 INFO [stderr]      Running /target/debug/deps/quantile-1159f95de4a101b7
Nov 18 09:55:10.411 INFO [stdout] test value_at_quantile_internal_count_exceeds_bucket_type ... ok
Nov 18 09:55:10.415 INFO [stdout] test value_at_quantile_5_values ... ok
Nov 18 09:55:10.459 INFO [stdout] test value_at_quantile_2_values ... ok
Nov 18 09:55:10.510 INFO [stdout] test value_at_quantile_20k ... ok
Nov 18 09:55:10.583 INFO [stdout] test value_at_quantile_large_numbers ... ok
Nov 18 09:55:13.185 INFO [stdout] test value_at_quantile_matches_quantile_iter_sequence_values ... ok
Nov 18 09:55:20.378 INFO [stdout] test value_at_quantile_matches_quantile_at_each_value_sequence_values ... ok
Nov 18 09:55:34.239 INFO [stdout] test value_at_quantile_matches_quantile_iter_random_values ... ok
Nov 18 09:55:40.431 INFO [stdout] test value_at_quantile_matches_random_quantile_random_values ... ok
Nov 18 09:55:56.187 INFO [stdout] test value_at_quantile_matches_quantile_at_each_value_random_values ... ok
Nov 18 09:55:56.187 INFO [stderr]      Running /target/debug/deps/serialization-8d62615f02b8f906
Nov 18 09:55:56.187 INFO [stdout] 
Nov 18 09:55:56.187 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:55:56.187 INFO [stdout] 
Nov 18 09:55:56.189 INFO [stdout] 
Nov 18 09:55:56.190 INFO [stdout] running 4 tests
Nov 18 09:55:56.219 INFO [stdout] test tests::total_count_overflow_from_deserialize_saturates ... ok
Nov 18 09:55:56.931 INFO [stdout] test tests::deserialize_no_compression_matches_java ... ok
Nov 18 09:55:56.931 INFO [stdout] test tests::deserialize_compression_matches_java ... ok
Nov 18 09:55:56.951 INFO [stdout] test tests::serialize_no_compression_matches_java_impl ... ok
Nov 18 09:55:56.951 INFO [stdout] 
Nov 18 09:55:56.951 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:55:56.951 INFO [stdout] 
Nov 18 09:55:56.956 INFO [stderr]    Doc-tests hdrhistogram
Nov 18 09:55:58.543 INFO [stdout] 
Nov 18 09:55:58.544 INFO [stdout] running 15 tests
Nov 18 09:56:09.151 INFO [stdout] test src/lib.rs -  (line 97) ... ok
Nov 18 09:56:09.521 INFO [stdout] test src/lib.rs - Histogram<T>::iter_log (line 1093) ... ok
Nov 18 09:56:09.951 INFO [stdout] test src/lib.rs -  (line 71) ... ok
Nov 18 09:56:10.323 INFO [stdout] test src/lib.rs - Histogram<T>::iter_quantiles (line 977) ... ok
Nov 18 09:56:10.783 INFO [stdout] test src/lib.rs -  (line 110) ... ok
Nov 18 09:56:10.859 INFO [stdout] test src/lib.rs - Histogram<T>::iter_linear (line 1035) ... ok
Nov 18 09:56:11.208 INFO [stdout] test src/lib.rs - Histogram<T>::iter_all (line 1170) ... ok
Nov 18 09:56:11.383 INFO [stdout] test src/lib.rs - Histogram<T>::iter_recorded (line 1131) ... ok
Nov 18 09:56:15.502 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 122) ... ok
Nov 18 09:56:15.525 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 145) ... ok
Nov 18 09:56:15.616 INFO [stdout] test src/serialization/mod.rs - serialization (line 134) ... ok
Nov 18 09:56:16.311 INFO [stdout] test src/serialization/mod.rs - serialization (line 75) ... ok
Nov 18 09:56:16.503 INFO [stdout] test src/serialization/mod.rs - serialization (line 119) ... ok
Nov 18 09:56:16.593 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 175) ... ok
Nov 18 09:56:16.757 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log::IntervalLogWriter (line 339) ... ok
Nov 18 09:56:16.757 INFO [stdout] 
Nov 18 09:56:16.757 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:56:16.757 INFO [stdout] 
Nov 18 09:56:16.785 INFO [stderr] su: No module specific data is present
Nov 18 09:56:17.114 INFO running `"docker" "inspect" "ddab6a8a2e0d55b71b09bd47c32c7fca53bd97715dcaba275e8c5acda760a08c"`
Nov 18 09:56:17.208 INFO running `"docker" "rm" "-f" "ddab6a8a2e0d55b71b09bd47c32c7fca53bd97715dcaba275e8c5acda760a08c"`
Nov 18 09:56:17.298 INFO [stdout] ddab6a8a2e0d55b71b09bd47c32c7fca53bd97715dcaba275e8c5acda760a08c