[INFO] cloning repository https://github.com/jonnystokes/muSickBeets
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/jonnystokes/muSickBeets" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjonnystokes%2FmuSickBeets", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjonnystokes%2FmuSickBeets'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 059f29e49f0b4f5a93e123e933b37ebbbbc5dc77
[INFO] testing jonnystokes/muSickBeets against try#0abe69e6c16114311cc2700e972492e64d69c28f for pr-154065
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjonnystokes%2FmuSickBeets" "/workspace/builds/worker-5-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-5-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/jonnystokes/muSickBeets
[INFO] finished tweaking git repo https://github.com/jonnystokes/muSickBeets
[INFO] tweaked toml for git repo https://github.com/jonnystokes/muSickBeets written to /workspace/builds/worker-5-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/jonnystokes/muSickBeets on toolchain 0abe69e6c16114311cc2700e972492e64d69c28f
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]      Locking 145 packages to latest Rust 1.96.0-nightly compatible versions
[INFO] [stderr]       Adding rand v0.9.2 (available: v0.10.0)
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 080b8089faec94bad40390cf5fe337bd3f7b81ff3825329100671960200a0bde
[INFO] running `Command { std: "docker" "start" "-a" "080b8089faec94bad40390cf5fe337bd3f7b81ff3825329100671960200a0bde", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "080b8089faec94bad40390cf5fe337bd3f7b81ff3825329100671960200a0bde", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "080b8089faec94bad40390cf5fe337bd3f7b81ff3825329100671960200a0bde", kill_on_drop: false }`
[INFO] [stdout] 080b8089faec94bad40390cf5fe337bd3f7b81ff3825329100671960200a0bde
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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" "+0abe69e6c16114311cc2700e972492e64d69c28f" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8057f326a32f2d33d5144de837c82da84182d9d9d76b548665ec879b32c63d2b
[INFO] running `Command { std: "docker" "start" "-a" "8057f326a32f2d33d5144de837c82da84182d9d9d76b548665ec879b32c63d2b", kill_on_drop: false }`
[INFO] [stderr]    Compiling glob v0.3.3
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling libc v0.2.183
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling minimal-lexical v0.2.1
[INFO] [stderr]    Compiling cc v1.2.58
[INFO] [stderr]    Compiling libloading v0.8.9
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling bindgen v0.71.1
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling rustc-hash v2.1.1
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling zerocopy v0.8.47
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling itertools v0.13.0
[INFO] [stderr]    Compiling unicode-segmentation v1.13.2
[INFO] [stderr]    Compiling x11 v2.21.0
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling signal-hook v0.3.18
[INFO] [stderr]    Compiling mio v1.2.0
[INFO] [stderr]    Compiling clang-sys v1.8.1
[INFO] [stderr]    Compiling convert_case v0.10.0
[INFO] [stderr]    Compiling primal-check v0.3.4
[INFO] [stderr]    Compiling transpose v0.2.3
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling x11rb-protocol v0.13.2
[INFO] [stderr]    Compiling anyhow v1.0.102
[INFO] [stderr]    Compiling signal-hook-mio v0.2.5
[INFO] [stderr]    Compiling xkbcommon v0.9.0
[INFO] [stderr]    Compiling cmake v0.1.58
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling minipaste v0.1.0
[INFO] [stderr]    Compiling csv-core v0.1.13
[INFO] [stderr]    Compiling nom v8.0.0
[INFO] [stderr]    Compiling ttf-parser v0.25.1
[INFO] [stderr]    Compiling rustfft v6.4.1
[INFO] [stderr]    Compiling itoa v1.0.18
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling rayon v1.11.0
[INFO] [stderr]    Compiling cexpr v0.6.0
[INFO] [stderr]    Compiling fltk-sys v1.5.22
[INFO] [stderr]    Compiling rdev v0.5.3
[INFO] [stderr]    Compiling hound v3.5.1
[INFO] [stderr]    Compiling csv v1.4.0
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling derive_more-impl v2.1.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling gethostname v1.1.0
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling derive_more v2.1.1
[INFO] [stderr]    Compiling crossterm v0.29.0
[INFO] [stderr]    Compiling realfft v3.5.0
[INFO] [stderr]    Compiling om-fork-ep-miniaudio-sys v2.6.2
[INFO] [stderr]    Compiling x11rb v0.13.2
[INFO] [stderr]    Compiling enigo v0.6.1
[INFO] [stderr]    Compiling om-fork-miniaudio v0.12.2
[INFO] [stderr]    Compiling fltk v1.5.22
[INFO] [stderr]    Compiling muSickBeets v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 06s
[INFO] running `Command { std: "docker" "inspect" "8057f326a32f2d33d5144de837c82da84182d9d9d76b548665ec879b32c63d2b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8057f326a32f2d33d5144de837c82da84182d9d9d76b548665ec879b32c63d2b", kill_on_drop: false }`
[INFO] [stdout] 8057f326a32f2d33d5144de837c82da84182d9d9d76b548665ec879b32c63d2b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f032d5c15bd0d15a23c2fecd3c1821b632aa09c9c50871f3be6ffed5b121c8c6
[INFO] running `Command { std: "docker" "start" "-a" "f032d5c15bd0d15a23c2fecd3c1821b632aa09c9c50871f3be6ffed5b121c8c6", kill_on_drop: false }`
[INFO] [stderr]    Compiling muSickBeets v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 5.79s
[INFO] running `Command { std: "docker" "inspect" "f032d5c15bd0d15a23c2fecd3c1821b632aa09c9c50871f3be6ffed5b121c8c6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f032d5c15bd0d15a23c2fecd3c1821b632aa09c9c50871f3be6ffed5b121c8c6", kill_on_drop: false }`
[INFO] [stdout] f032d5c15bd0d15a23c2fecd3c1821b632aa09c9c50871f3be6ffed5b121c8c6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 498acaaaf5142eac67f19d925e76e9c1ae7f0f095dec2f4180720de60bb0175e
[INFO] running `Command { std: "docker" "start" "-a" "498acaaaf5142eac67f19d925e76e9c1ae7f0f095dec2f4180720de60bb0175e", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stderr]      Running unittests src/fft_analyzer/main_fft.rs (/opt/rustwide/target/debug/deps/fft_analyzer-94a755a2a03e9392)
[INFO] [stdout] 
[INFO] [stdout] running 25 tests
[INFO] [stdout] test data::segmentation_solver::tests::bins_edit_keeps_single_segment_lock_when_present ... ok
[INFO] [stdout] test data::segmentation_solver::tests::bins_edit_respects_min_even_window_floor ... ok
[INFO] [stdout] test data::segmentation_solver::tests::bins_edit_updates_window_deterministically ... ok
[INFO] [stdout] test data::segmentation_solver::tests::overlap_edit_uses_locked_segments_when_present ... ok
[INFO] [stdout] test data::segmentation_solver::tests::bins_edit_respects_zero_pad_factor_mapping ... ok
[INFO] [stdout] test data::segmentation_solver::tests::segments_edit_prefers_overlap_and_solves_window ... ok
[INFO] [stdout] test data::segmentation_solver::tests::solver_enforces_hard_constraints ... ok
[INFO] [stdout] test csv_export::tests::test_csv_multiple_frames ... ok
[INFO] [stdout] test csv_export::tests::test_csv_import_backward_compat_without_solver_fields ... ok
[INFO] [stdout] test csv_export::tests::test_csv_roundtrip ... ok
[INFO] [stdout] test settings::tests::segmentation_solver_fields_default_when_missing_in_ini ... ok
[INFO] [stdout] test settings::tests::segmentation_solver_fields_roundtrip_in_ini_text ... ok
[INFO] [stdout] test processing::reconstructor::tests::identity_roundtrip_hann_zero_overlap_minimal_gaps ... ok
[INFO] [stdout] test processing::reconstructor::tests::identity_roundtrip_blackman_zero_overlap_minimal_gaps ... ok
[INFO] [stdout] test processing::reconstructor::tests::rectangular_zero_overlap_zero_gaps ... ok
[INFO] [stdout] test processing::reconstructor::tests::identity_roundtrip_hamming_zero_overlap ... ok
[INFO] [stdout] test processing::reconstructor::tests::identity_roundtrip_kaiser_zero_overlap ... ok
[INFO] [stdout] test processing::reconstructor::tests::rectangular_frame_boundary_samples ... ok
[INFO] [stdout] test processing::reconstructor::tests::centered_mode_single_frame_produces_two_frames ... ok
[INFO] [stdout] test processing::reconstructor::tests::sparse_bins_hamming_zero_overlap_has_boundary_jumps ... ok
[INFO] [stdout] test processing::reconstructor::tests::sparse_bins_hann_50pct_overlap_reduces_artifacts ... ok
[INFO] [stdout] test processing::reconstructor::tests::identity_roundtrip_hann_75pct_overlap ... ok
[INFO] [stdout] test processing::reconstructor::tests::no_amplification_spikes_any_window_zero_overlap ... ok
[INFO] [stdout] test processing::reconstructor::tests::hann_zero_overlap_gap_width_regression ... ok
[INFO] [stdout] test processing::reconstructor::tests::rectangular_single_frame_edge_to_edge ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/fft_analyzer/test_audio_gen.rs (/opt/rustwide/target/debug/deps/test_audio_gen-f3fcdd044a3b825f)
[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 unittests src/main.rs (/opt/rustwide/target/debug/deps/tester-bcac050bc5698186)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test tests::test_key_match ... ok
[INFO] [stdout] test tests::test_flag ... ok
[INFO] [stdout] test tests::test_key_str ... ok
[INFO] [stdout] test tests::test_valid_float ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/tracker/main.rs (/opt/rustwide/target/debug/deps/tracker-9e76d3854cc46b21)
[INFO] [stdout] 
[INFO] [stdout] running 23 tests
[INFO] [stdout] test audio::tests::test_analyze_audio ... ok
[INFO] [stdout] test audio::tests::test_generate_wav_filename ... ok
[INFO] [stdout] test channel::tests::test_channel_creation ... ok
[INFO] [stdout] test audio::tests::test_normalize_audio ... ok
[INFO] [stdout] test channel::tests::test_channel_render ... ok
[INFO] [stdout] test channel::tests::test_channel_trigger ... ok
[INFO] [stdout] test envelope::tests::test_envelope_trigger_and_release ... ok
[INFO] [stdout] test helper::tests::test_note_letter_to_semitone ... ok
[INFO] [stdout] test helper::tests::test_frequency_table_a4 ... ok
[INFO] [stdout] test instruments::tests::test_instrument_requires_pitch ... ok
[INFO] [stdout] test helper::tests::test_lerp ... ok
[INFO] [stdout] test instruments::tests::test_pulse_width_parameter ... ok
[INFO] [stdout] test instruments::tests::test_find_instrument_by_name ... ok
[INFO] [stdout] test engine::tests::test_engine_creation ... ok
[INFO] [stdout] test instruments::tests::test_sine_output_range ... ok
[INFO] [stdout] test engine::tests::test_engine_render ... ok
[INFO] [stdout] test parser::tests::test_parse_parameter_list ... ok
[INFO] [stdout] test parser::tests::test_effect_only_change_not_parsed_as_note ... ok
[INFO] [stdout] test parser::tests::test_strip_comments ... ok
[INFO] [stdout] test master_bus::tests::test_master_bus_creation ... ok
[INFO] [stdout] test master_bus::tests::test_master_clear ... ok
[INFO] [stdout] test master_bus::tests::test_master_bus_process ... ok
[INFO] [stdout] test master_bus::tests::test_master_amplitude_effect ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "498acaaaf5142eac67f19d925e76e9c1ae7f0f095dec2f4180720de60bb0175e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "498acaaaf5142eac67f19d925e76e9c1ae7f0f095dec2f4180720de60bb0175e", kill_on_drop: false }`
[INFO] [stdout] 498acaaaf5142eac67f19d925e76e9c1ae7f0f095dec2f4180720de60bb0175e