[INFO] fetching crate metrome 0.1.26... [INFO] testing metrome-0.1.26 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-1 [INFO] extracting crate metrome 0.1.26 into /workspace/builds/worker-5-tc2/source [INFO] started tweaking crates.io crate metrome 0.1.26 [INFO] finished tweaking crates.io crate metrome 0.1.26 [INFO] tweaked toml for crates.io crate metrome 0.1.26 written to /workspace/builds/worker-5-tc2/source/Cargo.toml [INFO] validating manifest of crates.io crate metrome 0.1.26 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 metrome 0.1.26 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] [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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 012f0a7af3215c3ab28a16cbb780ea5b8fd20f3765cb61c1ecf256b1ad7df931 [INFO] running `Command { std: "docker" "start" "-a" "012f0a7af3215c3ab28a16cbb780ea5b8fd20f3765cb61c1ecf256b1ad7df931", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "012f0a7af3215c3ab28a16cbb780ea5b8fd20f3765cb61c1ecf256b1ad7df931", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "012f0a7af3215c3ab28a16cbb780ea5b8fd20f3765cb61c1ecf256b1ad7df931", kill_on_drop: false }` [INFO] [stdout] 012f0a7af3215c3ab28a16cbb780ea5b8fd20f3765cb61c1ecf256b1ad7df931 [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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 0fb365cd2376bf4e9fbc5ac721dc25e5e631f9a825047d3b34d368f8718886a0 [INFO] running `Command { std: "docker" "start" "-a" "0fb365cd2376bf4e9fbc5ac721dc25e5e631f9a825047d3b34d368f8718886a0", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.78 [INFO] [stderr] Compiling anstyle-query v1.0.2 [INFO] [stderr] Compiling anstyle v1.0.4 [INFO] [stderr] Compiling clap_lex v0.6.0 [INFO] [stderr] Compiling anstyle-parse v0.2.3 [INFO] [stderr] Compiling anstream v0.6.11 [INFO] [stderr] Compiling clap_builder v4.4.18 [INFO] [stderr] Compiling quote v1.0.35 [INFO] [stderr] Compiling syn v2.0.48 [INFO] [stderr] Compiling clap_derive v4.4.7 [INFO] [stderr] Compiling clap v4.4.18 [INFO] [stderr] Compiling metrome v0.1.26 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 9.68s [INFO] running `Command { std: "docker" "inspect" "0fb365cd2376bf4e9fbc5ac721dc25e5e631f9a825047d3b34d368f8718886a0", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0fb365cd2376bf4e9fbc5ac721dc25e5e631f9a825047d3b34d368f8718886a0", kill_on_drop: false }` [INFO] [stdout] 0fb365cd2376bf4e9fbc5ac721dc25e5e631f9a825047d3b34d368f8718886a0 [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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 47bc2da5c06ae114b96dd6b4ac1fdf9e506cbdc5dd63c65bd731ba3aac765d27 [INFO] running `Command { std: "docker" "start" "-a" "47bc2da5c06ae114b96dd6b4ac1fdf9e506cbdc5dd63c65bd731ba3aac765d27", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v0.4.30 [INFO] [stderr] Compiling unicode-xid v0.1.0 [INFO] [stderr] Compiling syn v0.15.44 [INFO] [stderr] Compiling glob v0.3.1 [INFO] [stderr] Compiling quote v0.6.13 [INFO] [stderr] Compiling test-generator v0.3.1 [INFO] [stderr] Compiling metrome v0.1.26 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 5.59s [INFO] running `Command { std: "docker" "inspect" "47bc2da5c06ae114b96dd6b4ac1fdf9e506cbdc5dd63c65bd731ba3aac765d27", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "47bc2da5c06ae114b96dd6b4ac1fdf9e506cbdc5dd63c65bd731ba3aac765d27", kill_on_drop: false }` [INFO] [stdout] 47bc2da5c06ae114b96dd6b4ac1fdf9e506cbdc5dd63c65bd731ba3aac765d27 [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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] c0406cf3d5d501bcb1a570fec394097c94228e9034bcf82038b4ab5f702842d5 [INFO] running `Command { std: "docker" "start" "-a" "c0406cf3d5d501bcb1a570fec394097c94228e9034bcf82038b4ab5f702842d5", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/metrome-3bf43ae3670c49b9) [INFO] [stdout] [INFO] [stdout] running 31 tests [INFO] [stdout] test scanner::tests::ratios ... ok [INFO] [stdout] test scanner::tests::repeats ... ok [INFO] [stdout] test scanner::tests::numbers ... ok [INFO] [stdout] test scanner::tests::single_tokens ... ok [INFO] [stdout] test scanner::tests::valid_scores_examples_valid_eine_kleine_nachtmusik ... ok [INFO] [stdout] test scanner::tests::invalid_scores ... ok [INFO] [stdout] test scanner::tests::valid_scores_examples_valid_many_ratios ... ok [INFO] [stdout] test scanner::tests::valid_scores_examples_valid_boulez_sonatine ... ok [INFO] [stdout] test scanner::tests::valid_scores_examples_valid_many_tempo_changes ... ok [INFO] [stdout] test scanner::tests::valid_scores_examples_valid_repeats ... ok [INFO] [stdout] test scanner::tests::valid_scores_examples_valid_simple_score ... ok [INFO] [stdout] test scanner::tests::valid_scores_examples_valid_single_tempo ... ok [INFO] [stdout] test score::tests::bar_repeats ... ok [INFO] [stdout] test score::tests::missing_tempo ... ok [INFO] [stdout] test score::tests::setting_tempo ... ok [INFO] [stdout] test score::tests::single_bar ... ok [INFO] [stdout] test score::tests::tempo_changes ... ok [INFO] [stdout] test score::tests::total_durations ... ok [INFO] [stdout] test score::tests::valid_scores_examples_valid_eine_kleine_nachtmusik ... ok [INFO] [stdout] test score::tests::valid_scores_examples_valid_many_ratios ... ok [INFO] [stdout] test score::tests::note_repeats ... ok [INFO] [stdout] test score::tests::valid_scores_examples_valid_many_tempo_changes ... ok [INFO] [stdout] test score::tests::valid_scores_examples_valid_repeats ... ok [INFO] [stdout] test score::tests::valid_scores_examples_valid_boulez_sonatine ... ok [INFO] [stdout] test score::tests::valid_scores_examples_valid_single_tempo ... ok [INFO] [stdout] test units::tests::ratio::dot_application ... ok [INFO] [stdout] test units::tests::ratio::duration ... ok [INFO] [stdout] test units::tests::num_samples_from_duration ... ok [INFO] [stdout] test units::tests::tempo::relative_tempo_change ... ok [INFO] [stdout] test units::tests::tempo::whole_duration ... ok [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/metrome-2d74f05845f14be7) [INFO] [stdout] test score::tests::valid_scores_examples_valid_simple_score ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [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/snapshot_test.rs (/opt/rustwide/target/debug/deps/snapshot_test-8c99a6036f1e0509) [INFO] [stdout] [INFO] [stdout] running 7 tests [INFO] [stdout] test snapshot::wav_examples_valid_single_tempo ... ok [INFO] [stdout] test snapshot::wav_examples_valid_repeats ... ok [INFO] [stdout] test snapshot::wav_examples_valid_many_tempo_changes ... ok [INFO] [stdout] test snapshot::wav_examples_valid_simple_score ... ok [INFO] [stdout] test snapshot::wav_examples_valid_eine_kleine_nachtmusik ... ok [INFO] [stdout] test snapshot::wav_examples_valid_many_ratios ... ok [INFO] [stdout] test snapshot::wav_examples_valid_boulez_sonatine ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.70s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "c0406cf3d5d501bcb1a570fec394097c94228e9034bcf82038b4ab5f702842d5", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c0406cf3d5d501bcb1a570fec394097c94228e9034bcf82038b4ab5f702842d5", kill_on_drop: false }` [INFO] [stdout] c0406cf3d5d501bcb1a570fec394097c94228e9034bcf82038b4ab5f702842d5