Nov 18 09:50:10.736 INFO testing hdrsample-6.0.3 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 09:50:10.736 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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:10.914 INFO [stdout] d2a79b9085a6ceb3b8a3e8c187b7c769a3023885072da1cb871ddb1fdbaad661
Nov 18 09:50:10.916 INFO running `"docker" "start" "-a" "d2a79b9085a6ceb3b8a3e8c187b7c769a3023885072da1cb871ddb1fdbaad661"`
Nov 18 09:50:11.394 INFO [stderr] usermod: no changes
Nov 18 09:50:11.472 INFO [stderr]    Compiling hdrsample v6.0.3 (/source)
Nov 18 09:50:13.521 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.10s
Nov 18 09:50:13.526 INFO [stderr] su: No module specific data is present
Nov 18 09:50:13.892 INFO running `"docker" "inspect" "d2a79b9085a6ceb3b8a3e8c187b7c769a3023885072da1cb871ddb1fdbaad661"`
Nov 18 09:50:14.086 INFO running `"docker" "rm" "-f" "d2a79b9085a6ceb3b8a3e8c187b7c769a3023885072da1cb871ddb1fdbaad661"`
Nov 18 09:50:14.191 INFO [stdout] d2a79b9085a6ceb3b8a3e8c187b7c769a3023885072da1cb871ddb1fdbaad661
Nov 18 09:50:14.197 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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.529 INFO [stdout] cfdacf158027d291f930e9d39f4dbe1d0753d37c6a9e04801ce8dc00a535c2fc
Nov 18 09:50:14.532 INFO running `"docker" "start" "-a" "cfdacf158027d291f930e9d39f4dbe1d0753d37c6a9e04801ce8dc00a535c2fc"`
Nov 18 09:50:14.985 INFO [stderr] usermod: no changes
Nov 18 09:50:15.072 INFO [stderr]    Compiling gmp-mpfr-sys v1.1.9
Nov 18 09:50:15.072 INFO [stderr]    Compiling rug v0.9.3
Nov 18 09:53:52.913 INFO [stderr]    Compiling hdrsample v6.0.3 (/source)
Nov 18 09:54:08.637 INFO [stderr] warning: unnecessary parentheses around method argument
Nov 18 09:54:08.638 INFO [stderr]   --> src/tests/value_calculation.rs:28:43
Nov 18 09:54:08.638 INFO [stderr]    |
Nov 18 09:54:08.638 INFO [stderr] 28 |     assert_eq!(1 << 7, h.equivalent_range((1 << 17)));
Nov 18 09:54:08.638 INFO [stderr]    |                                           ^^^^^^^^^ help: remove these parentheses
Nov 18 09:54:08.639 INFO [stderr]    |
Nov 18 09:54:08.639 INFO [stderr]    = note: #[warn(unused_parens)] on by default
Nov 18 09:54:08.639 INFO [stderr] 
Nov 18 09:54:08.640 INFO [stderr] warning: unnecessary parentheses around method argument
Nov 18 09:54:08.640 INFO [stderr]   --> src/tests/value_calculation.rs:56:43
Nov 18 09:54:08.651 INFO [stderr]    |
Nov 18 09:54:08.651 INFO [stderr] 56 |     assert_eq!(1 << 7, h.equivalent_range((1 << 17)));
Nov 18 09:54:08.651 INFO [stderr]    |                                           ^^^^^^^^^ help: remove these parentheses
Nov 18 09:54:08.652 INFO [stderr] 
Nov 18 09:54:15.871 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4m 00s
Nov 18 09:54:15.883 INFO [stderr] su: No module specific data is present
Nov 18 09:54:16.240 INFO running `"docker" "inspect" "cfdacf158027d291f930e9d39f4dbe1d0753d37c6a9e04801ce8dc00a535c2fc"`
Nov 18 09:54:16.340 INFO running `"docker" "rm" "-f" "cfdacf158027d291f930e9d39f4dbe1d0753d37c6a9e04801ce8dc00a535c2fc"`
Nov 18 09:54:16.458 INFO [stdout] cfdacf158027d291f930e9d39f4dbe1d0753d37c6a9e04801ce8dc00a535c2fc
Nov 18 09:54:16.460 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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:16.655 INFO [stdout] b777d57e2c37d526b2cc3042b6a25466fb52408a36422791bbe3d14fd6fa6422
Nov 18 09:54:16.657 INFO running `"docker" "start" "-a" "b777d57e2c37d526b2cc3042b6a25466fb52408a36422791bbe3d14fd6fa6422"`
Nov 18 09:54:17.367 INFO [stderr] usermod: no changes
Nov 18 09:54:17.507 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Nov 18 09:54:17.513 INFO [stderr]      Running /target/debug/deps/hdrsample-e752678167449a0c
Nov 18 09:54:17.527 INFO [stdout] 
Nov 18 09:54:17.528 INFO [stdout] running 160 tests
Nov 18 09:54:17.539 INFO [stdout] test serialization::interval_log::tests::parse_duration_full_ns ... ok
Nov 18 09:54:17.539 INFO [stdout] test serialization::interval_log::tests::parse_comment ... ok
Nov 18 09:54:17.540 INFO [stdout] test serialization::interval_log::tests::parse_base_time ... ok
Nov 18 09:54:17.540 INFO [stdout] test serialization::interval_log::tests::iter_multiple_entrties_with_interleaved_ignored ... ok
Nov 18 09:54:17.540 INFO [stdout] test serialization::interval_log::tests::parse_duration_too_many_ns ... ok
Nov 18 09:54:17.541 INFO [stdout] test serialization::interval_log::tests::iter_all_ignored_empty_iter ... ok
Nov 18 09:54:17.541 INFO [stdout] test serialization::interval_log::tests::parse_interval_hist_no_tag ... ok
Nov 18 09:54:17.541 INFO [stdout] test serialization::interval_log::tests::parse_interval_hist_with_tag ... ok
Nov 18 09:54:17.547 INFO [stdout] test serialization::interval_log::tests::parse_legend ... ok
Nov 18 09:54:17.547 INFO [stdout] test serialization::interval_log::tests::parse_start_time_with_human_date ... ok
Nov 18 09:54:17.548 INFO [stdout] test serialization::interval_log::tests::parse_start_time_without_human_date ... ok
Nov 18 09:54:17.548 INFO [stdout] test serialization::interval_log::tests::write_base_time ... ok
Nov 18 09:54:17.548 INFO [stdout] test serialization::interval_log::tests::parse_duration_scale_ns ... ok
Nov 18 09:54:17.548 INFO [stdout] test serialization::interval_log::tests::iter_with_ignored_prefix ... ok
Nov 18 09:54:17.549 INFO [stdout] test serialization::interval_log::tests::write_comment_control_characters_still_parseable ... ok
Nov 18 09:54:17.549 INFO [stdout] test serialization::interval_log::tests::iter_without_ignored_prefix ... ok
Nov 18 09:54:17.549 INFO [stdout] test serialization::interval_log::tests::write_comment_newline_wraps ... ok
Nov 18 09:54:17.549 INFO [stdout] test serialization::interval_log::tests::write_header_comment ... ok
Nov 18 09:54:17.551 INFO [stdout] test serialization::interval_log::tests::write_header_then_interval_comment ... ok
Nov 18 09:54:17.555 INFO [stdout] test serialization::interval_log::tests::write_start_time ... ok
Nov 18 09:54:17.555 INFO [stdout] test serialization::tests::encode_counts_first_and_last_count_incremented ... ok
Nov 18 09:54:17.555 INFO [stdout] test serialization::tests::encode_counts_count_too_big ... ok
Nov 18 09:54:17.555 INFO [stdout] test serialization::tests::encode_counts_all_zeros ... ok
Nov 18 09:54:17.559 INFO [stdout] test serialization::tests::encode_counts_first_count_incremented ... ok
Nov 18 09:54:17.587 INFO [stdout] test serialization::tests::serialize_roundtrip_1_count_for_every_value_1_bucket ... ok
Nov 18 09:54:17.587 INFO [stdout] test serialization::tests::rand_varint::largest_number_in_7_bit_chunk_correct ... ok
Nov 18 09:54:17.587 INFO [stdout] test serialization::tests::serialize_all_zeros ... ok
Nov 18 09:54:17.587 INFO [stdout] test serialization::interval_log::tests::write_interval_histo_with_tag ... ok
Nov 18 09:54:17.587 INFO [stdout] test serialization::tests::encode_counts_last_count_incremented ... ok
Nov 18 09:54:17.587 INFO [stdout] test serialization::interval_log::tests::write_headers_multiple_times_only_last_is_used ... ok
Nov 18 09:54:17.587 INFO [stdout] test serialization::interval_log::tests::write_interval_histo_no_tag ... ok
Nov 18 09:54:17.603 INFO [stdout] test serialization::tests::serialize_roundtrip_1_count_for_every_value_2_buckets ... ok
Nov 18 09:54:17.619 INFO [stdout] test serialization::tests::serialize_roundtrip_all_zeros ... ok
Nov 18 09:54:18.297 INFO [stdout] test serialization::interval_log::tests::duration_fp_roundtrip_accuracy ... ok
Nov 18 09:54:31.183 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u8 ... ok
Nov 18 09:54:31.183 INFO [stdout] test serialization::tests::varint_read_u64_max ... ok
Nov 18 09:54:31.183 INFO [stdout] test serialization::tests::varint_read_u64_zero ... ok
Nov 18 09:54:31.183 INFO [stdout] test serialization::tests::varint_write_3_bit_value ... ok
Nov 18 09:54:31.183 INFO [stdout] test serialization::tests::varint_write_7_bit_value ... ok
Nov 18 09:54:31.199 INFO [stdout] test serialization::tests::varint_write_9_bit_value ... ok
Nov 18 09:54:32.191 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_1_byte ... ok
Nov 18 09:54:32.419 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u64 ... ok
Nov 18 09:54:32.919 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_3_byte ... ok
Nov 18 09:54:33.439 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_2_byte ... ok
Nov 18 09:54:34.083 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u32 ... ok
Nov 18 09:54:34.307 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_4_byte ... ok
Nov 18 09:54:34.819 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_5_byte ... ok
Nov 18 09:54:35.471 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_6_byte ... ok
Nov 18 09:54:35.495 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u8 ... ok
Nov 18 09:54:35.813 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u64 ... ok
Nov 18 09:54:36.003 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_7_byte ... ok
Nov 18 09:54:36.329 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_8_byte ... ok
Nov 18 09:54:36.403 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_1_byte ... ok
Nov 18 09:54:36.639 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u16 ... ok
Nov 18 09:54:36.707 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_2_byte ... ok
Nov 18 09:54:36.771 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_9_byte ... ok
Nov 18 09:54:36.911 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_3_byte ... ok
Nov 18 09:54:37.051 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_4_byte ... ok
Nov 18 09:54:37.079 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_5_byte ... ok
Nov 18 09:54:37.099 INFO [stdout] test serialization::tests::zig_zag_decode_0 ... ok
Nov 18 09:54:37.116 INFO [stdout] test serialization::tests::zig_zag_decode_1 ... ok
Nov 18 09:54:37.116 INFO [stdout] test serialization::tests::varint_write_u64_max ... ok
Nov 18 09:54:37.117 INFO [stdout] test serialization::tests::zig_zag_decode_u64_max_penultimate_to_i64_max ... ok
Nov 18 09:54:37.118 INFO [stdout] test serialization::tests::zig_zag_decode_2 ... ok
Nov 18 09:54:37.119 INFO [stdout] test serialization::tests::zig_zag_encode_0 ... ok
Nov 18 09:54:37.135 INFO [stdout] test serialization::tests::zig_zag_decode_u64_max_to_i64_min ... ok
Nov 18 09:54:37.136 INFO [stdout] test serialization::tests::zig_zag_encode_1 ... ok
Nov 18 09:54:37.137 INFO [stdout] test serialization::tests::zig_zag_encode_i64_min ... ok
Nov 18 09:54:37.159 INFO [stdout] test serialization::tests::zig_zag_encode_i64_max ... ok
Nov 18 09:54:37.160 INFO [stdout] test serialization::tests::zig_zag_encode_neg_1 ... ok
Nov 18 09:54:37.179 INFO [stdout] test tests::correct_original_min ... ok
Nov 18 09:54:37.199 INFO [stdout] test tests::index_calculation::bucket_for_biggest_value_in_first_bucket ... ok
Nov 18 09:54:37.207 INFO [stdout] test tests::index_calculation::bucket_for_biggest_value_in_second_bucket ... ok
Nov 18 09:54:37.255 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_first_bucket ... ok
Nov 18 09:54:37.288 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_last_bucket ... ok
Nov 18 09:54:37.295 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_second_bucket ... ok
Nov 18 09:54:37.319 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_third_bucket ... ok
Nov 18 09:54:37.363 INFO [stdout] test tests::index_calculation::bucket_for_value_above_biggest_isnt_clamped_at_max_bucket ... ok
Nov 18 09:54:37.364 INFO [stdout] test tests::index_calculation::bucket_for_value_below_smallest_clamps_to_zero ... ok
Nov 18 09:54:37.364 INFO [stdout] test tests::index_calculation::index_for_below_smallest ... ok
Nov 18 09:54:37.364 INFO [stdout] test tests::index_calculation::index_for_first_bucket_first_distinguishable_entry ... ok
Nov 18 09:54:37.365 INFO [stdout] test tests::index_calculation::index_for_first_bucket_first_entry ... ok
Nov 18 09:54:37.365 INFO [stdout] test tests::index_calculation::index_for_first_bucket_last_entry ... ok
Nov 18 09:54:37.365 INFO [stdout] test tests::index_calculation::index_for_second_bucket_first_entry ... ok
Nov 18 09:54:37.365 INFO [stdout] test tests::index_calculation::index_for_second_bucket_last_entry ... ok
Nov 18 09:54:37.365 INFO [stdout] test tests::index_calculation::index_for_second_bucket_last_entry_indistinguishable ... ok
Nov 18 09:54:37.366 INFO [stdout] test tests::index_calculation::index_for_way_past_largest_value_exceeds_length ... ok
Nov 18 09:54:37.366 INFO [stdout] test tests::index_calculation::sub_bucket_for_biggest_value_in_second_bucket ... ok
Nov 18 09:54:37.366 INFO [stdout] test tests::index_calculation::sub_bucket_for_largest_value_in_first_bucket ... ok
Nov 18 09:54:37.370 INFO [stdout] test tests::index_calculation::sub_bucket_for_largest_value_in_first_bucket_unit_magnitude_2 ... ok
Nov 18 09:54:37.370 INFO [stdout] test tests::index_calculation::sub_bucket_for_smaller_than_distinguishable_value_in_first_bucket_unit_magnitude_2 ... ok
Nov 18 09:54:37.370 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_distinguishable_value_in_first_bucket ... ok
Nov 18 09:54:37.370 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_distinguishable_value_in_first_bucket_unit_magnitude_2 ... ok
Nov 18 09:54:37.370 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_second_bucket ... ok
Nov 18 09:54:37.371 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_second_bucket_unit_magnitude_2 ... ok
Nov 18 09:54:37.371 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_third_bucket ... ok
Nov 18 09:54:37.371 INFO [stdout] test tests::index_calculation::sub_bucket_for_value_above_biggest_still_works ... ok
Nov 18 09:54:37.371 INFO [stdout] test tests::index_calculation::sub_bucket_for_value_below_smallest_clamps_to_zero ... ok
Nov 18 09:54:37.371 INFO [stdout] test tests::index_calculation::sub_bucket_for_zero_value_in_first_bucket ... ok
Nov 18 09:54:37.371 INFO [stdout] test tests::index_calculation::sub_bucket_for_zero_value_in_first_bucket_unit_magnitude_2 ... ok
Nov 18 09:54:37.373 INFO [stdout] test tests::index_calculation::unit_magnitude_0_index_calculations ... ok
Nov 18 09:54:37.383 INFO [stdout] test tests::index_calculation::unit_magnitude_4_index_calculations ... ok
Nov 18 09:54:37.384 INFO [stdout] test tests::index_calculation::unit_magnitude_52_sub_bucket_magnitude_11_index_calculations ... ok
Nov 18 09:54:37.384 INFO [stdout] test tests::index_calculation::unit_magnitude_53_sub_bucket_magnitude_11_throws ... ok
Nov 18 09:54:37.384 INFO [stdout] test tests::index_calculation::unit_magnitude_55_sub_bucket_magnitude_8_ok ... ok
Nov 18 09:54:37.386 INFO [stdout] test tests::index_calculation::unit_magnitude_62_sub_bucket_magnitude_1_ok ... ok
Nov 18 09:54:37.386 INFO [stdout] test tests::init::init_fields_10m_max_1k_min_middle_precision ... ok
Nov 18 09:54:37.387 INFO [stdout] test tests::init::init_fields_1_bucket_medium_precision ... ok
Nov 18 09:54:37.387 INFO [stdout] test tests::init::init_fields_max_value_0_precision_increased_min_value ... ok
Nov 18 09:54:37.387 INFO [stdout] test tests::init::init_fields_max_value_0_precision_most_buckets ... ok
Nov 18 09:54:37.440 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_9_byte ... ok
Nov 18 09:54:37.515 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u16 ... ok
Nov 18 09:54:37.518 INFO [stdout] test tests::init::init_fields_max_value_max_unit_magnitude_0_precision ... ok
Nov 18 09:54:37.651 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_7_byte ... ok
Nov 18 09:54:37.663 INFO [stdout] test tests::init::init_fields_max_value_medium_precision ... ok
Nov 18 09:54:37.687 INFO [stdout] test tests::init::init_fields_smallest_possible_array ... ok
Nov 18 09:54:37.687 INFO [stdout] test tests::new_err_high_not_double_low ... ok
Nov 18 09:54:37.699 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_6_byte ... ok
Nov 18 09:54:37.799 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u32 ... ok
Nov 18 09:54:37.799 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_8_byte ... ok
Nov 18 09:54:37.855 INFO [stdout] test tests::subtract::subtract_after_add ... ok
Nov 18 09:54:37.884 INFO [stdout] test tests::init::init_fields_max_value_max_unit_magnitude_max_precision ... ok
Nov 18 09:54:37.927 INFO [stdout] test tests::subtract::subtract_subtrahend_values_outside_minuend_range_error ... ok
Nov 18 09:54:38.111 INFO [stdout] test tests::subtract::subtract_to_negative_counts_error ... ok
Nov 18 09:54:38.119 INFO [stdout] test tests::subtract::subtract_values_at_extent_of_minuend_zero_count_range_recalculates_min_max ... ok
Nov 18 09:54:38.171 INFO [stdout] test tests::subtract::subtract_to_zero_counts ... ok
Nov 18 09:54:38.299 INFO [stdout] test tests::subtract::subtract_values_at_extent_of_minuend_nonzero_count_range_recalculates_same_min_max ... ok
Nov 18 09:54:38.345 INFO [stdout] test serialization::tests::zig_zag_roundtrip_random ... ok
Nov 18 09:54:38.611 INFO [stdout] test tests::subtract::subtract_values_inside_minuend_range_works ... ok
Nov 18 09:54:38.612 INFO [stdout] test tests::subtract::subtract_values_minuend_saturated_total_recalculates_not_saturated ... ok
Nov 18 09:54:38.704 INFO [stdout] test tests::subtract::subtract_values_strictly_inside_minuend_range_yields_same_min_max_no_restat ... ok
Nov 18 09:54:38.716 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0 ... ok
Nov 18 09:54:38.771 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_max_buckets ... ok
Nov 18 09:54:38.803 INFO [stdout] test tests::subtract::subtract_values_minuend_saturated_total_recalculates_saturated ... ok
Nov 18 09:54:38.843 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_min_precision_max_buckets ... ok
Nov 18 09:54:38.873 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_2 ... ok
Nov 18 09:54:38.884 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_2_max_buckets ... ok
Nov 18 09:54:38.885 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_50_max_buckets ... ok
Nov 18 09:54:38.906 INFO [stdout] test tests::value_calculation::highest_equivalent_u64_max_value_saturates ... ok
Nov 18 09:54:38.907 INFO [stdout] test tests::value_calculation::highest_equivalent_unit_magnitude_0 ... ok
Nov 18 09:54:38.907 INFO [stdout] test tests::value_calculation::highest_equivalent_unit_magnitude_2 ... ok
Nov 18 09:54:38.943 INFO [stdout] test tests::value_calculation::lowest_equivalent_unit_magnitude_0 ... ok
Nov 18 09:54:38.956 INFO [stdout] test tests::value_calculation::lowest_equivalent_unit_magnitude_2 ... ok
Nov 18 09:54:38.975 INFO [stdout] test tests::value_calculation::next_non_equivalent_u64_max_value_saturates ... ok
Nov 18 09:54:38.979 INFO [stdout] test tests::value_calculation::next_non_equivalent_unit_magnitude_0 ... ok
Nov 18 09:54:39.003 INFO [stdout] test tests::value_calculation::next_non_equivalent_unit_magnitude_2 ... ok
Nov 18 09:54:39.381 INFO [stdout] test tests::init::init_fields_max_value_max_precision_increased_min_value ... ok
Nov 18 09:54:39.384 INFO [stdout] test tests::value_calculation::value_for_beyond_histogram_max_still_works ... ok
Nov 18 09:54:39.475 INFO [stdout] test tests::value_calculation::value_for_impossible_index ... ok
Nov 18 09:54:39.479 INFO [stdout] test tests::value_calculation::value_for_unit_magnitude_0 ... ok
Nov 18 09:54:39.487 INFO [stdout] test tests::value_calculation::value_for_unit_magnitude_2 ... ok
Nov 18 09:54:39.519 INFO [stdout] test tests::value_calculation::value_from_loc_unit_magnitude_0 ... ok
Nov 18 09:54:39.519 INFO [stdout] test tests::value_calculation::value_from_loc_unit_magnitude_2 ... ok
Nov 18 09:54:40.852 INFO [stdout] test tests::value_calculation::value_for_at_each_index ... ok
Nov 18 09:54:40.909 INFO [stdout] test tests::init::init_fields_max_value_max_precision_largest_possible_array ... ok
Nov 18 09:54:41.428 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_max_precision_max_buckets ... ok
Nov 18 09:54:50.135 INFO [stdout] test tests::subtract::subtract_values_within_bucket_precision_of_of_minuend_min_recalculates_min_max ... ok
Nov 18 09:54:50.555 INFO [stdout] test tests::subtract::subtract_values_within_bucket_precision_of_of_minuend_max_recalculates_min_max ... ok
Nov 18 09:54:51.084 INFO [stdout] test tests::subtract::subtract_values_at_minuend_max_recalculates_min_max ... ok
Nov 18 09:54:51.143 INFO [stdout] test tests::subtract::subtract_values_at_minuend_min_recalculates_min_max ... ok
Nov 18 09:54:51.143 INFO [stdout] 
Nov 18 09:54:51.143 INFO [stdout] test result: ok. 160 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:54:51.143 INFO [stdout] 
Nov 18 09:54:51.151 INFO [stdout] 
Nov 18 09:54:51.151 INFO [stderr]      Running /target/debug/deps/auto_resize-94d92b3a1086d50f
Nov 18 09:54:51.151 INFO [stdout] running 4 tests
Nov 18 09:54:51.183 INFO [stdout] test autosizing_add ... ok
Nov 18 09:54:51.183 INFO [stdout] test histogram_autosizing_edges ... ok
Nov 18 09:54:51.195 INFO [stdout] test histogram_autosizing ... ok
Nov 18 09:54:53.903 INFO [stdout] test autosizing_across_continuous_range ... ok
Nov 18 09:54:53.903 INFO [stdout] 
Nov 18 09:54:53.903 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:54:53.903 INFO [stdout] 
Nov 18 09:54:53.911 INFO [stderr]      Running /target/debug/deps/data_access-556e47de7d1fa954
Nov 18 09:54:53.912 INFO [stdout] 
Nov 18 09:54:53.912 INFO [stdout] running 26 tests
Nov 18 09:54:53.935 INFO [stdout] test count_between_saturates ... ok
Nov 18 09:54:53.936 INFO [stdout] test count_between_low_and_high_beyond_max ... ok
Nov 18 09:54:53.971 INFO [stdout] test count_between_high_beyond_max ... ok
Nov 18 09:54:53.971 INFO [stdout] test count_at_beyond_max_value ... ok
Nov 18 09:54:54.099 INFO [stdout] test count_between ... ok
Nov 18 09:54:54.123 INFO [stdout] test get_stdev ... ok
Nov 18 09:54:54.168 INFO [stdout] test get_min_value ... ok
Nov 18 09:54:54.173 INFO [stdout] test get_max_value ... ok
Nov 18 09:54:54.187 INFO [stdout] test count_at ... ok
Nov 18 09:54:54.199 INFO [stdout] test get_mean ... ok
Nov 18 09:54:54.207 INFO [stdout] test iter_log ... ok
Nov 18 09:54:54.207 INFO [stdout] test linear_iter_steps ... ok
Nov 18 09:54:54.221 INFO [stdout] test quantile_below_value_beyond_max ... ok
Nov 18 09:54:54.226 INFO [stdout] test quantile_below_saturates ... ok
Nov 18 09:54:54.271 INFO [stdout] test quantile_atorbelow ... ok
Nov 18 09:54:54.271 INFO [stdout] test iter_recorded ... ok
Nov 18 09:54:54.287 INFO [stdout] test iter_all ... ok
Nov 18 09:54:54.295 INFO [stdout] test total_count_exceeds_bucket_type ... ok
Nov 18 09:54:54.347 INFO [stdout] test total_count ... ok
Nov 18 09:54:54.367 INFO [stdout] test linear_iter_raw ... ok
Nov 18 09:54:54.375 INFO [stdout] test quantiles ... ok
Nov 18 09:54:54.378 INFO [stdout] test linear_iter_corrected ... ok
Nov 18 09:54:54.499 INFO [stdout] test scaling_equivalence ... ok
Nov 18 09:54:54.523 INFO [stdout] test value_duplication ... ok
Nov 18 09:54:54.608 INFO [stdout] test quantile_iter ... ok
Nov 18 09:54:55.135 INFO [stdout] test large_quantile ... ok
Nov 18 09:54:55.136 INFO [stdout] 
Nov 18 09:54:55.136 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:54:55.136 INFO [stdout] 
Nov 18 09:54:55.137 INFO [stderr]      Running /target/debug/deps/histogram-fd6cc72ef6d553e5
Nov 18 09:54:55.140 INFO [stdout] 
Nov 18 09:54:55.140 INFO [stdout] running 37 tests
Nov 18 09:54:55.171 INFO [stdout] test construction_arg_ranges ... ok
Nov 18 09:54:55.172 INFO [stdout] test empty_histogram ... ok
Nov 18 09:54:55.175 INFO [stdout] test median_equivalent ... ok
Nov 18 09:54:55.177 INFO [stdout] test equivalent_range ... ok
Nov 18 09:54:55.189 INFO [stdout] test construction_arg_gets ... ok
Nov 18 09:54:55.196 INFO [stdout] test highest_equivalent ... ok
Nov 18 09:54:55.220 INFO [stdout] test lowest_equivalent ... ok
Nov 18 09:54:55.227 INFO [stdout] test median_equivalent_doesnt_panic_at_extremes ... ok
Nov 18 09:54:55.267 INFO [stdout] test add ... ok
Nov 18 09:54:55.273 INFO [stdout] test reset ... ok
Nov 18 09:54:55.299 INFO [stdout] test record ... ok
Nov 18 09:54:55.306 INFO [stdout] test saturating_record ... ok
Nov 18 09:54:55.308 INFO [stdout] test scaled_equivalent_range ... ok
Nov 18 09:54:55.315 INFO [stdout] test record_in_interval ... ok
Nov 18 09:54:55.323 INFO [stdout] test record_past_trackable_max ... ok
Nov 18 09:54:55.328 INFO [stdout] test scaled_median_equivalent ... ok
Nov 18 09:54:55.334 INFO [stdout] test scaled_highest_equivalent ... ok
Nov 18 09:54:55.364 INFO [stdout] test scaled_lowest_equivalent ... ok
Nov 18 09:54:55.390 INFO [stdout] test subtract_underflow_guarded_by_per_value_count_check ... ok
Nov 18 09:54:55.419 INFO [stdout] test clone ... ok
Nov 18 09:54:55.519 INFO [stdout] test total_count_overflow_from_add_same_dimensions_saturates_calculating_other_addend_total ... ok
Nov 18 09:54:55.572 INFO [stdout] test scaled_clone ... ok
Nov 18 09:54:55.573 INFO [stdout] test total_count_overflow_from_add_same_dimensions_saturates_when_added_to_orig_total_count ... ok
Nov 18 09:54:55.583 INFO [stdout] test total_count_overflow_from_record_saturates ... ok
Nov 18 09:54:55.595 INFO [stdout] test total_count_overflow_from_add_with_resize_saturates ... ok
Nov 18 09:54:55.623 INFO [stdout] test scaled_set_to ... ok
Nov 18 09:54:55.635 INFO [stdout] test value_count_overflow_from_add_same_dimensions_saturates ... ok
Nov 18 09:54:55.659 INFO [stdout] test value_count_overflow_from_add_with_resize_to_same_dimensions_saturates ... ok
Nov 18 09:54:55.679 INFO [stdout] test value_count_overflow_from_record_autoresize_doesnt_panic_saturates ... ok
Nov 18 09:54:55.679 INFO [stdout] test value_count_overflow_from_record_saturates_u16 ... ok
Nov 18 09:54:55.706 INFO [stdout] test value_count_overflow_from_record_saturates_u64 ... ok
Nov 18 09:54:55.751 INFO [stdout] test total_count_overflow_from_add_different_precision_saturates ... ok
Nov 18 09:54:55.831 INFO [stdout] test set_to ... ok
Nov 18 09:54:55.915 INFO [stdout] test value_count_overflow_from_add_different_precision_saturates ... ok
Nov 18 09:54:56.415 INFO [stdout] test random_write_full_value_range_precision_0_no_panic ... ok
Nov 18 09:54:56.514 INFO [stdout] test random_write_middle_of_value_range_precision_3_no_panic ... ok
Nov 18 09:54:57.007 INFO [stdout] test random_write_full_value_range_precision_5_no_panic ... ok
Nov 18 09:54:57.007 INFO [stdout] 
Nov 18 09:54:57.007 INFO [stdout] test result: ok. 37 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:54:57.007 INFO [stdout] 
Nov 18 09:54:57.008 INFO [stderr]      Running /target/debug/deps/interval_log-7d5e8e93f48b5a59
Nov 18 09:54:57.025 INFO [stdout] 
Nov 18 09:54:57.025 INFO [stdout] running 6 tests
Nov 18 09:54:57.027 INFO [stdout] test tests::parse_sample_tagged_interval_log_start_timestamp ... ok
Nov 18 09:54:57.059 INFO [stdout] test tests::parse_interval_log_syntax_error_then_returns_none ... ok
Nov 18 09:54:57.075 INFO [stdout] test tests::parse_sample_tagged_interval_log_interval_count ... ok
Nov 18 09:54:57.096 INFO [stdout] test tests::parse_sample_tagged_interval_log_interval_metadata ... ok
Nov 18 09:54:57.129 INFO [stdout] test tests::parse_sample_tagged_interval_log_rewrite_identical ... ok
Nov 18 09:55:00.531 INFO [stdout] test tests::write_random_histograms_to_interval_log_then_read ... ok
Nov 18 09:55:00.531 INFO [stdout] 
Nov 18 09:55:00.531 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:55:00.531 INFO [stdout] 
Nov 18 09:55:00.532 INFO [stderr]      Running /target/debug/deps/iterators-0d8f38f7b3a2d49e
Nov 18 09:55:00.539 INFO [stdout] 
Nov 18 09:55:00.539 INFO [stdout] running 20 tests
Nov 18 09:55:00.543 INFO [stdout] test iter_all_values_all_buckets ... ok
Nov 18 09:55:00.547 INFO [stdout] test iter_all_values_all_buckets_unit_magnitude_2 ... ok
Nov 18 09:55:00.548 INFO [stdout] test iter_linear_bucket_values_size_8_all_buckets ... ok
Nov 18 09:55:00.563 INFO [stdout] test iter_logarithmic_bucket_values_min_4_base_2_all_buckets ... ok
Nov 18 09:55:00.567 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_2_all_buckets ... ok
Nov 18 09:55:00.567 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_10_all_buckets ... ok
Nov 18 09:55:00.595 INFO [stdout] test iter_quantiles_empty ... ok
Nov 18 09:55:00.595 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_2_all_buckets_unit_magnitude_2 ... ok
Nov 18 09:55:00.595 INFO [stdout] test iter_linear_count_since_last_iteration_saturates ... ok
Nov 18 09:55:00.603 INFO [stdout] test iter_linear_visits_buckets_wider_than_step_size_multiple_times ... ok
Nov 18 09:55:00.603 INFO [stdout] test iter_quantiles_one_value ... ok
Nov 18 09:55:00.603 INFO [stdout] test iter_quantiles_smorgasboard ... ok
Nov 18 09:55:00.615 INFO [stdout] test iter_quantiles_iterates_to_end_skips_intermediate_at_final_value ... ok
Nov 18 09:55:00.615 INFO [stdout] test iter_quantiles_iterates_to_quantile_10_as_it_reaches_last_bucket ... ok
Nov 18 09:55:00.615 INFO [stdout] test iter_quantiles_saturated_count_before_max_value ... ok
Nov 18 09:55:00.623 INFO [stdout] test iter_recorded_values_all_buckets ... ok
Nov 18 09:55:00.623 INFO [stdout] test iter_linear_visits_buckets_once_when_step_size_equals_bucket_size ... ok
Nov 18 09:55:00.623 INFO [stdout] test iter_recorded_values_all_buckets_unit_magnitude_2 ... ok
Nov 18 09:55:00.635 INFO [stdout] test iter_recorded_non_saturated_total_count ... ok
Nov 18 09:55:00.635 INFO [stdout] test iter_recorded_saturated_total_count ... ok
Nov 18 09:55:00.636 INFO [stdout] 
Nov 18 09:55:00.636 INFO [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:55:00.636 INFO [stdout] 
Nov 18 09:55:00.647 INFO [stdout] 
Nov 18 09:55:00.647 INFO [stderr]      Running /target/debug/deps/quantile-ee7ef86c314c7a3e
Nov 18 09:55:00.648 INFO [stdout] running 10 tests
Nov 18 09:55:00.655 INFO [stdout] test value_at_quantile_internal_count_exceeds_bucket_type ... ok
Nov 18 09:55:00.697 INFO [stdout] test value_at_quantile_5_values ... ok
Nov 18 09:55:00.727 INFO [stdout] test value_at_quantile_2_values ... ok
Nov 18 09:55:00.739 INFO [stdout] test value_at_quantile_20k ... ok
Nov 18 09:55:00.803 INFO [stdout] test value_at_quantile_large_numbers ... ok
Nov 18 09:55:04.227 INFO [stdout] test value_at_quantile_matches_quantile_iter_sequence_values ... ok
Nov 18 09:55:11.031 INFO [stdout] test value_at_quantile_matches_quantile_at_each_value_sequence_values ... ok
Nov 18 09:55:25.061 INFO [stdout] test value_at_quantile_matches_quantile_iter_random_values ... ok
Nov 18 09:55:28.267 INFO [stdout] test value_at_quantile_matches_random_quantile_random_values ... ok
Nov 18 09:55:46.679 INFO [stdout] test value_at_quantile_matches_quantile_at_each_value_random_values ... ok
Nov 18 09:55:46.679 INFO [stdout] 
Nov 18 09:55:46.679 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:55:46.679 INFO [stdout] 
Nov 18 09:55:46.682 INFO [stderr]      Running /target/debug/deps/serialization-2b7af36e00d8974e
Nov 18 09:55:46.682 INFO [stdout] 
Nov 18 09:55:46.682 INFO [stdout] running 4 tests
Nov 18 09:55:46.779 INFO [stdout] test tests::total_count_overflow_from_deserialize_saturates ... ok
Nov 18 09:55:47.087 INFO [stdout] test tests::serialize_no_compression_matches_java_impl ... ok
Nov 18 09:55:47.214 INFO [stdout] test tests::deserialize_no_compression_matches_java ... ok
Nov 18 09:55:47.220 INFO [stdout] test tests::deserialize_compression_matches_java ... ok
Nov 18 09:55:47.220 INFO [stdout] 
Nov 18 09:55:47.220 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:55:47.220 INFO [stdout] 
Nov 18 09:55:47.221 INFO [stderr]    Doc-tests hdrsample
Nov 18 09:55:48.587 INFO [stdout] 
Nov 18 09:55:48.587 INFO [stdout] running 15 tests
Nov 18 09:55:55.090 INFO [stdout] test src/lib.rs -  (line 95) ... ok
Nov 18 09:55:55.231 INFO [stdout] test src/lib.rs - Histogram<T>::iter_log (line 1080) ... ok
Nov 18 09:55:56.503 INFO [stdout] test src/lib.rs -  (line 69) ... ok
Nov 18 09:55:57.599 INFO [stdout] test src/lib.rs - Histogram<T>::iter_all (line 1157) ... ok
Nov 18 09:55:58.675 INFO [stdout] test src/lib.rs - Histogram<T>::iter_recorded (line 1118) ... ok
Nov 18 09:56:00.194 INFO [stdout] test src/lib.rs - Histogram<T>::iter_linear (line 1022) ... ok
Nov 18 09:56:00.635 INFO [stdout] test src/lib.rs - Histogram<T>::iter_quantiles (line 964) ... ok
Nov 18 09:56:00.919 INFO [stdout] test src/lib.rs -  (line 108) ... ok
Nov 18 09:56:03.380 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 145) ... ok
Nov 18 09:56:05.152 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 122) ... ok
Nov 18 09:56:07.647 INFO [stdout] test src/serialization/mod.rs - serialization (line 119) ... ok
Nov 18 09:56:08.043 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log::IntervalLogWriter (line 339) ... ok
Nov 18 09:56:09.135 INFO [stdout] test src/serialization/mod.rs - serialization (line 75) ... ok
Nov 18 09:56:09.196 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 175) ... ok
Nov 18 09:56:09.294 INFO [stdout] test src/serialization/mod.rs - serialization (line 134) ... ok
Nov 18 09:56:09.294 INFO [stdout] 
Nov 18 09:56:09.295 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 09:56:09.295 INFO [stdout] 
Nov 18 09:56:09.332 INFO [stderr] su: No module specific data is present
Nov 18 09:56:09.965 INFO running `"docker" "inspect" "b777d57e2c37d526b2cc3042b6a25466fb52408a36422791bbe3d14fd6fa6422"`
Nov 18 09:56:10.161 INFO running `"docker" "rm" "-f" "b777d57e2c37d526b2cc3042b6a25466fb52408a36422791bbe3d14fd6fa6422"`
Nov 18 09:56:10.434 INFO [stdout] b777d57e2c37d526b2cc3042b6a25466fb52408a36422791bbe3d14fd6fa6422