[INFO] fetching crate sonora-aec3 0.1.0...
[INFO] testing sonora-aec3-0.1.0 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-2
[INFO] extracting crate sonora-aec3 0.1.0 into /workspace/builds/worker-0-tc2/source
[INFO] started tweaking crates.io crate sonora-aec3 0.1.0
[INFO] finished tweaking crates.io crate sonora-aec3 0.1.0
[INFO] tweaked toml for crates.io crate sonora-aec3 0.1.0 written to /workspace/builds/worker-0-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate sonora-aec3 0.1.0 on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate sonora-aec3 0.1.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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 6c4c2a3532ba2960f70ad6a28f538a65951e75c34991a46311bbd8a031ef3378
[INFO] running `Command { std: "docker" "start" "-a" "6c4c2a3532ba2960f70ad6a28f538a65951e75c34991a46311bbd8a031ef3378", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "6c4c2a3532ba2960f70ad6a28f538a65951e75c34991a46311bbd8a031ef3378", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6c4c2a3532ba2960f70ad6a28f538a65951e75c34991a46311bbd8a031ef3378", kill_on_drop: false }`
[INFO] [stdout] 6c4c2a3532ba2960f70ad6a28f538a65951e75c34991a46311bbd8a031ef3378
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ddbf1abd4983f6a20fcce23993ecad2969cd1b52ffb0f4ff577666c3caba4ab8
[INFO] running `Command { std: "docker" "start" "-a" "ddbf1abd4983f6a20fcce23993ecad2969cd1b52ffb0f4ff577666c3caba4ab8", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.23
[INFO] [stderr]    Compiling sonora-fft v0.1.0
[INFO] [stderr]    Compiling sonora-simd v0.1.0
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling derive_more-impl v2.1.1
[INFO] [stderr]    Compiling derive_more v2.1.1
[INFO] [stderr]    Compiling sonora-common-audio v0.1.0
[INFO] [stderr]    Compiling sonora-aec3 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 7.95s
[INFO] running `Command { std: "docker" "inspect" "ddbf1abd4983f6a20fcce23993ecad2969cd1b52ffb0f4ff577666c3caba4ab8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ddbf1abd4983f6a20fcce23993ecad2969cd1b52ffb0f4ff577666c3caba4ab8", kill_on_drop: false }`
[INFO] [stdout] ddbf1abd4983f6a20fcce23993ecad2969cd1b52ffb0f4ff577666c3caba4ab8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7c5811023f513cf55d8d36f4da5c9192b569403bb6f52c43555c3c11865415d9
[INFO] running `Command { std: "docker" "start" "-a" "7c5811023f513cf55d8d36f4da5c9192b569403bb6f52c43555c3c11865415d9", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.181
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling zerocopy v0.8.39
[INFO] [stderr]    Compiling regex-syntax v0.8.9
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling getrandom v0.4.1
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling tempfile v3.25.0
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling structmeta-derive v0.3.0
[INFO] [stderr]    Compiling derive_more-impl v2.1.1
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling proptest v1.10.0
[INFO] [stderr]    Compiling structmeta v0.3.0
[INFO] [stderr]    Compiling derive-ex v0.1.8
[INFO] [stderr]    Compiling derive_more v2.1.1
[INFO] [stderr]    Compiling sonora-common-audio v0.1.0
[INFO] [stderr]    Compiling sonora-aec3 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling test-strategy v0.4.4
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 17.86s
[INFO] running `Command { std: "docker" "inspect" "7c5811023f513cf55d8d36f4da5c9192b569403bb6f52c43555c3c11865415d9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7c5811023f513cf55d8d36f4da5c9192b569403bb6f52c43555c3c11865415d9", kill_on_drop: false }`
[INFO] [stdout] 7c5811023f513cf55d8d36f4da5c9192b569403bb6f52c43555c3c11865415d9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] deece56c26eb2eccd9fca0ab1bd5afed599d276f0e3163f55d3c4f846a957eea
[INFO] running `Command { std: "docker" "start" "-a" "deece56c26eb2eccd9fca0ab1bd5afed599d276f0e3163f55d3c4f846a957eea", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.09s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/sonora_aec3-5e0c6f30c168d778)
[INFO] [stdout] 
[INFO] [stdout] running 172 tests
[INFO] [stdout] test adaptive_fir_filter::tests::adapt_partitions_complex_multiply ... ok
[INFO] [stdout] test adaptive_fir_filter::tests::adapt_partitions_simd_matches_scalar ... ok
[INFO] [stdout] test adaptive_fir_filter::tests::apply_filter_accumulates ... ok
[INFO] [stdout] test adaptive_fir_filter::tests::compute_frequency_response_multichannel_takes_max ... ok
[INFO] [stdout] test adaptive_fir_filter::tests::compute_frequency_response_basic ... ok
[INFO] [stdout] test adaptive_fir_filter::tests::constrain_does_not_panic ... ok
[INFO] [stdout] test adaptive_fir_filter::tests::filter_size ... ok
[INFO] [stdout] test adaptive_fir_filter::tests::filter_size_change_immediate ... ok
[INFO] [stdout] test adaptive_fir_filter::tests::filter_and_adapt_basic ... ok
[INFO] [stdout] test adaptive_fir_filter::tests::apply_filter_simd_matches_scalar ... ok
[INFO] [stdout] test adaptive_fir_filter::tests::scale_filter_works ... ok
[INFO] [stdout] test adaptive_fir_filter_erl::tests::compute_erl_simd_matches_scalar ... ok
[INFO] [stdout] test adaptive_fir_filter::tests::impulse_response_update ... ok
[INFO] [stdout] test adaptive_fir_filter_erl::tests::erl_sums_partitions ... ok
[INFO] [stdout] test aec3_fft::tests::fft_impulse ... ok
[INFO] [stdout] test aec3_fft::tests::ifft_all_ones_re ... ok
[INFO] [stdout] test aec3_fft::tests::ifft_all_zeros ... ok
[INFO] [stdout] test aec_state::tests::capture_saturation_flag ... ok
[INFO] [stdout] test aec3_fft::tests::fft_dc ... ok
[INFO] [stdout] test aec_state::tests::initial_state_is_not_usable ... ok
[INFO] [stdout] test aec3_fft::tests::zero_padded_fft_rectangular ... ok
[INFO] [stdout] test block_processor::tests::get_metrics_returns_values ... ok
[INFO] [stdout] test aec3_fft::tests::padded_fft_rectangular ... ok
[INFO] [stdout] test aec3_fft::tests::ifft_dc_only ... ok
[INFO] [stdout] test aec3_fft::tests::fft_all_zeros ... ok
[INFO] [stdout] test block_processor::tests::set_audio_buffer_delay ... ok
[INFO] [stdout] test adaptive_fir_filter::tests::compute_frequency_response_simd_matches_scalar ... ok
[INFO] [stdout] test block_processor::tests::set_capture_output_usage ... ok
[INFO] [stdout] test api_call_jitter_metrics::tests::jitter_peak_capture ... ok
[INFO] [stdout] test aec3_fft::tests::fft_and_ifft_roundtrip ... ok
[INFO] [stdout] test block_processor_metrics::tests::normal_usage ... ok
[INFO] [stdout] test api_call_jitter_metrics::tests::jitter_peak_render ... ok
[INFO] [stdout] test common::tests::fast_approx_log2f_reasonable ... ok
[INFO] [stdout] test coarse_filter_update_gain::tests::echo_path_change_resets ... ok
[INFO] [stdout] test common::tests::fft_length_by2_log2_consistent ... ok
[INFO] [stdout] test clockdrift_detector::tests::clockdrift_detector ... ok
[INFO] [stdout] test coarse_filter_update_gain::tests::gain_nonzero_after_warmup ... ok
[INFO] [stdout] test coarse_filter_update_gain::tests::saturation_zeros_gain ... ok
[INFO] [stdout] test common::tests::block_size_log2_consistent ... ok
[INFO] [stdout] test common::tests::log2_to_db_conversion ... ok
[INFO] [stdout] test common::tests::num_bands_for_known_rates ... ok
[INFO] [stdout] test common::tests::valid_rates ... ok
[INFO] [stdout] test config::tests::out_of_range_values_are_clamped ... ok
[INFO] [stdout] test echo_remover::tests::signal_transition_crossfade ... ok
[INFO] [stdout] test echo_remover::tests::update_echo_leakage_status ... ok
[INFO] [stdout] test echo_remover::tests::set_capture_output_usage ... ok
[INFO] [stdout] test echo_path_variability::tests::correct_behavior ... ok
[INFO] [stdout] test echo_remover_metrics::tests::db_metric_constructor ... ok
[INFO] [stdout] test echo_remover_metrics::tests::db_metric_default ... ok
[INFO] [stdout] test echo_remover_metrics::tests::db_metric_update_instant ... ok
[INFO] [stdout] test echo_remover::tests::signal_transition_same_buffer ... ok
[INFO] [stdout] test block_processor::tests::basic_setup_and_api_calls ... ok
[INFO] [stdout] test adaptive_fir_filter::tests::adapt_partitions_updates_h ... ok
[INFO] [stdout] test adaptive_fir_filter_erl::tests::erl_empty_partitions ... ok
[INFO] [stdout] test adaptive_fir_filter_erl::tests::erl_single_partition ... ok
[INFO] [stdout] test fft_data::tests::assign_copies_and_zeros_dc_nyquist_im ... ok
[INFO] [stdout] test fft_data::tests::clear_zeros_everything ... ok
[INFO] [stdout] test fft_data::tests::copy_to_packed_array ... ok
[INFO] [stdout] test fft_data::tests::roundtrip_packed ... ok
[INFO] [stdout] test fft_data::tests::spectrum_scalar ... ok
[INFO] [stdout] test filter_analyzer::tests::filter_resize ... ok
[INFO] [stdout] test fft_data::tests::copy_from_packed_array ... ok
[INFO] [stdout] test fullband_erle_estimator::tests::quality_estimate_available_after_updates ... ok
[INFO] [stdout] test fullband_erle_estimator::tests::creation_and_reset ... ok
[INFO] [stdout] test fullband_erle_estimator::tests::unconverged_filter_does_not_update ... ok
[INFO] [stdout] test fullband_erle_estimator::tests::erle_increases_with_echo ... ok
[INFO] [stdout] test matched_filter::tests::matched_filter_core_accumulated_error ... ok
[INFO] [stdout] test matched_filter::tests::matched_filter_max_lag ... ok
[INFO] [stdout] test matched_filter::tests::matched_filter_reset ... ok
[INFO] [stdout] test echo_remover::tests::get_metrics_initial ... ok
[INFO] [stdout] test matched_filter::tests::matched_filter_core_dispatch_scalar_identical ... ok
[INFO] [stdout] test moving_average::tests::average_with_memory ... ok
[INFO] [stdout] test moving_average::tests::pass_through_with_mem_len_1 ... ok
[INFO] [stdout] test frame_blocker::tests::block_bitexactness ... ok
[INFO] [stdout] test multi_channel_content_detector::tests::detection_disabled_with_flag ... ok
[INFO] [stdout] test multi_channel_content_detector::tests::mono_input_not_detected_as_stereo ... ok
[INFO] [stdout] test multi_channel_content_detector::tests::single_channel_not_detected ... ok
[INFO] [stdout] test multi_channel_content_detector::tests::temporary_detection_when_not_persistent ... ok
[INFO] [stdout] test multi_channel_content_detector::tests::timeout_resets_detection ... ok
[INFO] [stdout] test nearend_detector::tests::dominant_detects_strong_nearend ... ok
[INFO] [stdout] test nearend_detector::tests::dominant_initially_not_nearend ... ok
[INFO] [stdout] test multi_channel_content_detector::tests::stereo_content_detected_after_hysteresis ... ok
[INFO] [stdout] test nearend_detector::tests::subband_initially_not_nearend ... ok
[INFO] [stdout] test refined_filter_update_gain::tests::echo_path_change_resets_h_error ... ok
[INFO] [stdout] test multi_channel_content_detector::tests::threshold_filters_small_differences ... ok
[INFO] [stdout] test refined_filter_update_gain::tests::gain_nonzero_after_warmup ... ok
[INFO] [stdout] test render_buffer::tests::headroom_calculation ... ok
[INFO] [stdout] test render_buffer::tests::spectral_sum_accumulates_all_channels ... ok
[INFO] [stdout] test render_buffer::tests::spectral_sums_shorter_is_prefix_of_longer ... ok
[INFO] [stdout] test render_delay_buffer::tests::align_from_delay_returns_changed ... ok
[INFO] [stdout] test refined_filter_update_gain::tests::saturation_zeros_gain ... ok
[INFO] [stdout] test frame_blocker::tests::blocker_and_framer ... ok
[INFO] [stdout] test render_delay_buffer::tests::max_delay_respects_headroom ... ok
[INFO] [stdout] test render_delay_buffer::tests::basic_insert_and_prepare ... ok
[INFO] [stdout] test multi_channel_content_detector::tests::no_timeout_keeps_persistent ... ok
[INFO] [stdout] test render_delay_buffer::tests::render_buffer_view_accessible ... ok
[INFO] [stdout] test render_signal_analyzer::tests::mask_regions_with_no_narrow_bands ... ok
[INFO] [stdout] test render_signal_analyzer::tests::no_narrow_bands_initially ... ok
[INFO] [stdout] test render_signal_analyzer::tests::update_without_delay_resets_counters ... ok
[INFO] [stdout] test residual_echo_estimator::tests::creation_and_reset ... ok
[INFO] [stdout] test residual_echo_estimator::tests::echo_path_gain_transparent_vs_normal ... ok
[INFO] [stdout] test residual_echo_estimator::tests::noise_gate_reduces_power ... ok
[INFO] [stdout] test residual_echo_estimator::tests::nonlinear_estimate_produces_output ... ok
[INFO] [stdout] test reverb_decay_estimator::tests::decay_returns_configured_value ... ok
[INFO] [stdout] test reverb_decay_estimator::tests::early_reverb_estimator_returns_zero_with_insufficient_sections ... ok
[INFO] [stdout] test render_delay_buffer::tests::set_audio_buffer_delay ... ok
[INFO] [stdout] test reverb_decay_estimator::tests::stationary_signal_skips_update ... ok
[INFO] [stdout] test reverb_frequency_response::tests::conservative_mode_uses_max ... ok
[INFO] [stdout] test api_call_jitter_metrics::tests::constant_jitter ... ok
[INFO] [stdout] test reverb_frequency_response::tests::stationary_block_skips_update ... ok
[INFO] [stdout] test matched_filter::tests::matched_filter_core_converges ... ok
[INFO] [stdout] test reverb_frequency_response::tests::update_produces_nonzero_response ... ok
[INFO] [stdout] test reverb_model::tests::initial_reverb_is_zero ... ok
[INFO] [stdout] test reverb_model::tests::per_frequency_scaling_applied ... ok
[INFO] [stdout] test reverb_decay_estimator::tests::linear_regressor_basic ... ok
[INFO] [stdout] test reverb_model::tests::reset_clears_state ... ok
[INFO] [stdout] test reverb_model::tests::no_update_when_decay_is_zero ... ok
[INFO] [stdout] test reverb_model::tests::reverb_accumulates_with_decay ... ok
[INFO] [stdout] test reverb_model_estimator::tests::creation_with_multiple_channels ... ok
[INFO] [stdout] test reverb_model_estimator::tests::update_with_stationary_signal ... ok
[INFO] [stdout] test reverb_frequency_response::tests::initial_response_is_zero ... ok
[INFO] [stdout] test stationarity_estimator::tests::initial_state_is_not_stationary ... ok
[INFO] [stdout] test stationarity_estimator::tests::noise_update_increases_from_initial ... ok
[INFO] [stdout] test stationarity_estimator::tests::reset_clears_state ... ok
[INFO] [stdout] test matched_filter::tests::matched_filter_core_simd_matches_scalar ... ok
[INFO] [stdout] test signal_dependent_erle_estimator::tests::longer_run ... ok
[INFO] [stdout] test stationarity_estimator::tests::noise_spectrum_initializes_to_min_power ... ok
[INFO] [stdout] test matched_filter::tests::max_square_peak_index_correctness ... ok
[INFO] [stdout] test subband_erle_estimator::tests::erle_starts_at_min ... ok
[INFO] [stdout] test subband_erle_estimator::tests::erle_increases_with_echo_signal ... ok
[INFO] [stdout] test subtractor::tests::handle_echo_path_change_delay ... ok
[INFO] [stdout] test subband_erle_estimator::tests::reset_restores_initial_state ... ok
[INFO] [stdout] test subtractor::tests::filter_misadjustment_estimator_basic ... ok
[INFO] [stdout] test signal_dependent_erle_estimator::tests::sweep_settings ... ok
[INFO] [stdout] test subtractor::tests::exit_initial_state_does_not_panic ... ok
[INFO] [stdout] test subtractor::tests::subtractor_creation ... ok
[INFO] [stdout] test subtractor::tests::handle_echo_path_change_gain ... ok
[INFO] [stdout] test subtractor_output::tests::compute_metrics_sums_of_squares ... ok
[INFO] [stdout] test subtractor_output_analyzer::tests::divergence_detection ... ok
[INFO] [stdout] test subtractor_output_analyzer::tests::handle_echo_path_change_resets ... ok
[INFO] [stdout] test subtractor_output_analyzer::tests::initial_state_not_converged ... ok
[INFO] [stdout] test suppression_filter::tests::comfort_noise_in_unity_gain ... ok
[INFO] [stdout] test subtractor_output_analyzer::tests::convergence_detection ... ok
[INFO] [stdout] test subtractor::tests::process_single_block ... ok
[INFO] [stdout] test subtractor_output::tests::compute_metrics_max_abs_handles_negatives ... ok
[INFO] [stdout] test suppression_gain::tests::initial_gain_is_transparent ... ok
[INFO] [stdout] test suppression_gain::tests::low_noise_detector_high_power_not_low ... ok
[INFO] [stdout] test transparent_mode::tests::disabled_when_bounded_erl ... ok
[INFO] [stdout] test suppression_filter::tests::signal_suppression ... ok
[INFO] [stdout] test transparent_mode::tests::enabled_when_not_bounded_erl ... ok
[INFO] [stdout] test transparent_mode::tests::hmm_activates_without_convergence ... ok
[INFO] [stdout] test transparent_mode::tests::hmm_creates_via_config ... ok
[INFO] [stdout] test transparent_mode::tests::hmm_deactivates_with_convergence ... ok
[INFO] [stdout] test transparent_mode::tests::hmm_initial_state_not_active ... ok
[INFO] [stdout] test transparent_mode::tests::hmm_no_update_without_active_render ... ok
[INFO] [stdout] test transparent_mode::tests::legacy_initial_state_not_active ... ok
[INFO] [stdout] test vector_math::tests::sqrt_matches_scalar ... ok
[INFO] [stdout] test suppression_filter::tests::delay ... ok
[INFO] [stdout] test subtractor::tests::subtractor_multichannel_creation ... ok
[INFO] [stdout] test reverb_decay_estimator::tests::mild_decay_returns_nearend_len ... ok
[INFO] [stdout] test transparent_mode::tests::hmm_reset_restores_initial_state ... ok
[INFO] [stdout] test subband_erle_estimator::tests::erle_bounded_by_max ... ok
[INFO] [stdout] test refined_filter_update_gain::tests::h_error_clamped_to_bounds ... ok
[INFO] [stdout] test suppression_filter::tests::signal_transparency ... ok
[INFO] [stdout] test matched_filter::tests::max_square_peak_index_random ... ok
[INFO] [stdout] test matched_filter_lag_aggregator::tests::lag_estimate_invariance_required_for_aggregated_lag ... ok
[INFO] [stdout] test erl_estimator::tests::estimates ... ok
[INFO] [stdout] test decimator::tests::no_leakage_from_upper_frequencies ... ok
[INFO] [stdout] test render_delay_buffer::tests::buffer_overflow ... ok
[INFO] [stdout] test comfort_noise_generator::tests::correct_level ... ok
[INFO] [stdout] test echo_remover::tests::basic_api_calls ... ok
[INFO] [stdout] test block_processor::tests::test_longer_call ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 172 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 7.24s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests sonora_aec3
[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" "deece56c26eb2eccd9fca0ab1bd5afed599d276f0e3163f55d3c4f846a957eea", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "deece56c26eb2eccd9fca0ab1bd5afed599d276f0e3163f55d3c4f846a957eea", kill_on_drop: false }`
[INFO] [stdout] deece56c26eb2eccd9fca0ab1bd5afed599d276f0e3163f55d3c4f846a957eea