[INFO] fetching crate sonora-ffi 0.1.0...
[INFO] testing sonora-ffi-0.1.0 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-2
[INFO] extracting crate sonora-ffi 0.1.0 into /workspace/builds/worker-2-tc2/source
[INFO] started tweaking crates.io crate sonora-ffi 0.1.0
[INFO] finished tweaking crates.io crate sonora-ffi 0.1.0
[INFO] tweaked toml for crates.io crate sonora-ffi 0.1.0 written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate sonora-ffi 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-ffi 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-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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] 60b530385cf224569ca95cee5f1d5b2fa7728dab2dfa7eb0075236d495ccfa92
[INFO] running `Command { std: "docker" "start" "-a" "60b530385cf224569ca95cee5f1d5b2fa7728dab2dfa7eb0075236d495ccfa92", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "60b530385cf224569ca95cee5f1d5b2fa7728dab2dfa7eb0075236d495ccfa92", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "60b530385cf224569ca95cee5f1d5b2fa7728dab2dfa7eb0075236d495ccfa92", kill_on_drop: false }`
[INFO] [stdout] 60b530385cf224569ca95cee5f1d5b2fa7728dab2dfa7eb0075236d495ccfa92
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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] 02ca377a0399063449ab39c596c13284c2d97d3607f929a643ca850e9faa9953
[INFO] running `Command { std: "docker" "start" "-a" "02ca377a0399063449ab39c596c13284c2d97d3607f929a643ca850e9faa9953", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.23
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling libc v0.2.181
[INFO] [stderr]    Compiling unicode-xid v0.2.6
[INFO] [stderr]    Compiling getrandom v0.4.1
[INFO] [stderr]    Compiling anstyle v1.0.13
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling zmij v1.0.20
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling anstream v0.6.21
[INFO] [stderr]    Compiling bitflags v2.10.0
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling cpufeatures v0.3.0
[INFO] [stderr]    Compiling winnow v0.7.14
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling clap_lex v0.7.7
[INFO] [stderr]    Compiling clap_builder v4.5.57
[INFO] [stderr]    Compiling sonora-simd v0.1.0
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling cbindgen v0.29.2
[INFO] [stderr]    Compiling sonora-fft v0.1.0
[INFO] [stderr]    Compiling equivalent v1.0.2
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling itoa v1.0.17
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling toml_parser v1.0.7+spec-1.1.0
[INFO] [stderr]    Compiling indexmap v2.13.0
[INFO] [stderr]    Compiling tempfile v3.25.0
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling sonora-ns v0.1.0
[INFO] [stderr]    Compiling serde_spanned v1.0.4
[INFO] [stderr]    Compiling toml_datetime v0.7.5+spec-1.1.0
[INFO] [stderr]    Compiling toml v0.9.12+spec-1.1.0
[INFO] [stderr]    Compiling clap v4.5.57
[INFO] [stderr]    Compiling derive_more-impl v2.1.1
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling bytemuck_derive v1.10.2
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling derive_more v2.1.1
[INFO] [stderr]    Compiling bytemuck v1.25.0
[INFO] [stderr]    Compiling sonora-common-audio v0.1.0
[INFO] [stderr]    Compiling sonora-agc2 v0.1.0
[INFO] [stderr]    Compiling sonora-aec3 v0.1.0
[INFO] [stderr]    Compiling sonora v0.1.0
[INFO] [stderr]    Compiling sonora-ffi v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 52.91s
[INFO] running `Command { std: "docker" "inspect" "02ca377a0399063449ab39c596c13284c2d97d3607f929a643ca850e9faa9953", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "02ca377a0399063449ab39c596c13284c2d97d3607f929a643ca850e9faa9953", kill_on_drop: false }`
[INFO] [stdout] 02ca377a0399063449ab39c596c13284c2d97d3607f929a643ca850e9faa9953
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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] 0e1b6ebc9538cac2b5f638464cc9eae19ee09604e7f882be258fdca841a1cf88
[INFO] running `Command { std: "docker" "start" "-a" "0e1b6ebc9538cac2b5f638464cc9eae19ee09604e7f882be258fdca841a1cf88", kill_on_drop: false }`
[INFO] [stderr]    Compiling sonora-ffi v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.14s
[INFO] running `Command { std: "docker" "inspect" "0e1b6ebc9538cac2b5f638464cc9eae19ee09604e7f882be258fdca841a1cf88", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0e1b6ebc9538cac2b5f638464cc9eae19ee09604e7f882be258fdca841a1cf88", kill_on_drop: false }`
[INFO] [stdout] 0e1b6ebc9538cac2b5f638464cc9eae19ee09604e7f882be258fdca841a1cf88
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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] 20b46388e1ea392b747187ff5d3d91316d2623abbb51cac2cfbae3a70e20a373
[INFO] running `Command { std: "docker" "start" "-a" "20b46388e1ea392b747187ff5d3d91316d2623abbb51cac2cfbae3a70e20a373", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.10s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/sonora_ffi-2522dfab7d27765f)
[INFO] [stdout] 
[INFO] [stdout] running 44 tests
[INFO] [stdout] test conversions::tests::config_roundtrip_default ... ok
[INFO] [stdout] test conversions::tests::downmix_method_roundtrip ... ok
[INFO] [stdout] test conversions::tests::stats_conversion_all_none ... ok
[INFO] [stdout] test conversions::tests::noise_suppression_level_roundtrip ... ok
[INFO] [stdout] test functions::tests::analog_level_null_safety ... ok
[INFO] [stdout] test functions::tests::create_and_destroy ... ok
[INFO] [stdout] test conversions::tests::stats_conversion_with_values ... ok
[INFO] [stdout] test functions::tests::apply_config_null_returns_error ... ok
[INFO] [stdout] test functions::tests::apply_and_get_config_roundtrip ... ok
[INFO] [stdout] test functions::tests::delay_clamped_high ... ok
[INFO] [stdout] test functions::tests::delay_clamped_negative ... ok
[INFO] [stdout] test functions::tests::delay_null_safety ... ok
[INFO] [stdout] test functions::tests::destroy_null_is_safe ... ok
[INFO] [stdout] test functions::tests::config_default_matches_rust_default ... ok
[INFO] [stdout] test conversions::tests::config_roundtrip_all_enabled ... ok
[INFO] [stdout] test functions::tests::create_with_config ... ok
[INFO] [stdout] test functions::tests::get_config_null_config_out_returns_error ... ok
[INFO] [stdout] test functions::tests::get_config_null_returns_error ... ok
[INFO] [stdout] test functions::tests::get_statistics_null_safety ... ok
[INFO] [stdout] test functions::tests::process_reverse_stream_f32_works ... ok
[INFO] [stdout] test functions::tests::process_reverse_stream_i16_works ... ok
[INFO] [stdout] test functions::tests::get_statistics_default ... ok
[INFO] [stdout] test functions::tests::process_stream_f32_bad_rate ... ok
[INFO] [stdout] test functions::tests::process_stream_f32_no_processing_passthrough ... ok
[INFO] [stdout] test functions::tests::process_stream_f32_null_apm ... ok
[INFO] [stdout] test functions::tests::process_stream_f32_silence_passthrough ... ok
[INFO] [stdout] test functions::tests::process_stream_f32_stereo ... ok
[INFO] [stdout] test functions::tests::process_stream_i16_bad_length ... ok
[INFO] [stdout] test functions::tests::process_stream_i16_silence_passthrough ... ok
[INFO] [stdout] test functions::tests::runtime_settings_null_safety ... ok
[INFO] [stdout] test functions::tests::set_and_get_analog_level ... ok
[INFO] [stdout] test functions::tests::process_stream_i16_null_returns_error ... ok
[INFO] [stdout] test functions::tests::runtime_settings_succeed ... ok
[INFO] [stdout] test functions::tests::set_and_get_delay ... ok
[INFO] [stdout] test functions::tests::version_returns_non_null ... ok
[INFO] [stdout] test panic_guard::tests::ffi_guard_ptr_returns_pointer_on_success ... ok
[INFO] [stdout] test panic_guard::tests::ffi_guard_returns_value_on_success ... ok
[INFO] [stdout] test panic_guard::tests::ffi_guard_ptr_returns_null_on_panic ... ok
[INFO] [stdout] test panic_guard::tests::ffi_guard_returns_internal_on_panic ... ok
[INFO] [stdout] test functions::tests::e2e_config_change_mid_stream ... ok
[INFO] [stdout] test functions::tests::e2e_i16_pipeline ... ok
[INFO] [stdout] test functions::tests::e2e_echo_cancellation_pipeline ... ok
[INFO] [stdout] test functions::tests::e2e_stereo_capture_and_render ... ok
[INFO] [stdout] test functions::tests::e2e_all_components_enabled ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 44 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.34s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests sonora_ffi
[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" "20b46388e1ea392b747187ff5d3d91316d2623abbb51cac2cfbae3a70e20a373", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "20b46388e1ea392b747187ff5d3d91316d2623abbb51cac2cfbae3a70e20a373", kill_on_drop: false }`
[INFO] [stdout] 20b46388e1ea392b747187ff5d3d91316d2623abbb51cac2cfbae3a70e20a373