[INFO] fetching crate resonant-fft 0.4.0...
[INFO] testing resonant-fft-0.4.0 against 1.99.0-beta.8 for beta-1.100-2
[INFO] extracting crate resonant-fft 0.4.0 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate resonant-fft 0.4.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate resonant-fft 0.4.0
[INFO] tweaked toml for crates.io crate resonant-fft 0.4.0 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate resonant-fft 0.4.0 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate resonant-fft 0.4.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.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded resonant-core v0.4.0
[INFO] [stderr]   Downloaded transpose v0.2.3
[INFO] [stderr]   Downloaded primal-check v0.3.4
[INFO] [stderr]   Downloaded strength_reduce v0.2.4
[INFO] [stderr]   Downloaded rustfft v6.4.1
[INFO] [stderr]   Downloaded web-sys v0.3.91
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 6084e9e3c0dc84f19811b482ee7c02d6619eb33815692ce800e07ef170240c2b
[INFO] running `Command { std: "docker" "start" "6084e9e3c0dc84f19811b482ee7c02d6619eb33815692ce800e07ef170240c2b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "6084e9e3c0dc84f19811b482ee7c02d6619eb33815692ce800e07ef170240c2b", 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" "6084e9e3c0dc84f19811b482ee7c02d6619eb33815692ce800e07ef170240c2b" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "6084e9e3c0dc84f19811b482ee7c02d6619eb33815692ce800e07ef170240c2b", 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" "6084e9e3c0dc84f19811b482ee7c02d6619eb33815692ce800e07ef170240c2b" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling strength_reduce v0.2.4
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling resonant-core v0.4.0
[INFO] [stderr]    Compiling transpose v0.2.3
[INFO] [stderr]    Compiling primal-check v0.3.4
[INFO] [stderr]    Compiling rustfft v6.4.1
[INFO] [stderr]    Compiling resonant-fft v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 18.35s
[INFO] running `Command { std: "docker" "inspect" "6084e9e3c0dc84f19811b482ee7c02d6619eb33815692ce800e07ef170240c2b", 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" "6084e9e3c0dc84f19811b482ee7c02d6619eb33815692ce800e07ef170240c2b" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling quote v1.0.45
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling zerocopy v0.8.48
[INFO] [stderr]    Compiling libc v0.2.183
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.18
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling crossbeam-deque v0.8.6
[INFO] [stderr]    Compiling criterion-plot v0.5.0
[INFO] [stderr]    Compiling rayon-core v1.13.0
[INFO] [stderr]    Compiling is-terminal v0.4.17
[INFO] [stderr]    Compiling rayon v1.11.0
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling clap v4.6.0
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling zerocopy-derive v0.8.48
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling criterion v0.5.1
[INFO] [stderr]    Compiling resonant-fft v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 53.04s
[INFO] running `Command { std: "docker" "inspect" "6084e9e3c0dc84f19811b482ee7c02d6619eb33815692ce800e07ef170240c2b", 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" "6084e9e3c0dc84f19811b482ee7c02d6619eb33815692ce800e07ef170240c2b" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/resonant_fft-3d636fdb197d13c7)
[INFO] [stdout] 
[INFO] [stdout] running 88 tests
[INFO] [stdout] test dct::tests::dct_ii_dc_signal ... ok
[INFO] [stdout] test dct::tests::round_trip_dct_ii_iii ... ok
[INFO] [stdout] test dct::tests::round_trip_larger ... ok
[INFO] [stdout] test dct::tests::dct_ii_empty_returns_error ... ok
[INFO] [stdout] test dct::tests::dct_ii_length_mismatch ... ok
[INFO] [stdout] test dct::tests::dct_ii_linearity ... ok
[INFO] [stdout] test dct::tests::dct_ii_single_element ... ok
[INFO] [stdout] test dct::tests::dct_iii_single_element ... ok
[INFO] [stdout] test ext::tests::fft_empty_returns_error ... ok
[INFO] [stdout] test ext::tests::fft_ifft_roundtrip ... ok
[INFO] [stdout] test dct::tests::dct_ii_known_two_point ... ok
[INFO] [stdout] test ext::tests::fft_time_to_freq_domain ... ok
[INFO] [stdout] test ext::tests::fft_works_with_array ... ok
[INFO] [stdout] test ext::tests::fft_works_with_slice ... ok
[INFO] [stdout] test ext::tests::rfft_compile_fail_on_freq_domain ... ok
[INFO] [stdout] test ext::tests::rfft_ext_empty_returns_error ... ok
[INFO] [stdout] test ext::tests::rfft_ext_returns_half_spectrum ... ok
[INFO] [stdout] test ext::tests::ifft_freq_to_time_domain ... ok
[INFO] [stdout] test ext::tests::magnitude_of_dc_signal ... ok
[INFO] [stdout] test ext::tests::magnitude_squared_avoids_sqrt ... ok
[INFO] [stdout] test phase_vocoder::tests::accessors_return_correct_values ... ok
[INFO] [stdout] test ext::tests::rfft_magnitude_matches_complex_fft_magnitude ... ok
[INFO] [stdout] test phase_vocoder::tests::continuous_tone_phase_increments_by_expected_advance_per_frame ... ok
[INFO] [stdout] test phase_vocoder::tests::dc_bin_phase_stays_zero_with_constant_zero_input ... ok
[INFO] [stdout] test phase_vocoder::tests::new_non_power_of_two_returns_error ... ok
[INFO] [stdout] test ext::tests::phase_of_dc_signal ... ok
[INFO] [stdout] test phase_vocoder::tests::new_power_of_two_succeeds ... ok
[INFO] [stdout] test phase_vocoder::tests::new_zero_fft_size_returns_error ... ok
[INFO] [stdout] test ext::tests::rfft_ext_dc_signal ... ok
[INFO] [stdout] test phase_vocoder::tests::process_frame_passes_magnitudes_through ... ok
[INFO] [stdout] test phase_vocoder::tests::reset_restores_initial_state ... ok
[INFO] [stdout] test phase_vocoder::tests::stretch_half_gives_half_synthesis_hop ... ok
[INFO] [stdout] test radix2::tests::fft_dc_signal ... ok
[INFO] [stdout] test radix2::tests::fft_impulse ... ok
[INFO] [stdout] test radix2::tests::fft_empty_returns_error ... ok
[INFO] [stdout] test radix2::tests::fft_error_display ... ok
[INFO] [stdout] test radix2::tests::fft_known_4point ... ok
[INFO] [stdout] test radix2::tests::fft_large_power_of_two ... ok
[INFO] [stdout] test radix2::tests::fft_non_power_of_two_returns_error ... ok
[INFO] [stdout] test radix2::tests::ifft_empty_returns_error ... ok
[INFO] [stdout] test radix2::tests::fft_single_element ... ok
[INFO] [stdout] test radix2::tests::fft_two_elements ... ok
[INFO] [stdout] test rfft::tests::irfft_wrong_output_length_returns_error ... ok
[INFO] [stdout] test phase_vocoder::tests::principal_argument_wraps_correctly ... ok
[INFO] [stdout] test radix2::tests::roundtrip_8point ... ok
[INFO] [stdout] test rfft::tests::irfft_empty_returns_error ... ok
[INFO] [stdout] test rfft::tests::rfft_dc_signal ... ok
[INFO] [stdout] test rfft::tests::rfft_empty_returns_error ... ok
[INFO] [stdout] test rfft::tests::rfft_matches_complex_fft_dc_bins ... ok
[INFO] [stdout] test rfft::tests::rfft_non_power_of_two_returns_error ... ok
[INFO] [stdout] test rfft::tests::rfft_nyquist_bin_is_real ... ok
[INFO] [stdout] test rfft::tests::rfft_wrong_output_length_returns_error ... ok
[INFO] [stdout] test rfft::tests::rfft_single_frequency ... ok
[INFO] [stdout] test rfft::tests::roundtrip_256point ... ok
[INFO] [stdout] test rfft::tests::roundtrip_2point ... ok
[INFO] [stdout] test rfft::tests::roundtrip_4point ... ok
[INFO] [stdout] test rfft::tests::roundtrip_8point ... ok
[INFO] [stdout] test radix2::tests::ifft_inverts_fft ... ok
[INFO] [stdout] test radix2::tests::ifft_non_power_of_two_returns_error ... ok
[INFO] [stdout] test rustfft_backend::tests::fft_dc_signal ... ok
[INFO] [stdout] test rustfft_backend::tests::plan_reuse ... ok
[INFO] [stdout] test rustfft_backend::tests::fft_empty_returns_error ... ok
[INFO] [stdout] test rustfft_backend::tests::ifft_empty_returns_error ... ok
[INFO] [stdout] test rustfft_backend::tests::impulse_flat_spectrum ... ok
[INFO] [stdout] test rustfft_backend::tests::plan_wrong_length ... ok
[INFO] [stdout] test rustfft_backend::tests::roundtrip_non_power_of_two ... ok
[INFO] [stdout] test rustfft_backend::tests::roundtrip_power_of_two ... ok
[INFO] [stdout] test simd::tests::magnitude_basic ... ok
[INFO] [stdout] test simd::tests::magnitude_squared_basic ... ok
[INFO] [stdout] test simd::tests::magnitude_empty ... ok
[INFO] [stdout] test simd::tests::magnitude_matches_scalar ... ok
[INFO] [stdout] test simd::tests::magnitude_squared_matches_scalar ... ok
[INFO] [stdout] test stft::tests::analyze_empty_returns_error ... ok
[INFO] [stdout] test stft::tests::analyze_frame_size_matches_window ... ok
[INFO] [stdout] test stft::tests::analyze_produces_correct_frame_count ... ok
[INFO] [stdout] test stft::tests::analyze_shorter_than_window_returns_empty ... ok
[INFO] [stdout] test stft::tests::roundtrip_no_window ... ok
[INFO] [stdout] test stft::tests::single_frame_roundtrip ... ok
[INFO] [stdout] test stft::tests::with_window_function ... ok
[INFO] [stdout] test radix2::tests::parseval_theorem ... ok
[INFO] [stdout] test stft::tests::accessors ... ok
[INFO] [stdout] test stft::tests::synthesize_empty_frames ... ok
[INFO] [stdout] test dct::tests::dct_iii_empty_returns_error ... ok
[INFO] [stdout] test rfft::tests::rfft_conjugate_symmetry_matches_full_fft ... ok
[INFO] [stdout] test rustfft_backend::tests::fft_3point_dc ... ok
[INFO] [stdout] test stft::tests::hop_larger_than_window_panics - should panic ... ok
[INFO] [stdout] test stft::tests::zero_window_panics - should panic ... ok
[INFO] [stdout] test stft::tests::zero_hop_panics - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 88 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.12s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/radix2.rs (/opt/rustwide/target/debug/deps/radix2-40c142a5f3a09270)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test dc_signal_produces_impulse_spectrum ... ok
[INFO] [stdout] test error_on_empty ... ok
[INFO] [stdout] test impulse_produces_flat_spectrum ... ok
[INFO] [stdout] test forward_then_inverse_roundtrip ... ok
[INFO] [stdout] test error_on_non_power_of_two ... ok
[INFO] [stdout] test known_4point_result ... ok
[INFO] [stdout] test parseval_energy_conservation ... ok
[INFO] [stdout] test roundtrip_large ... ok
[INFO] [stdout] test fft_error_display_format ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/rustfft_backend.rs (/opt/rustwide/target/debug/deps/rustfft_backend-182830b4a75b0e8e)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test empty_returns_error ... ok
[INFO] [stdout] test dc_signal_non_power_of_two ... ok
[INFO] [stdout] test matches_radix2_on_power_of_two ... ok
[INFO] [stdout] test plan_roundtrip ... ok
[INFO] [stdout] test roundtrip_arbitrary_size ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/signal_ext.rs (/opt/rustwide/target/debug/deps/signal_ext-952bbbcae4e2507a)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test magnitude_of_pure_cosine ... ok
[INFO] [stdout] test fft_ifft_roundtrip_vec ... ok
[INFO] [stdout] test magnitude_squared_matches_magnitude ... ok
[INFO] [stdout] test fft_ifft_roundtrip_array ... ok
[INFO] [stdout] test phase_real_positive_is_zero ... ok
[INFO] [stdout] test fft_with_slice_ref ... ok
[INFO] [stdout] test fft_empty_signal_returns_error ... ok
[INFO] [stderr]      Running tests/stft.rs (/opt/rustwide/target/debug/deps/stft-86d65bcbfcab892f)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test synthesize_empty ... ok
[INFO] [stdout] test roundtrip_no_window ... ok
[INFO] [stdout] test with_hann_window ... ok
[INFO] [stdout] test accessors_match_config ... ok
[INFO] [stdout] test analyze_frame_count ... ok
[INFO] [stdout] test analyze_empty_signal ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests resonant_fft
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test src/ext.rs - ext::SignalIfftExt (line 60) - compile fail ... ok
[INFO] [stdout] test src/ext.rs - ext::SignalFftExt (line 31) - compile fail ... ok
[INFO] [stdout] test src/ext.rs - ext::SignalRfftExt (line 176) - compile fail ... ok
[INFO] [stdout] test src/dct.rs - dct::dct_iii (line 67) ... ok
[INFO] [stdout] test src/dct.rs - dct::dct_ii (line 30) ... ok
[INFO] [stdout] test src/lib.rs - phase_vocoder (line 93) ... ok
[INFO] [stdout] test src/radix2.rs - radix2::fft (line 78) ... ok
[INFO] [stdout] test src/radix2.rs - radix2::ifft (line 109) ... ok
[INFO] [stdout] test src/rfft.rs - rfft::rfft (line 48) ... ok
[INFO] [stdout] test src/lib.rs - (line 30) ... ok
[INFO] [stdout] test src/rfft.rs - rfft::irfft (line 142) ... ok
[INFO] [stdout] test src/ext.rs - ext::SignalFftExt (line 20) ... ok
[INFO] [stdout] test src/ext.rs - ext::SignalFreqExt (line 113) ... ok
[INFO] [stdout] test src/ext.rs - ext::SignalRfftExt::rfft (line 193) ... ok
[INFO] [stdout] test src/rustfft_backend.rs - rustfft_backend::FftPlan (line 96) ... ok
[INFO] [stdout] test src/rustfft_backend.rs - rustfft_backend::fft (line 27) ... ok
[INFO] [stdout] test src/rustfft_backend.rs - rustfft_backend::ifft (line 59) ... ok
[INFO] [stdout] test src/stft.rs - stft::Stft (line 23) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.69s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "6084e9e3c0dc84f19811b482ee7c02d6619eb33815692ce800e07ef170240c2b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6084e9e3c0dc84f19811b482ee7c02d6619eb33815692ce800e07ef170240c2b", kill_on_drop: false }`
[INFO] [stdout] 6084e9e3c0dc84f19811b482ee7c02d6619eb33815692ce800e07ef170240c2b
