[INFO] fetching crate cp-progress 0.6.0...
[INFO] testing cp-progress-0.6.0 against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate cp-progress 0.6.0 into /workspace/builds/worker-1-tc2/source
[INFO] started tweaking crates.io crate cp-progress 0.6.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate cp-progress 0.6.0
[INFO] tweaked toml for crates.io crate cp-progress 0.6.0 written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate cp-progress 0.6.0 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate cp-progress 0.6.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 3ee59f696d4b8ba72f87f367b37553952750f12013ee9280478aecf642928813
[INFO] running `Command { std: "docker" "start" "3ee59f696d4b8ba72f87f367b37553952750f12013ee9280478aecf642928813", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3ee59f696d4b8ba72f87f367b37553952750f12013ee9280478aecf642928813", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3ee59f696d4b8ba72f87f367b37553952750f12013ee9280478aecf642928813" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3ee59f696d4b8ba72f87f367b37553952750f12013ee9280478aecf642928813", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3ee59f696d4b8ba72f87f367b37553952750f12013ee9280478aecf642928813" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling lexopt v0.3.2
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling signal-hook v0.3.18
[INFO] [stderr]    Compiling cp-progress v0.6.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 7.40s
[INFO] running `Command { std: "docker" "inspect" "3ee59f696d4b8ba72f87f367b37553952750f12013ee9280478aecf642928813", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3ee59f696d4b8ba72f87f367b37553952750f12013ee9280478aecf642928813" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling nix v0.30.1
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling signal-hook v0.3.18
[INFO] [stderr]    Compiling cp-progress v0.6.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 11.83s
[INFO] running `Command { std: "docker" "inspect" "3ee59f696d4b8ba72f87f367b37553952750f12013ee9280478aecf642928813", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3ee59f696d4b8ba72f87f367b37553952750f12013ee9280478aecf642928813" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.07s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/build/cp-progress/6a36130c144a8011/out/cprog-6a36130c144a8011)
[INFO] [stdout] 
[INFO] [stdout] running 219 tests
[INFO] [stdout] test args::tests::a_long_option_with_an_attached_value_does_not_fail_the_scan ... ok
[INFO] [stdout] test args::tests::bundled_short_interactive ... ok
[INFO] [stdout] test args::tests::attached_short_suffix_value ... ok
[INFO] [stdout] test args::tests::double_dash_makes_following_dash_i_an_operand ... ok
[INFO] [stdout] test args::tests::bundled_short_verbose ... ok
[INFO] [stdout] test args::tests::short_interactive ... ok
[INFO] [stdout] test args::tests::short_verbose ... ok
[INFO] [stdout] test args::tests::long_target_directory_value_looking_like_flag ... ok
[INFO] [stdout] test args::tests::long_interactive ... ok
[INFO] [stdout] test args::tests::permuted_interactive_after_operand ... ok
[INFO] [stdout] test args::tests::long_interactive_with_attached_value ... ok
[INFO] [stdout] test args::tests::long_verbose ... ok
[INFO] [stdout] test args::tests::both_verbose_and_interactive ... ok
[INFO] [stdout] test args::tests::long_suffix_value_looking_like_flag ... ok
[INFO] [stdout] test capture::tests::an_interrupted_read_does_not_end_the_stderr_relay ... ok
[INFO] [stdout] test args::tests::double_dash_makes_following_dash_v_an_operand ... ok
[INFO] [stdout] test capture::tests::completed_line_pulses_the_slow_timer ... ok
[INFO] [stdout] test capture::tests::a_chunk_without_a_line_boundary_does_not_pulse ... ok
[INFO] [stdout] test capture::tests::relay_bytes_forwards_verbatim ... ok
[INFO] [stdout] test capture::tests::without_verbose_the_bytes_are_dropped_but_the_timer_still_pulses ... ok
[INFO] [stdout] test capture::tests::a_real_read_error_still_ends_the_relay ... ok
[INFO] [stdout] test capture::tests::an_interrupted_read_does_not_end_the_relay ... ok
[INFO] [stdout] test args::tests::suffix_value_looking_like_interactive_is_not_a_flag ... ok
[INFO] [stdout] test args::tests::target_directory_value_looking_like_verbose_is_not_a_flag ... ok
[INFO] [stdout] test args::tests::missing_required_value_is_scan_error ... ok
[INFO] [stdout] test capture::tests::relays_partial_line_without_waiting_for_newline ... ok
[INFO] [stdout] test env_knobs::a_numeric_knob_is_taken_verbatim ... ok
[INFO] [stdout] test exit::tests::nonzero_exit_code_is_preserved ... ok
[INFO] [stdout] test env_knobs::an_overflowing_knob_falls_back_rather_than_wrapping ... ok
[INFO] [stdout] test env_knobs::each_knob_reads_the_variable_that_names_it ... ok
[INFO] [stdout] test env_knobs::unset_knobs_are_the_values_the_docs_promise ... ok
[INFO] [stdout] test exit::tests::finalize_returns_code_verbatim ... ok
[INFO] [stdout] test exit::tests::signal_maps_to_128_plus_n ... ok
[INFO] [stdout] test messages::tests::color_wraps_success_green_and_failure_red ... ok
[INFO] [stdout] test exit::tests::signal_termination_is_detected ... ok
[INFO] [stdout] test messages::tests::cp_spawn_fatal ... ok
[INFO] [stdout] test messages::tests::cp_wait_fatal ... ok
[INFO] [stdout] test messages::tests::glyph_fallback_is_independent_of_colour ... ok
[INFO] [stdout] test messages::tests::duration_formats_hours ... ok
[INFO] [stdout] test messages::tests::summary_glyphs_fall_back_to_ascii_without_unicode ... ok
[INFO] [stdout] test messages::tests::failure_summary_states_exit_code_and_elapsed ... ok
[INFO] [stdout] test messages::tests::no_summary_without_progress ... ok
[INFO] [stdout] test messages::tests::no_summary_on_signal ... ok
[INFO] [stdout] test messages::tests::the_version_notice_separator_falls_back_to_ascii_too ... ok
[INFO] [stdout] test messages::tests::usage_fatal ... ok
[INFO] [stdout] test messages::tests::version_notice_is_absent_for_an_ordinary_copy ... ok
[INFO] [stdout] test messages::tests::version_notice_is_absent_when_stderr_is_not_a_tty ... ok
[INFO] [stdout] test messages::tests::version_notice_is_plain_when_colour_is_off ... ok
[INFO] [stdout] test messages::tests::version_notice_is_dim_when_colour_is_allowed ... ok
[INFO] [stdout] test messages::tests::success_summary ... ok
[INFO] [stdout] test messages::tests::version_notice_is_separated_by_a_blank_line ... ok
[INFO] [stdout] test messages::tests::version_notice_names_cprog_and_its_repository ... ok
[INFO] [stdout] test plan::tests::all_conditions_met_is_managed ... ok
[INFO] [stdout] test plan::tests::background_job_is_passthrough ... ok
[INFO] [stdout] test plan::tests::ci_is_passthrough ... ok
[INFO] [stdout] test plan::tests::different_terminals_is_passthrough ... ok
[INFO] [stdout] test exit::tests::normal_exit_code_is_preserved ... ok
[INFO] [stdout] test args::tests::plain_files_have_no_flags ... ok
[INFO] [stdout] test args::tests::a_non_utf8_operand_does_not_stop_the_scan ... ok
[INFO] [stdout] test env_knobs::a_non_numeric_knob_falls_back_to_its_default ... ok
[INFO] [stdout] test proc::tests::a_read_fd_above_the_destination_is_ignored ... ok
[INFO] [stdout] test proc::tests::a_regular_file_on_a_stdio_number_is_still_not_a_candidate ... ok
[INFO] [stdout] test proc::tests::inherited_read_fd_is_not_taken_as_the_source ... ok
[INFO] [stdout] test capture::tests::a_real_read_error_ends_the_stdout_relay_too ... ok
[INFO] [stdout] test args::tests::no_args_is_usage_error ... ok
[INFO] [stdout] test args::tests::a_flag_after_an_attached_value_is_still_seen ... ok
[INFO] [stdout] test plan::tests::missing_stdbuf_is_passthrough ... ok
[INFO] [stdout] test proc::tests::inherited_write_fd_is_reported_as_an_extra_candidate ... ok
[INFO] [stdout] test plan::tests::forced_passthrough_wins_over_everything ... ok
[INFO] [stdout] test proc::tests::no_write_fd_means_no_current_file ... ok
[INFO] [stdout] test plan::tests::interactive_forces_passthrough ... ok
[INFO] [stdout] test proc::tests::picks_write_dest_and_read_source ... ok
[INFO] [stdout] test plan::tests::non_linux_is_passthrough ... ok
[INFO] [stdout] test proc::tests::redirected_low_fds_are_not_selected ... ok
[INFO] [stdout] test plan::tests::stderr_not_tty_is_passthrough ... ok
[INFO] [stdout] test proc::tests::special_source_gives_indeterminate_total ... ok
[INFO] [stdout] test plan::tests::stdout_not_tty_is_passthrough ... ok
[INFO] [stdout] test plan::tests::term_dumb_or_unset_is_passthrough ... ok
[INFO] [stdout] test proc::tests::linux_proc_source_classifies_our_open_files ... ok
[INFO] [stdout] test args::tests::help_and_version_are_informational ... ok
[INFO] [stdout] test process::tests::managed_wraps_stdbuf_and_injects_verbose ... ok
[INFO] [stdout] test progress::tests::default_rate_window_is_one_second ... ok
[INFO] [stdout] test process::tests::managed_sets_only_quoting_style_not_locale ... ok
[INFO] [stdout] test progress::tests::eta_unknown_when_rate_unknown ... ok
[INFO] [stdout] test proc::tests::with_both_decoys_present_only_the_read_one_is_excluded_here ... ok
[INFO] [stdout] test process::tests::managed_does_not_double_inject_verbose ... ok
[INFO] [stdout] test progress::tests::eta_unknown_when_total_unknown ... ok
[INFO] [stdout] test process::tests::passthrough_runs_cp_verbatim ... ok
[INFO] [stdout] test progress::tests::eta_from_remaining_over_rate ... ok
[INFO] [stdout] test progress::tests::eta_zero_when_complete ... ok
[INFO] [stdout] test progress::tests::percent_empty_source_is_complete_not_divide_by_zero ... ok
[INFO] [stdout] test proc::tests::no_read_fd_below_the_destination_means_no_source ... ok
[INFO] [stdout] test progress::tests::rate_needs_a_positive_span_not_only_two_samples ... ok
[INFO] [stdout] test progress::tests::rate_unknown_before_two_samples ... ok
[INFO] [stdout] test progress::tests::rate_zero_when_negative_increase ... ok
[INFO] [stdout] test progress::tests::reset_samples_clears_the_rate_history_but_keeps_total ... ok
[INFO] [stdout] test progress::tests::percent_basic_ratio ... ok
[INFO] [stdout] test render::tests::a_tick_redraw_at_the_bottom_row_does_not_scroll ... ok
[INFO] [stdout] test render::tests::a_footer_at_the_bottom_row_survives_the_scroll_it_causes ... ok
[INFO] [stdout] test progress::tests::rate_is_per_second_not_per_window ... ok
[INFO] [stdout] test progress::tests::rate_over_window ... ok
[INFO] [stdout] test render::tests::a_redraw_replaces_both_rows_in_place ... ok
[INFO] [stdout] test progress::tests::rate_zero_when_no_increase ... ok
[INFO] [stdout] test render::tests::an_empty_batch_still_clears_a_stale_footer ... ok
[INFO] [stdout] test process::tests::passthrough_never_touches_env ... ok
[INFO] [stdout] test progress::tests::percent_overshoot_clamps_to_100 ... ok
[INFO] [stdout] test render::tests::drop_erases_even_on_panic ... ok
[INFO] [stdout] test progress::tests::percent_unknown_total_is_indeterminate ... ok
[INFO] [stdout] test render::tests::drop_never_panics_when_the_erase_itself_fails ... ok
[INFO] [stdout] test progress::tests::rate_reflects_recent_window_after_eviction ... ok
[INFO] [stdout] test progress::tests::snapshot_builds_progress_state ... ok
[INFO] [stdout] test progress::tests::without_reset_a_long_stop_drags_the_rate_to_zero ... ok
[INFO] [stdout] test render::tests::cursor_hidden_only_once ... ok
[INFO] [stdout] test render::tests::drained_chunks_are_bracketed_by_one_erase_and_one_draw ... ok
[INFO] [stdout] test render::tests::drop_erases_footer_and_restores_cursor ... ok
[INFO] [stdout] test render::tests::drop_without_footer_writes_nothing ... ok
[INFO] [stdout] test render::tests::partial_log_line_withholds_the_footer ... ok
[INFO] [stdout] test render::tests::redraw_overwrites_in_place ... ok
[INFO] [stdout] test render::tests::split_cp_error_survives_on_screen ... ok
[INFO] [stdout] test render::tests::suspend_restore_shows_cursor_then_redraw_re_hides ... ok
[INFO] [stdout] test render::tests::tick_redraw_is_suppressed_while_a_line_is_pending ... ok
[INFO] [stdout] test render::tests::write_log_erases_then_writes_then_redraws ... ok
[INFO] [stdout] test render::tests::footer_returns_once_the_line_is_finished ... ok
[INFO] [stdout] test sampler::tests::a_paused_destination_is_not_abandoned_for_another_candidate ... ok
[INFO] [stdout] test sampler::tests::a_single_candidate_phase_forgets_the_sizes_it_passed_through ... ok
[INFO] [stdout] test render::tests::line_pending_follows_the_last_chunk_of_a_batch ... ok
[INFO] [stdout] test render::tests::erase_walks_back_exactly_as_far_as_it_drew ... ok
[INFO] [stdout] test render::tests::dropping_the_guard_at_the_bottom_row_clears_only_the_footer ... ok
[INFO] [stdout] test render::tests::erase_is_noop_until_shown ... ok
[INFO] [stdout] test render::tests::two_rows_are_drawn_top_down ... ok
[INFO] [stdout] test render::tests::erasing_two_rows_walks_back_up_to_the_first ... ok
[INFO] [stdout] test sampler::tests::absent_source_gives_indeterminate_total ... ok
[INFO] [stdout] test render::tests::write_log_without_footer_just_erases_and_writes ... ok
[INFO] [stdout] test sampler::tests::an_inherited_read_fd_does_not_become_the_total ... ok
[INFO] [stdout] test sampler::tests::an_idle_phase_forgets_the_sizes_it_passed_through ... ok
[INFO] [stdout] test sampler::tests::a_preallocated_destination_reads_complete_immediately ... ok
[INFO] [stdout] test render::tests::io_failure_is_returned_and_drop_never_panics ... ok
[INFO] [stdout] test sampler::tests::both_inherited_fds_together_still_track_the_real_copy ... ok
[INFO] [stdout] test sampler::tests::a_tie_overrides_the_file_already_being_tracked ... ok
[INFO] [stdout] test sampler::tests::a_real_sparse_file_reports_its_full_logical_size ... ok
[INFO] [stdout] test sampler::tests::idle_then_a_new_file_starts_a_fresh_model ... ok
[INFO] [stdout] test sampler::tests::proc_error_skips_tick ... ok
[INFO] [stdout] test sampler::tests::finished_file_reports_idle_not_skip ... ok
[INFO] [stdout] test sampler::tests::dest_stat_error_skips_tick_and_keeps_model ... ok
[INFO] [stdout] test sampler::tests::growing_candidate_wins_over_an_inherited_write_fd ... ok
[INFO] [stdout] test sampler::tests::equal_growth_keeps_the_candidate_seen_first ... ok
[INFO] [stdout] test sampler::tests::new_file_resets_total ... ok
[INFO] [stdout] test sampler::tests::linux_stat_source_reads_the_real_size ... ok
[INFO] [stdout] test sampler::tests::progress_rises_to_complete ... ok
[INFO] [stdout] test sampler::tests::single_candidate_is_used_without_growth_history ... ok
[INFO] [stdout] test shared_state::a_wait_on_a_stopped_stopper_returns_at_once ... ok
[INFO] [stdout] test sampler::tests::sparse_destination_progress_reaches_completion ... ok
[INFO] [stdout] test sampler::tests::the_biggest_gainer_wins_even_when_it_is_the_inherited_fd ... ok
[INFO] [stdout] test sampler::tests::no_current_file_is_idle ... ok
[INFO] [stdout] test sampler::tests::reset_rate_history_clears_the_current_files_history ... ok
[INFO] [stdout] test shared_state::a_poisoned_mutex_is_recovered_rather_than_fatal ... ok
[INFO] [stdout] test sampler::tests::candidate_tracking_does_not_grow_with_the_number_of_files ... ok
[INFO] [stdout] test slowfile::tests::a_zero_threshold_makes_everything_slow_from_the_first_instant_after_a_pulse ... ok
[INFO] [stdout] test slowfile::tests::a_zero_threshold_still_reports_nothing_before_the_first_pulse ... ok
[INFO] [stdout] test slowfile::tests::before_any_pulse_is_not_slow ... ok
[INFO] [stdout] test slowfile::tests::new_pulse_resets_timer_at_file_boundary ... ok
[INFO] [stdout] test sampler::tests::copied_bytes_are_the_logical_size ... ok
[INFO] [stdout] test teardown_signal_disposition::suspend_reverts_to_default_after_render_loop ... ok
[INFO] [stdout] test term::tests::a_non_terminal_fd_is_treated_as_foreground ... ok
[INFO] [stdout] test term::tests::color_rule ... ok
[INFO] [stdout] test term::tests::same_terminal_fds_matches_itself_and_separates_distinct_files ... ok
[INFO] [stdout] test term::tests::unicode_rule ... ok
[INFO] [stdout] test term::tests::resize_requery_rule ... ok
[INFO] [stdout] test term::tests::same_terminal_requires_both_dev_and_ino ... ok
[INFO] [stdout] test term::tests::the_stdbuf_probe_requires_a_regular_executable_file ... ok
[INFO] [stdout] test ui::name_row_tests::a_long_path_loses_its_front_not_its_tail ... ok
[INFO] [stdout] test ui::name_row_tests::the_ellipsis_follows_the_glyph_style ... ok
[INFO] [stdout] test slowfile::tests::threshold_boundary_is_exclusive ... ok
[INFO] [stdout] test ui::name_row_tests::an_empty_path_stays_empty ... ok
[INFO] [stdout] test ui::name_row_tests::control_characters_are_removed_before_fitting ... ok
[INFO] [stdout] test ui::name_row_tests::a_path_that_fits_is_untouched ... ok
[INFO] [stdout] test term::tests::term_ok_requires_set_and_not_dumb ... ok
[INFO] [stdout] test ui::name_row_tests::a_wide_character_is_never_split_in_half ... ok
[INFO] [stdout] test ui::name_row_tests::a_width_below_the_ellipsis_yields_nothing ... ok
[INFO] [stdout] test ui::tests::bar_ascii_fallback ... ok
[INFO] [stdout] test ui::name_row_tests::truncation_is_by_display_width_not_bytes ... ok
[INFO] [stdout] test ui::tests::bar_fill_proportional ... ok
[INFO] [stdout] test shared_state::stopping_twice_is_harmless ... ok
[INFO] [stdout] test ui::tests::bar_indeterminate_is_not_fake_full ... ok
[INFO] [stdout] test ui::tests::bar_width_is_stable_as_the_eta_text_changes ... ok
[INFO] [stdout] test ui::tests::bar_snaps_to_largest_divisor_of_100 ... ok
[INFO] [stdout] test ui::tests::eta_formats_mmss_hhmmss_and_unknown ... ok
[INFO] [stdout] test ui::tests::footer_for_respects_size_suppression ... ok
[INFO] [stdout] test ui::tests::footer_for_shown_when_slow_with_state ... ok
[INFO] [stdout] test ui::tests::a_layout_that_exactly_fits_is_not_shed ... ok
[INFO] [stdout] test ui::tests::colored_footer_visible_width_fits_terminal ... ok
[INFO] [stdout] test ui::tests::a_rate_too_wide_for_the_field_overflows_rather_than_truncating ... ok
[INFO] [stdout] test ui::tests::rate_saturates_at_the_largest_unit ... ok
[INFO] [stdout] test ui::tests::percent_formats_two_decimals_right_aligned ... ok
[INFO] [stdout] test ui::tests::rate_field_is_constant_width ... ok
[INFO] [stdout] test ui::tests::footer_for_hidden_when_no_state_is_published ... ok
[INFO] [stdout] test ui::tests::size_pair_adapts_unit_to_total ... ok
[INFO] [stdout] test ui::tests::size_saturates_at_the_largest_unit ... ok
[INFO] [stdout] test ui::tests::very_narrow_keeps_only_percent ... ok
[INFO] [stdout] test ui::tests::rate_scales_units_and_unknown ... ok
[INFO] [stdout] test ui::tests::bar_color_wraps_fill_in_green ... ok
[INFO] [stdout] test ui::tests::wide_terminal_shows_all_fields ... ok
[INFO] [stdout] test ui::tests::bar_floors_uniformly_full_only_at_100 ... ok
[INFO] [stdout] test ui::tests::eta_stays_in_one_column_as_the_numbers_change ... ok
[INFO] [stdout] test ui::tests::the_footer_fits_the_terminal_down_to_the_last_resort ... ok
[INFO] [stdout] test ui::tests::shedding_respects_survival_priority_across_widths ... ok
[INFO] [stdout] test verbose::tests::single_complete_line_is_one_pulse ... ok
[INFO] [stdout] test verbose::tests::trailing_partial_after_completed_line_is_held ... ok
[INFO] [stdout] test verbose::tests::arbitrary_bytes_only_newlines_count ... ok
[INFO] [stdout] test ui::tests::the_size_field_is_constant_width_while_the_total_holds ... ok
[INFO] [stdout] test term::tests::terminal_size_of_a_non_terminal_is_none ... ok
[INFO] [stdout] test verbose::tests::multiple_lines_in_one_chunk ... ok
[INFO] [stdout] test verbose::tests::newline_split_across_chunks_pulses_when_completed ... ok
[INFO] [stdout] test ui::tests::footer_suppressed_when_terminal_too_short ... ok
[INFO] [stdout] test capture::tests::dropping_the_receiver_releases_a_blocked_relay ... ok
[INFO] [stdout] test capture::tests::a_full_queue_makes_the_relay_wait_rather_than_buffer ... ok
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/release/build/cp-progress/75478d35bb8d107f/out/cprog-75478d35bb8d107f)
[INFO] [stdout] test shared_state::a_wait_that_is_never_stopped_times_out_and_says_so ... ok
[INFO] [stdout] test shared_state::stopping_wakes_a_thread_already_waiting ... ok
[INFO] [stdout] test capture::tests::dropping_the_receiver_releases_a_blocked_stdout_relay ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 219 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/background.rs (/opt/rustwide/target/release/build/cp-progress/f9771d0d9c7037a3/out/background-f9771d0d9c7037a3)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running tests/exit_contract.rs (/opt/rustwide/target/release/build/cp-progress/488290b136d85474/out/exit_contract-488290b136d85474)
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test usage_exit_code_survives_a_broken_stderr_pipe ... ok
[INFO] [stdout] test failed_exec_with_broken_stderr_still_exits_127 ... ok
[INFO] [stdout] test missing_cp_is_fatal_cpspawn_exit_127 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/fallback.rs (/opt/rustwide/target/release/build/cp-progress/7819782e06123e81/out/fallback-7819782e06123e81)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/forced_passthrough.rs (/opt/rustwide/target/release/build/cp-progress/e2b4293339d638f5/out/forced_passthrough-e2b4293339d638f5)
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/harness.rs (/opt/rustwide/target/release/build/cp-progress/2908219f2613d5f1/out/harness-2908219f2613d5f1)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running tests/log_integrity.rs (/opt/rustwide/target/release/build/cp-progress/6d6b89ee4fdaa776/out/log_integrity-6d6b89ee4fdaa776)
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/managed.rs (/opt/rustwide/target/release/build/cp-progress/3b070f893e557f0b/out/managed-3b070f893e557f0b)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/passthrough.rs (/opt/rustwide/target/release/build/cp-progress/5b1f5e18d586fb46/out/passthrough-5b1f5e18d586fb46)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/quiet.rs (/opt/rustwide/target/release/build/cp-progress/f75e74417d8950f1/out/quiet-f75e74417d8950f1)
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/resize.rs (/opt/rustwide/target/release/build/cp-progress/19900b4295bcc91f/out/resize-19900b4295bcc91f)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/signals.rs (/opt/rustwide/target/release/build/cp-progress/ce097c18a884ace6/out/signals-ce097c18a884ace6)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/suspend.rs (/opt/rustwide/target/release/build/cp-progress/60c3e6ce3dcecc38/out/suspend-60c3e6ce3dcecc38)
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests cprog
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "3ee59f696d4b8ba72f87f367b37553952750f12013ee9280478aecf642928813", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3ee59f696d4b8ba72f87f367b37553952750f12013ee9280478aecf642928813", kill_on_drop: false }`
[INFO] [stdout] 3ee59f696d4b8ba72f87f367b37553952750f12013ee9280478aecf642928813
