Dec 15 09:00:59.693 INFO testing hdrsample-6.0.4 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550 Dec 15 09:00:59.693 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +bd47d6825bf4090517549d33cfef10d3300b4a75-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"` Dec 15 09:01:00.077 INFO [stdout] 5c12695dea3808d3b80749e13a287822055b1fe0bd9519b92deb433e7c904afc Dec 15 09:01:00.083 INFO running `"docker" "start" "-a" "5c12695dea3808d3b80749e13a287822055b1fe0bd9519b92deb433e7c904afc"` Dec 15 09:01:01.127 INFO [stderr] usermod: no changes Dec 15 09:01:01.307 INFO [stderr] Compiling base64 v0.7.0 Dec 15 09:01:02.539 INFO [stderr] Compiling hdrsample v6.0.4 (/source) Dec 15 09:01:05.047 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 3.89s Dec 15 09:01:05.052 INFO [stderr] su: No module specific data is present Dec 15 09:01:05.795 INFO running `"docker" "inspect" "5c12695dea3808d3b80749e13a287822055b1fe0bd9519b92deb433e7c904afc"` Dec 15 09:01:06.020 INFO running `"docker" "rm" "-f" "5c12695dea3808d3b80749e13a287822055b1fe0bd9519b92deb433e7c904afc"` Dec 15 09:01:06.211 INFO [stdout] 5c12695dea3808d3b80749e13a287822055b1fe0bd9519b92deb433e7c904afc Dec 15 09:01:06.213 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +bd47d6825bf4090517549d33cfef10d3300b4a75-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"` Dec 15 09:01:06.571 INFO [stdout] 6bdc08295bcd944787f6de28f66cc2a6137073d6f28e5646bb165d97d3ef328e Dec 15 09:01:06.574 INFO running `"docker" "start" "-a" "6bdc08295bcd944787f6de28f66cc2a6137073d6f28e5646bb165d97d3ef328e"` Dec 15 09:01:07.755 INFO [stderr] usermod: no changes Dec 15 09:01:07.923 INFO [stderr] Compiling rug v0.9.3 Dec 15 09:01:07.923 INFO [stderr] Compiling ieee754 v0.2.2 Dec 15 09:01:07.939 INFO [stderr] Compiling gmp-mpfr-sys v1.1.9 Dec 15 09:01:19.915 INFO [stderr] Compiling hdrsample v6.0.4 (/source) Dec 15 09:01:27.923 INFO [stderr] warning: unnecessary parentheses around method argument Dec 15 09:01:27.923 INFO [stderr] --> src/tests/value_calculation.rs:28:43 Dec 15 09:01:27.923 INFO [stderr] | Dec 15 09:01:27.923 INFO [stderr] 28 | assert_eq!(1 << 7, h.equivalent_range((1 << 17))); Dec 15 09:01:27.923 INFO [stderr] | ^^^^^^^^^ help: remove these parentheses Dec 15 09:01:27.923 INFO [stderr] | Dec 15 09:01:27.923 INFO [stderr] = note: #[warn(unused_parens)] on by default Dec 15 09:01:27.923 INFO [stderr] Dec 15 09:01:27.923 INFO [stderr] warning: unnecessary parentheses around method argument Dec 15 09:01:27.923 INFO [stderr] --> src/tests/value_calculation.rs:56:43 Dec 15 09:01:27.923 INFO [stderr] | Dec 15 09:01:27.923 INFO [stderr] 56 | assert_eq!(1 << 7, h.equivalent_range((1 << 17))); Dec 15 09:01:27.923 INFO [stderr] | ^^^^^^^^^ help: remove these parentheses Dec 15 09:01:27.923 INFO [stderr] Dec 15 09:01:39.873 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 32.10s Dec 15 09:01:39.887 INFO [stderr] su: No module specific data is present Dec 15 09:01:40.503 INFO running `"docker" "inspect" "6bdc08295bcd944787f6de28f66cc2a6137073d6f28e5646bb165d97d3ef328e"` Dec 15 09:01:40.766 INFO running `"docker" "rm" "-f" "6bdc08295bcd944787f6de28f66cc2a6137073d6f28e5646bb165d97d3ef328e"` Dec 15 09:01:41.078 INFO [stdout] 6bdc08295bcd944787f6de28f66cc2a6137073d6f28e5646bb165d97d3ef328e Dec 15 09:01:41.081 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +bd47d6825bf4090517549d33cfef10d3300b4a75-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"` Dec 15 09:01:41.540 INFO [stdout] 965206568b961c903da5d90cf5a72205e182ee90566d2c4c1e4d2e8b31cfcd5d Dec 15 09:01:41.543 INFO running `"docker" "start" "-a" "965206568b961c903da5d90cf5a72205e182ee90566d2c4c1e4d2e8b31cfcd5d"` Dec 15 09:01:42.575 INFO [stderr] usermod: no changes Dec 15 09:01:42.663 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.06s Dec 15 09:01:42.679 INFO [stderr] Running /target/debug/deps/hdrsample-49c6b8067e755fa6 Dec 15 09:01:42.679 INFO [stdout] Dec 15 09:01:42.679 INFO [stdout] running 160 tests Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::iter_multiple_entrties_with_interleaved_ignored ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::iter_with_ignored_prefix ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::iter_all_ignored_empty_iter ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::parse_duration_full_ns ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::parse_duration_scale_ns ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::parse_interval_hist_no_tag ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::parse_comment ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::parse_duration_too_many_ns ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::parse_interval_hist_with_tag ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::parse_legend ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::write_base_time ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::parse_start_time_with_human_date ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::parse_start_time_without_human_date ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::write_comment_newline_wraps ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::write_comment_control_characters_still_parseable ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::write_header_comment ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::write_header_then_interval_comment ... ok Dec 15 09:01:42.688 INFO [stdout] test serialization::interval_log::tests::write_headers_multiple_times_only_last_is_used ... ok Dec 15 09:01:42.691 INFO [stdout] test serialization::interval_log::tests::write_start_time ... ok Dec 15 09:01:42.699 INFO [stdout] test serialization::interval_log::tests::parse_base_time ... ok Dec 15 09:01:42.699 INFO [stdout] test serialization::tests::encode_counts_first_count_incremented ... ok Dec 15 09:01:42.699 INFO [stdout] test serialization::interval_log::tests::iter_without_ignored_prefix ... ok Dec 15 09:01:42.707 INFO [stdout] test serialization::interval_log::tests::write_interval_histo_with_tag ... ok Dec 15 09:01:42.707 INFO [stdout] test serialization::tests::encode_counts_first_and_last_count_incremented ... ok Dec 15 09:01:42.707 INFO [stdout] test serialization::tests::rand_varint::largest_number_in_7_bit_chunk_correct ... ok Dec 15 09:01:42.707 INFO [stdout] test serialization::tests::encode_counts_count_too_big ... ok Dec 15 09:01:42.711 INFO [stdout] test serialization::tests::encode_counts_all_zeros ... ok Dec 15 09:01:42.719 INFO [stdout] test serialization::interval_log::tests::write_interval_histo_no_tag ... ok Dec 15 09:01:42.723 INFO [stdout] test serialization::tests::serialize_roundtrip_1_count_for_every_value_2_buckets ... ok Dec 15 09:01:42.723 INFO [stdout] test serialization::tests::serialize_roundtrip_all_zeros ... ok Dec 15 09:01:42.735 INFO [stdout] test serialization::tests::encode_counts_last_count_incremented ... ok Dec 15 09:01:42.743 INFO [stdout] test serialization::tests::serialize_all_zeros ... ok Dec 15 09:01:42.743 INFO [stdout] test serialization::tests::serialize_roundtrip_1_count_for_every_value_1_bucket ... ok Dec 15 09:01:43.359 INFO [stdout] test serialization::interval_log::tests::duration_fp_roundtrip_accuracy ... ok Dec 15 09:01:55.919 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u16 ... ok Dec 15 09:01:55.924 INFO [stdout] test serialization::tests::varint_read_u64_max ... ok Dec 15 09:01:55.939 INFO [stdout] test serialization::tests::varint_read_u64_zero ... ok Dec 15 09:01:55.991 INFO [stdout] test serialization::tests::varint_write_3_bit_value ... ok Dec 15 09:01:55.991 INFO [stdout] test serialization::tests::varint_write_7_bit_value ... ok Dec 15 09:01:55.991 INFO [stdout] test serialization::tests::varint_write_9_bit_value ... ok Dec 15 09:01:56.115 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u8 ... ok Dec 15 09:01:56.231 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_1_byte ... ok Dec 15 09:01:56.514 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_3_byte ... ok Dec 15 09:01:56.527 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_2_byte ... ok Dec 15 09:01:56.907 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_5_byte ... ok Dec 15 09:01:56.999 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u64 ... ok Dec 15 09:01:57.039 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_4_byte ... ok Dec 15 09:01:57.242 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u32 ... ok Dec 15 09:01:57.339 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_6_byte ... ok Dec 15 09:01:57.409 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_7_byte ... ok Dec 15 09:01:57.599 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_2_byte ... ok Dec 15 09:01:57.617 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_8_byte ... ok Dec 15 09:01:57.686 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_1_byte ... ok Dec 15 09:01:57.810 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_3_byte ... ok Dec 15 09:01:57.847 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u16 ... ok Dec 15 09:01:57.919 INFO [stdout] test serialization::tests::varint_write_read_roundtrip_rand_9_byte ... ok Dec 15 09:01:57.925 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_4_byte ... ok Dec 15 09:01:57.936 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_5_byte ... ok Dec 15 09:01:57.955 INFO [stdout] test serialization::tests::varint_write_u64_max ... ok Dec 15 09:01:57.955 INFO [stdout] test serialization::tests::zig_zag_decode_0 ... ok Dec 15 09:01:57.955 INFO [stdout] test serialization::tests::zig_zag_decode_1 ... ok Dec 15 09:01:57.955 INFO [stdout] test serialization::tests::zig_zag_decode_2 ... ok Dec 15 09:01:57.955 INFO [stdout] test serialization::tests::zig_zag_decode_u64_max_penultimate_to_i64_max ... ok Dec 15 09:01:57.955 INFO [stdout] test serialization::tests::zig_zag_decode_u64_max_to_i64_min ... ok Dec 15 09:01:57.955 INFO [stdout] test serialization::tests::zig_zag_encode_0 ... ok Dec 15 09:01:57.955 INFO [stdout] test serialization::tests::zig_zag_encode_1 ... ok Dec 15 09:01:57.955 INFO [stdout] test serialization::tests::zig_zag_encode_i64_max ... ok Dec 15 09:01:57.983 INFO [stdout] test serialization::tests::zig_zag_encode_i64_min ... ok Dec 15 09:01:57.983 INFO [stdout] test serialization::tests::zig_zag_encode_neg_1 ... ok Dec 15 09:01:58.234 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_7_byte ... ok Dec 15 09:01:58.240 INFO [stdout] test tests::correct_original_min ... ok Dec 15 09:01:58.246 INFO [stdout] test tests::index_calculation::bucket_for_biggest_value_in_first_bucket ... ok Dec 15 09:01:58.293 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_9_byte ... ok Dec 15 09:01:58.293 INFO [stdout] test tests::index_calculation::bucket_for_biggest_value_in_second_bucket ... ok Dec 15 09:01:58.296 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_first_bucket ... ok Dec 15 09:01:58.297 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_second_bucket ... ok Dec 15 09:01:58.308 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_third_bucket ... ok Dec 15 09:01:58.308 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_8_byte ... ok Dec 15 09:01:58.308 INFO [stdout] test tests::index_calculation::bucket_for_smallest_value_in_last_bucket ... ok Dec 15 09:01:58.308 INFO [stdout] test serialization::tests::varint_write_read_slice_roundtrip_rand_6_byte ... ok Dec 15 09:01:58.319 INFO [stdout] test tests::index_calculation::bucket_for_value_above_biggest_isnt_clamped_at_max_bucket ... ok Dec 15 09:01:58.319 INFO [stdout] test tests::index_calculation::bucket_for_value_below_smallest_clamps_to_zero ... ok Dec 15 09:01:58.320 INFO [stdout] test tests::index_calculation::index_for_first_bucket_first_entry ... ok Dec 15 09:01:58.326 INFO [stdout] test tests::index_calculation::index_for_second_bucket_first_entry ... ok Dec 15 09:01:58.331 INFO [stdout] test tests::index_calculation::index_for_second_bucket_last_entry ... ok Dec 15 09:01:58.331 INFO [stdout] test tests::index_calculation::index_for_below_smallest ... ok Dec 15 09:01:58.331 INFO [stdout] test tests::index_calculation::index_for_first_bucket_first_distinguishable_entry ... ok Dec 15 09:01:58.332 INFO [stdout] test tests::index_calculation::index_for_second_bucket_last_entry_indistinguishable ... ok Dec 15 09:01:58.339 INFO [stdout] test tests::index_calculation::sub_bucket_for_biggest_value_in_second_bucket ... ok Dec 15 09:01:58.339 INFO [stdout] test tests::index_calculation::sub_bucket_for_largest_value_in_first_bucket ... ok Dec 15 09:01:58.340 INFO [stdout] test tests::index_calculation::sub_bucket_for_largest_value_in_first_bucket_unit_magnitude_2 ... ok Dec 15 09:01:58.347 INFO [stdout] test tests::index_calculation::sub_bucket_for_smaller_than_distinguishable_value_in_first_bucket_unit_magnitude_2 ... ok Dec 15 09:01:58.348 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_distinguishable_value_in_first_bucket ... ok Dec 15 09:01:58.350 INFO [stdout] test tests::index_calculation::index_for_way_past_largest_value_exceeds_length ... ok Dec 15 09:01:58.351 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_second_bucket_unit_magnitude_2 ... ok Dec 15 09:01:58.355 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_distinguishable_value_in_first_bucket_unit_magnitude_2 ... ok Dec 15 09:01:58.357 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_second_bucket ... ok Dec 15 09:01:58.357 INFO [stdout] test tests::index_calculation::index_for_first_bucket_last_entry ... ok Dec 15 09:01:58.357 INFO [stdout] test tests::index_calculation::sub_bucket_for_value_above_biggest_still_works ... ok Dec 15 09:01:58.358 INFO [stdout] test tests::index_calculation::sub_bucket_for_value_below_smallest_clamps_to_zero ... ok Dec 15 09:01:58.363 INFO [stdout] test tests::index_calculation::unit_magnitude_0_index_calculations ... ok Dec 15 09:01:58.363 INFO [stdout] test tests::index_calculation::sub_bucket_for_smallest_value_in_third_bucket ... ok Dec 15 09:01:58.363 INFO [stdout] test tests::index_calculation::sub_bucket_for_zero_value_in_first_bucket ... ok Dec 15 09:01:58.363 INFO [stdout] test tests::index_calculation::sub_bucket_for_zero_value_in_first_bucket_unit_magnitude_2 ... ok Dec 15 09:01:58.366 INFO [stdout] test tests::index_calculation::unit_magnitude_4_index_calculations ... ok Dec 15 09:01:58.366 INFO [stdout] test tests::index_calculation::unit_magnitude_62_sub_bucket_magnitude_1_ok ... ok Dec 15 09:01:58.367 INFO [stdout] test tests::init::init_fields_10m_max_1k_min_middle_precision ... ok Dec 15 09:01:58.370 INFO [stdout] test tests::init::init_fields_1_bucket_medium_precision ... ok Dec 15 09:01:58.370 INFO [stdout] test tests::init::init_fields_max_value_0_precision_increased_min_value ... ok Dec 15 09:01:58.372 INFO [stdout] test tests::init::init_fields_max_value_0_precision_most_buckets ... ok Dec 15 09:01:58.383 INFO [stdout] test tests::index_calculation::unit_magnitude_52_sub_bucket_magnitude_11_index_calculations ... ok Dec 15 09:01:58.383 INFO [stdout] test tests::index_calculation::unit_magnitude_53_sub_bucket_magnitude_11_throws ... ok Dec 15 09:01:58.383 INFO [stdout] test tests::index_calculation::unit_magnitude_55_sub_bucket_magnitude_8_ok ... ok Dec 15 09:01:58.412 INFO [stdout] test tests::init::init_fields_max_value_max_unit_magnitude_0_precision ... ok Dec 15 09:01:58.435 INFO [stdout] test tests::init::init_fields_max_value_medium_precision ... ok Dec 15 09:01:58.449 INFO [stdout] test tests::init::init_fields_smallest_possible_array ... ok Dec 15 09:01:58.464 INFO [stdout] test tests::init::init_fields_max_value_max_unit_magnitude_max_precision ... ok Dec 15 09:01:58.464 INFO [stdout] test serialization::tests::zig_zag_roundtrip_random ... ok Dec 15 09:01:58.483 INFO [stdout] test tests::new_err_high_not_double_low ... ok Dec 15 09:01:58.591 INFO [stdout] test tests::subtract::subtract_subtrahend_values_outside_minuend_range_error ... ok Dec 15 09:01:58.603 INFO [stdout] test tests::subtract::subtract_to_negative_counts_error ... ok Dec 15 09:01:58.653 INFO [stdout] test tests::subtract::subtract_to_zero_counts ... ok Dec 15 09:01:58.692 INFO [stdout] test tests::subtract::subtract_after_add ... ok Dec 15 09:01:58.701 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_deflate_u64 ... ok Dec 15 09:01:58.771 INFO [stdout] test tests::subtract::subtract_values_at_extent_of_minuend_zero_count_range_recalculates_min_max ... ok Dec 15 09:01:58.871 INFO [stdout] test tests::subtract::subtract_values_at_extent_of_minuend_nonzero_count_range_recalculates_same_min_max ... ok Dec 15 09:01:58.909 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u32 ... ok Dec 15 09:01:59.166 INFO [stdout] test tests::subtract::subtract_values_minuend_saturated_total_recalculates_saturated ... ok Dec 15 09:01:59.171 INFO [stdout] test tests::subtract::subtract_values_minuend_saturated_total_recalculates_not_saturated ... ok Dec 15 09:01:59.223 INFO [stdout] test tests::subtract::subtract_values_inside_minuend_range_works ... ok Dec 15 09:01:59.233 INFO [stdout] test serialization::tests::serialize_roundtrip_random_v2_u8 ... ok Dec 15 09:01:59.256 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0 ... ok Dec 15 09:01:59.339 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_max_buckets ... ok Dec 15 09:01:59.456 INFO [stdout] test tests::subtract::subtract_values_strictly_inside_minuend_range_yields_same_min_max_no_restat ... ok Dec 15 09:01:59.460 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_min_precision_max_buckets ... ok Dec 15 09:01:59.460 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_2 ... ok Dec 15 09:01:59.499 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_2_max_buckets ... ok Dec 15 09:01:59.503 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_50_max_buckets ... ok Dec 15 09:01:59.508 INFO [stdout] test tests::value_calculation::highest_equivalent_u64_max_value_saturates ... ok Dec 15 09:01:59.544 INFO [stdout] test tests::value_calculation::highest_equivalent_unit_magnitude_0 ... ok Dec 15 09:01:59.558 INFO [stdout] test tests::value_calculation::highest_equivalent_unit_magnitude_2 ... ok Dec 15 09:01:59.564 INFO [stdout] test tests::value_calculation::lowest_equivalent_unit_magnitude_0 ... ok Dec 15 09:01:59.571 INFO [stdout] test tests::value_calculation::lowest_equivalent_unit_magnitude_2 ... ok Dec 15 09:01:59.666 INFO [stdout] test tests::init::init_fields_max_value_max_precision_increased_min_value ... ok Dec 15 09:01:59.667 INFO [stdout] test tests::value_calculation::next_non_equivalent_u64_max_value_saturates ... ok Dec 15 09:01:59.667 INFO [stdout] test tests::value_calculation::next_non_equivalent_unit_magnitude_2 ... ok Dec 15 09:01:59.723 INFO [stdout] test tests::value_calculation::next_non_equivalent_unit_magnitude_0 ... ok Dec 15 09:01:59.735 INFO [stdout] test tests::value_calculation::value_for_beyond_histogram_max_still_works ... ok Dec 15 09:01:59.787 INFO [stdout] test tests::value_calculation::value_for_impossible_index ... ok Dec 15 09:01:59.794 INFO [stdout] test tests::value_calculation::value_for_unit_magnitude_0 ... ok Dec 15 09:01:59.806 INFO [stdout] test tests::value_calculation::value_for_unit_magnitude_2 ... ok Dec 15 09:01:59.817 INFO [stdout] test tests::value_calculation::value_from_loc_unit_magnitude_0 ... ok Dec 15 09:01:59.839 INFO [stdout] test tests::value_calculation::value_from_loc_unit_magnitude_2 ... ok Dec 15 09:02:00.047 INFO [stdout] test tests::init::init_fields_max_value_max_precision_largest_possible_array ... ok Dec 15 09:02:00.437 INFO [stdout] test tests::value_calculation::value_for_at_each_index ... ok Dec 15 09:02:00.878 INFO [stdout] test tests::value_calculation::equivalent_range_unit_magnitude_0_max_precision_max_buckets ... ok Dec 15 09:02:04.927 INFO [stdout] test tests::subtract::subtract_values_at_minuend_max_recalculates_min_max ... ok Dec 15 09:02:05.251 INFO [stdout] test tests::subtract::subtract_values_within_bucket_precision_of_of_minuend_max_recalculates_min_max ... ok Dec 15 09:02:05.463 INFO [stdout] test tests::subtract::subtract_values_within_bucket_precision_of_of_minuend_min_recalculates_min_max ... ok Dec 15 09:02:05.787 INFO [stdout] test tests::subtract::subtract_values_at_minuend_min_recalculates_min_max ... ok Dec 15 09:02:05.787 INFO [stderr] Running /target/debug/deps/auto_resize-2e00cf9836208b57 Dec 15 09:02:05.787 INFO [stdout] Dec 15 09:02:05.787 INFO [stdout] test result: ok. 160 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 09:02:05.787 INFO [stdout] Dec 15 09:02:05.791 INFO [stdout] Dec 15 09:02:05.791 INFO [stdout] running 4 tests Dec 15 09:02:05.819 INFO [stdout] test autosizing_add ... ok Dec 15 09:02:05.844 INFO [stdout] test histogram_autosizing_edges ... ok Dec 15 09:02:05.844 INFO [stdout] test histogram_autosizing ... ok Dec 15 09:02:08.315 INFO [stdout] test autosizing_across_continuous_range ... ok Dec 15 09:02:08.315 INFO [stdout] Dec 15 09:02:08.315 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 09:02:08.315 INFO [stdout] Dec 15 09:02:08.320 INFO [stderr] Running /target/debug/deps/data_access-05f205543311270e Dec 15 09:02:08.328 INFO [stdout] Dec 15 09:02:08.328 INFO [stdout] running 26 tests Dec 15 09:02:08.328 INFO [stdout] test count_between_low_and_high_beyond_max ... ok Dec 15 09:02:08.330 INFO [stdout] test count_between_high_beyond_max ... ok Dec 15 09:02:08.331 INFO [stdout] test count_between_saturates ... ok Dec 15 09:02:08.343 INFO [stdout] test count_at_beyond_max_value ... ok Dec 15 09:02:08.556 INFO [stdout] test get_max_value ... ok Dec 15 09:02:08.578 INFO [stdout] test count_at ... ok Dec 15 09:02:08.581 INFO [stdout] test count_between ... ok Dec 15 09:02:08.581 INFO [stdout] test get_min_value ... ok Dec 15 09:02:08.588 INFO [stdout] test get_mean ... ok Dec 15 09:02:08.594 INFO [stdout] test iter_all ... ok Dec 15 09:02:08.599 INFO [stdout] test linear_iter_steps ... ok Dec 15 09:02:08.649 INFO [stdout] test quantile_below_saturates ... ok Dec 15 09:02:08.653 INFO [stdout] test quantile_below_value_beyond_max ... ok Dec 15 09:02:08.670 INFO [stdout] test get_stdev ... ok Dec 15 09:02:08.671 INFO [stdout] test iter_log ... ok Dec 15 09:02:08.693 INFO [stdout] test quantile_atorbelow ... ok Dec 15 09:02:08.806 INFO [stdout] test linear_iter_raw ... ok Dec 15 09:02:08.806 INFO [stdout] test total_count_exceeds_bucket_type ... ok Dec 15 09:02:08.806 INFO [stdout] test iter_recorded ... ok Dec 15 09:02:08.840 INFO [stdout] test quantiles ... ok Dec 15 09:02:08.858 INFO [stdout] test value_duplication ... ok Dec 15 09:02:08.867 INFO [stdout] test total_count ... ok Dec 15 09:02:08.895 INFO [stdout] test linear_iter_corrected ... ok Dec 15 09:02:08.900 INFO [stdout] test scaling_equivalence ... ok Dec 15 09:02:08.964 INFO [stdout] test quantile_iter ... ok Dec 15 09:02:09.223 INFO [stdout] test large_quantile ... ok Dec 15 09:02:09.223 INFO [stdout] Dec 15 09:02:09.223 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 09:02:09.223 INFO [stdout] Dec 15 09:02:09.223 INFO [stderr] Running /target/debug/deps/histogram-1929f2bbd416702f Dec 15 09:02:09.224 INFO [stdout] Dec 15 09:02:09.224 INFO [stdout] running 37 tests Dec 15 09:02:09.230 INFO [stdout] test construction_arg_ranges ... ok Dec 15 09:02:09.230 INFO [stdout] test highest_equivalent ... ok Dec 15 09:02:09.239 INFO [stdout] test empty_histogram ... ok Dec 15 09:02:09.239 INFO [stdout] test median_equivalent_doesnt_panic_at_extremes ... ok Dec 15 09:02:09.249 INFO [stdout] test equivalent_range ... ok Dec 15 09:02:09.250 INFO [stdout] test median_equivalent ... ok Dec 15 09:02:09.255 INFO [stdout] test record ... ok Dec 15 09:02:09.255 INFO [stdout] test lowest_equivalent ... ok Dec 15 09:02:09.300 INFO [stdout] test record_past_trackable_max ... ok Dec 15 09:02:09.300 INFO [stdout] test reset ... ok Dec 15 09:02:09.300 INFO [stdout] test construction_arg_gets ... ok Dec 15 09:02:09.301 INFO [stdout] test record_in_interval ... ok Dec 15 09:02:09.307 INFO [stdout] test add ... ok Dec 15 09:02:09.307 INFO [stdout] test scaled_highest_equivalent ... ok Dec 15 09:02:09.311 INFO [stdout] test scaled_equivalent_range ... ok Dec 15 09:02:09.311 INFO [stdout] test saturating_record ... ok Dec 15 09:02:09.335 INFO [stdout] test scaled_lowest_equivalent ... ok Dec 15 09:02:09.363 INFO [stdout] test clone ... ok Dec 15 09:02:09.367 INFO [stdout] test scaled_median_equivalent ... ok Dec 15 09:02:09.383 INFO [stdout] test subtract_underflow_guarded_by_per_value_count_check ... ok Dec 15 09:02:09.443 INFO [stdout] test total_count_overflow_from_add_same_dimensions_saturates_calculating_other_addend_total ... ok Dec 15 09:02:09.518 INFO [stdout] test scaled_clone ... ok Dec 15 09:02:09.518 INFO [stdout] test total_count_overflow_from_add_with_resize_saturates ... ok Dec 15 09:02:09.518 INFO [stdout] test total_count_overflow_from_record_saturates ... ok Dec 15 09:02:09.518 INFO [stdout] test set_to ... ok Dec 15 09:02:09.584 INFO [stdout] test total_count_overflow_from_add_same_dimensions_saturates_when_added_to_orig_total_count ... ok Dec 15 09:02:09.584 INFO [stdout] test scaled_set_to ... ok Dec 15 09:02:09.584 INFO [stdout] test value_count_overflow_from_record_autoresize_doesnt_panic_saturates ... ok Dec 15 09:02:09.584 INFO [stdout] test value_count_overflow_from_record_saturates_u16 ... ok Dec 15 09:02:09.595 INFO [stdout] test value_count_overflow_from_record_saturates_u64 ... ok Dec 15 09:02:09.611 INFO [stdout] test value_count_overflow_from_add_with_resize_to_same_dimensions_saturates ... ok Dec 15 09:02:09.619 INFO [stdout] test value_count_overflow_from_add_same_dimensions_saturates ... ok Dec 15 09:02:09.661 INFO [stdout] test total_count_overflow_from_add_different_precision_saturates ... ok Dec 15 09:02:09.753 INFO [stdout] test value_count_overflow_from_add_different_precision_saturates ... ok Dec 15 09:02:09.982 INFO [stdout] test random_write_full_value_range_precision_0_no_panic ... ok Dec 15 09:02:10.059 INFO [stdout] test random_write_middle_of_value_range_precision_3_no_panic ... ok Dec 15 09:02:10.735 INFO [stdout] test random_write_full_value_range_precision_5_no_panic ... ok Dec 15 09:02:10.735 INFO [stdout] Dec 15 09:02:10.735 INFO [stdout] test result: ok. 37 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 09:02:10.735 INFO [stdout] Dec 15 09:02:10.739 INFO [stdout] Dec 15 09:02:10.739 INFO [stderr] Running /target/debug/deps/interval_log-d611425eda64edc3 Dec 15 09:02:10.739 INFO [stdout] running 6 tests Dec 15 09:02:10.760 INFO [stdout] test tests::parse_interval_log_syntax_error_then_returns_none ... ok Dec 15 09:02:10.760 INFO [stdout] test tests::parse_sample_tagged_interval_log_interval_count ... ok Dec 15 09:02:10.777 INFO [stdout] test tests::parse_sample_tagged_interval_log_start_timestamp ... ok Dec 15 09:02:10.777 INFO [stdout] test tests::parse_sample_tagged_interval_log_interval_metadata ... ok Dec 15 09:02:10.835 INFO [stdout] test tests::parse_sample_tagged_interval_log_rewrite_identical ... ok Dec 15 09:02:14.227 INFO [stdout] test tests::write_random_histograms_to_interval_log_then_read ... ok Dec 15 09:02:14.227 INFO [stdout] Dec 15 09:02:14.227 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 09:02:14.227 INFO [stdout] Dec 15 09:02:14.231 INFO [stderr] Running /target/debug/deps/iterators-c3bbbcf637a9ba9e Dec 15 09:02:14.239 INFO [stdout] Dec 15 09:02:14.239 INFO [stdout] running 20 tests Dec 15 09:02:14.243 INFO [stdout] test iter_linear_bucket_values_size_8_all_buckets ... ok Dec 15 09:02:14.253 INFO [stdout] test iter_all_values_all_buckets ... ok Dec 15 09:02:14.255 INFO [stdout] test iter_all_values_all_buckets_unit_magnitude_2 ... ok Dec 15 09:02:14.256 INFO [stdout] test iter_linear_count_since_last_iteration_saturates ... ok Dec 15 09:02:14.256 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_2_all_buckets_unit_magnitude_2 ... ok Dec 15 09:02:14.256 INFO [stdout] test iter_logarithmic_bucket_values_min_4_base_2_all_buckets ... ok Dec 15 09:02:14.256 INFO [stdout] test iter_quantiles_iterates_to_end_skips_intermediate_at_final_value ... ok Dec 15 09:02:14.256 INFO [stdout] test iter_quantiles_empty ... ok Dec 15 09:02:14.259 INFO [stdout] test iter_quantiles_one_value ... ok Dec 15 09:02:14.264 INFO [stdout] test iter_linear_visits_buckets_once_when_step_size_equals_bucket_size ... ok Dec 15 09:02:14.275 INFO [stdout] test iter_quantiles_smorgasboard ... ok Dec 15 09:02:14.275 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_2_all_buckets ... ok Dec 15 09:02:14.275 INFO [stdout] test iter_quantiles_iterates_to_quantile_10_as_it_reaches_last_bucket ... ok Dec 15 09:02:14.303 INFO [stdout] test iter_quantiles_saturated_count_before_max_value ... ok Dec 15 09:02:14.303 INFO [stdout] test iter_recorded_values_all_buckets_unit_magnitude_2 ... ok Dec 15 09:02:14.303 INFO [stdout] test iter_logarithmic_bucket_values_min_1_base_10_all_buckets ... ok Dec 15 09:02:14.307 INFO [stdout] test iter_recorded_values_all_buckets ... ok Dec 15 09:02:14.307 INFO [stdout] test iter_linear_visits_buckets_wider_than_step_size_multiple_times ... ok Dec 15 09:02:14.311 INFO [stdout] test iter_recorded_saturated_total_count ... ok Dec 15 09:02:14.311 INFO [stdout] test iter_recorded_non_saturated_total_count ... ok Dec 15 09:02:14.311 INFO [stdout] Dec 15 09:02:14.311 INFO [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 09:02:14.311 INFO [stdout] Dec 15 09:02:14.319 INFO [stderr] Running /target/debug/deps/quantile-a687425efa94bd81 Dec 15 09:02:14.319 INFO [stdout] Dec 15 09:02:14.319 INFO [stdout] running 10 tests Dec 15 09:02:14.333 INFO [stdout] test value_at_quantile_internal_count_exceeds_bucket_type ... ok Dec 15 09:02:14.383 INFO [stdout] test value_at_quantile_5_values ... ok Dec 15 09:02:14.393 INFO [stdout] test value_at_quantile_2_values ... ok Dec 15 09:02:14.399 INFO [stdout] test value_at_quantile_20k ... ok Dec 15 09:02:14.472 INFO [stdout] test value_at_quantile_large_numbers ... ok Dec 15 09:02:18.175 INFO [stdout] test value_at_quantile_matches_quantile_iter_sequence_values ... ok Dec 15 09:02:23.065 INFO [stdout] test value_at_quantile_matches_quantile_at_each_value_sequence_values ... ok Dec 15 09:02:43.495 INFO [stdout] test value_at_quantile_matches_quantile_iter_random_values ... ok Dec 15 09:02:48.941 INFO [stdout] test value_at_quantile_matches_random_quantile_random_values ... ok Dec 15 09:03:06.045 INFO [stdout] test value_at_quantile_matches_quantile_at_each_value_random_values ... ok Dec 15 09:03:06.045 INFO [stdout] Dec 15 09:03:06.045 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 09:03:06.045 INFO [stdout] Dec 15 09:03:06.045 INFO [stderr] Running /target/debug/deps/serialization-93a115e8d993be74 Dec 15 09:03:06.055 INFO [stdout] Dec 15 09:03:06.055 INFO [stdout] running 4 tests Dec 15 09:03:06.116 INFO [stdout] test tests::total_count_overflow_from_deserialize_saturates ... ok Dec 15 09:03:06.791 INFO [stdout] test tests::serialize_no_compression_matches_java_impl ... ok Dec 15 09:03:06.884 INFO [stdout] test tests::deserialize_compression_matches_java ... ok Dec 15 09:03:06.905 INFO [stdout] test tests::deserialize_no_compression_matches_java ... ok Dec 15 09:03:06.905 INFO [stdout] Dec 15 09:03:06.905 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 09:03:06.905 INFO [stdout] Dec 15 09:03:06.907 INFO [stderr] Doc-tests hdrsample Dec 15 09:03:08.795 INFO [stdout] Dec 15 09:03:08.795 INFO [stdout] running 15 tests Dec 15 09:03:17.991 INFO [stdout] test src/lib.rs - Histogram::iter_quantiles (line 964) ... ok Dec 15 09:03:19.647 INFO [stdout] test src/lib.rs - Histogram::iter_linear (line 1022) ... ok Dec 15 09:03:19.995 INFO [stdout] test src/lib.rs - (line 108) ... ok Dec 15 09:03:19.999 INFO [stdout] test src/lib.rs - Histogram::iter_recorded (line 1118) ... ok Dec 15 09:03:20.199 INFO [stdout] test src/lib.rs - (line 69) ... ok Dec 15 09:03:22.871 INFO [stdout] test src/lib.rs - (line 95) ... ok Dec 15 09:03:24.088 INFO [stdout] test src/lib.rs - Histogram::iter_log (line 1080) ... ok Dec 15 09:03:24.729 INFO [stdout] test src/lib.rs - Histogram::iter_all (line 1157) ... ok Dec 15 09:03:31.623 INFO [stdout] test src/serialization/mod.rs - serialization (line 119) ... ok Dec 15 09:03:32.479 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log::IntervalLogWriter (line 339) ... ok Dec 15 09:03:32.971 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 175) ... ok Dec 15 09:03:33.191 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 122) ... ok Dec 15 09:03:33.196 INFO [stdout] test src/serialization/interval_log/mod.rs - serialization::interval_log (line 145) ... ok Dec 15 09:03:34.660 INFO [stdout] test src/serialization/mod.rs - serialization (line 75) ... ok Dec 15 09:03:34.715 INFO [stdout] test src/serialization/mod.rs - serialization (line 134) ... ok Dec 15 09:03:34.715 INFO [stdout] Dec 15 09:03:34.715 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 09:03:34.715 INFO [stdout] Dec 15 09:03:34.745 INFO [stderr] su: No module specific data is present Dec 15 09:03:35.550 INFO running `"docker" "inspect" "965206568b961c903da5d90cf5a72205e182ee90566d2c4c1e4d2e8b31cfcd5d"` Dec 15 09:03:35.818 INFO running `"docker" "rm" "-f" "965206568b961c903da5d90cf5a72205e182ee90566d2c4c1e4d2e8b31cfcd5d"` Dec 15 09:03:36.091 INFO [stdout] 965206568b961c903da5d90cf5a72205e182ee90566d2c4c1e4d2e8b31cfcd5d