[INFO] cloning repository https://github.com/Mistodon/melo
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/Mistodon/melo" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FMistodon%2Fmelo", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FMistodon%2Fmelo'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 3a100cc7d11e51023a606e33ad5d79b94e301ae7
[INFO] testing Mistodon/melo against 1.47.0 for beta-1.48-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FMistodon%2Fmelo" "/workspace/builds/worker-3/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/Mistodon/melo on toolchain 1.47.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.47.0" "read-manifest" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/Mistodon/melo
[INFO] finished tweaking git repo https://github.com/Mistodon/melo
[INFO] tweaked toml for git repo https://github.com/Mistodon/melo written to /workspace/builds/worker-3/source/Cargo.toml
[INFO] crate git repo https://github.com/Mistodon/melo already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.47.0" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+1.47.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] e41019eaf029e7dc1c7335d38d197b06cc8f33b04df506dd95c9a8cdda131bed
[INFO] running `Command { std: "docker" "start" "-a" "e41019eaf029e7dc1c7335d38d197b06cc8f33b04df506dd95c9a8cdda131bed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e41019eaf029e7dc1c7335d38d197b06cc8f33b04df506dd95c9a8cdda131bed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e41019eaf029e7dc1c7335d38d197b06cc8f33b04df506dd95c9a8cdda131bed", kill_on_drop: false }`
[INFO] [stdout] e41019eaf029e7dc1c7335d38d197b06cc8f33b04df506dd95c9a8cdda131bed
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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=warn" "-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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+1.47.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 164dcd645ad73a433566cc1f7d4616b179538eb2616e3ec5f9f7cee4d143f42b
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "164dcd645ad73a433566cc1f7d4616b179538eb2616e3ec5f9f7cee4d143f42b", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.36
[INFO] [stderr]    Compiling num-traits v0.1.42
[INFO] [stderr]    Compiling rustc-serialize v0.3.24
[INFO] [stderr]    Compiling unicode-xid v0.0.4
[INFO] [stderr]    Compiling cc v1.0.4
[INFO] [stderr]    Compiling unicode-width v0.1.4
[INFO] [stderr]    Compiling void v1.0.2
[INFO] [stderr]    Compiling strsim v0.6.0
[INFO] [stderr]    Compiling cfg-if v0.1.2
[INFO] [stderr]    Compiling rustc-demangle v0.1.5
[INFO] [stderr]    Compiling bitflags v1.0.1
[INFO] [stderr]    Compiling vec_map v0.8.0
[INFO] [stderr]    Compiling ansi_term v0.10.2
[INFO] [stderr]    Compiling utf8-ranges v1.0.0
[INFO] [stderr]    Compiling regex-syntax v0.4.2
[INFO] [stderr]    Compiling byteorder v0.4.2
[INFO] [stderr]    Compiling unreachable v1.0.0
[INFO] [stderr]    Compiling synom v0.11.3
[INFO] [stderr]    Compiling textwrap v0.9.0
[INFO] [stderr]    Compiling thread_local v0.3.5
[INFO] [stderr]    Compiling syn v0.11.11
[INFO] [stderr]    Compiling rand v0.3.20
[INFO] [stderr]    Compiling memchr v2.0.1
[INFO] [stderr]    Compiling atty v0.2.6
[INFO] [stderr]    Compiling clap v2.29.2
[INFO] [stderr]    Compiling aho-corasick v0.6.4
[INFO] [stderr]    Compiling num-integer v0.1.35
[INFO] [stderr]    Compiling enum_primitive v0.1.1
[INFO] [stderr]    Compiling num-iter v0.1.34
[INFO] [stderr]    Compiling backtrace-sys v0.1.16
[INFO] [stderr]    Compiling regex v0.2.5
[INFO] [stderr]    Compiling synstructure v0.6.1
[INFO] [stderr]    Compiling failure_derive v0.1.1
[INFO] [stderr]    Compiling structopt-derive v0.1.6
[INFO] [stderr]    Compiling num-bigint v0.1.41
[INFO] [stderr]    Compiling num-complex v0.1.41
[INFO] [stderr]    Compiling uuid v0.1.18
[INFO] [stderr]    Compiling mktemp v0.3.1
[INFO] [stderr]    Compiling num-rational v0.1.41
[INFO] [stderr]    Compiling structopt v0.1.7
[INFO] [stderr]    Compiling num v0.1.41
[INFO] [stderr]    Compiling rimd v0.0.1
[INFO] [stderr]    Compiling backtrace v0.3.5
[INFO] [stderr]    Compiling failure v0.1.1
[INFO] [stderr]    Compiling melo v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: use of deprecated constant `std::sync::ONCE_INIT`: the `new` function is now preferred
[INFO] [stdout]   --> src/lexing/mod.rs:24:1
[INFO] [stdout]    |
[INFO] [stdout] 24 | / lazy_static! {
[INFO] [stdout] 25 | |     static ref STRUCTURE_REGEX: Regex = Regex::new(
[INFO] [stdout] 26 | |         "\
[INFO] [stdout] 27 | |          (?P<keyword>part|piece|play|section|voice)|\
[INFO] [stdout] ...  |
[INFO] [stdout] 52 | |     ).trust();
[INFO] [stdout] 53 | | }
[INFO] [stdout]    | |_^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(deprecated)]` on by default
[INFO] [stdout]    = note: this warning originates in a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated constant `std::sync::ONCE_INIT`: the `new` function is now preferred
[INFO] [stdout]   --> src/lexing/mod.rs:24:1
[INFO] [stdout]    |
[INFO] [stdout] 24 | / lazy_static! {
[INFO] [stdout] 25 | |     static ref STRUCTURE_REGEX: Regex = Regex::new(
[INFO] [stdout] 26 | |         "\
[INFO] [stdout] 27 | |          (?P<keyword>part|piece|play|section|voice)|\
[INFO] [stdout] ...  |
[INFO] [stdout] 52 | |     ).trust();
[INFO] [stdout] 53 | | }
[INFO] [stdout]    | |_^
[INFO] [stdout]    |
[INFO] [stdout]    = note: this warning originates in a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 2 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 58.66s
[INFO] running `Command { std: "docker" "inspect" "164dcd645ad73a433566cc1f7d4616b179538eb2616e3ec5f9f7cee4d143f42b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "164dcd645ad73a433566cc1f7d4616b179538eb2616e3ec5f9f7cee4d143f42b", kill_on_drop: false }`
[INFO] [stdout] 164dcd645ad73a433566cc1f7d4616b179538eb2616e3ec5f9f7cee4d143f42b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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=warn" "-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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+1.47.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 25f96adaeb5401e022f3dae39f35027a7982acfec62125ac0975894289978d9d
[INFO] running `Command { std: "docker" "start" "-a" "25f96adaeb5401e022f3dae39f35027a7982acfec62125ac0975894289978d9d", kill_on_drop: false }`
[INFO] [stderr]    Compiling ansi_term v0.9.0
[INFO] [stderr]    Compiling difference v1.0.0
[INFO] [stdout] warning: use of deprecated constant `std::sync::ONCE_INIT`: the `new` function is now preferred
[INFO] [stdout]   --> src/lexing/mod.rs:24:1
[INFO] [stdout]    |
[INFO] [stdout] 24 | / lazy_static! {
[INFO] [stdout] 25 | |     static ref STRUCTURE_REGEX: Regex = Regex::new(
[INFO] [stdout] 26 | |         "\
[INFO] [stdout] 27 | |          (?P<keyword>part|piece|play|section|voice)|\
[INFO] [stdout] ...  |
[INFO] [stdout] 52 | |     ).trust();
[INFO] [stdout] 53 | | }
[INFO] [stdout]    | |_^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(deprecated)]` on by default
[INFO] [stdout]    = note: this warning originates in a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated constant `std::sync::ONCE_INIT`: the `new` function is now preferred
[INFO] [stdout]   --> src/lexing/mod.rs:24:1
[INFO] [stdout]    |
[INFO] [stdout] 24 | / lazy_static! {
[INFO] [stdout] 25 | |     static ref STRUCTURE_REGEX: Regex = Regex::new(
[INFO] [stdout] 26 | |         "\
[INFO] [stdout] 27 | |          (?P<keyword>part|piece|play|section|voice)|\
[INFO] [stdout] ...  |
[INFO] [stdout] 52 | |     ).trust();
[INFO] [stdout] 53 | | }
[INFO] [stdout]    | |_^
[INFO] [stdout]    |
[INFO] [stdout]    = note: this warning originates in a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 2 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling pretty_assertions v0.4.1
[INFO] [stderr]    Compiling melo v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: use of deprecated constant `std::sync::ONCE_INIT`: the `new` function is now preferred
[INFO] [stdout]   --> src/lexing/mod.rs:24:1
[INFO] [stdout]    |
[INFO] [stdout] 24 | / lazy_static! {
[INFO] [stdout] 25 | |     static ref STRUCTURE_REGEX: Regex = Regex::new(
[INFO] [stdout] 26 | |         "\
[INFO] [stdout] 27 | |          (?P<keyword>part|piece|play|section|voice)|\
[INFO] [stdout] ...  |
[INFO] [stdout] 52 | |     ).trust();
[INFO] [stdout] 53 | | }
[INFO] [stdout]    | |_^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(deprecated)]` on by default
[INFO] [stdout]    = note: this warning originates in a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated constant `std::sync::ONCE_INIT`: the `new` function is now preferred
[INFO] [stdout]   --> src/lexing/mod.rs:24:1
[INFO] [stdout]    |
[INFO] [stdout] 24 | / lazy_static! {
[INFO] [stdout] 25 | |     static ref STRUCTURE_REGEX: Regex = Regex::new(
[INFO] [stdout] 26 | |         "\
[INFO] [stdout] 27 | |          (?P<keyword>part|piece|play|section|voice)|\
[INFO] [stdout] ...  |
[INFO] [stdout] 52 | |     ).trust();
[INFO] [stdout] 53 | | }
[INFO] [stdout]    | |_^
[INFO] [stdout]    |
[INFO] [stdout]    = note: this warning originates in a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 2 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 9.52s
[INFO] running `Command { std: "docker" "inspect" "25f96adaeb5401e022f3dae39f35027a7982acfec62125ac0975894289978d9d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "25f96adaeb5401e022f3dae39f35027a7982acfec62125ac0975894289978d9d", kill_on_drop: false }`
[INFO] [stdout] 25f96adaeb5401e022f3dae39f35027a7982acfec62125ac0975894289978d9d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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=warn" "-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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+1.47.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 4a80ea094e98cfe906eb7e8a9e254f9b1b7e65b9a3abcfac0ecc928bac7b8c9d
[INFO] running `Command { std: "docker" "start" "-a" "4a80ea094e98cfe906eb7e8a9e254f9b1b7e65b9a3abcfac0ecc928bac7b8c9d", kill_on_drop: false }`
[INFO] [stderr] warning: use of deprecated constant `std::sync::ONCE_INIT`: the `new` function is now preferred
[INFO] [stderr]   --> src/lexing/mod.rs:24:1
[INFO] [stderr]    |
[INFO] [stderr] 24 | / lazy_static! {
[INFO] [stderr] 25 | |     static ref STRUCTURE_REGEX: Regex = Regex::new(
[INFO] [stderr] 26 | |         "\
[INFO] [stderr] 27 | |          (?P<keyword>part|piece|play|section|voice)|\
[INFO] [stderr] ...  |
[INFO] [stderr] 52 | |     ).trust();
[INFO] [stderr] 53 | | }
[INFO] [stderr]    | |_^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(deprecated)]` on by default
[INFO] [stderr]    = note: this warning originates in a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated constant `std::sync::ONCE_INIT`: the `new` function is now preferred
[INFO] [stderr]   --> src/lexing/mod.rs:24:1
[INFO] [stderr]    |
[INFO] [stderr] 24 | / lazy_static! {
[INFO] [stderr] 25 | |     static ref STRUCTURE_REGEX: Regex = Regex::new(
[INFO] [stderr] 26 | |         "\
[INFO] [stderr] 27 | |          (?P<keyword>part|piece|play|section|voice)|\
[INFO] [stderr] ...  |
[INFO] [stderr] 52 | |     ).trust();
[INFO] [stderr] 53 | | }
[INFO] [stderr]    | |_^
[INFO] [stderr]    |
[INFO] [stderr]    = note: this warning originates in a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stderr] 
[INFO] [stderr] warning: 2 warnings emitted
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated constant `std::sync::ONCE_INIT`: the `new` function is now preferred
[INFO] [stderr]   --> src/lexing/mod.rs:24:1
[INFO] [stderr]    |
[INFO] [stderr] 24 | / lazy_static! {
[INFO] [stderr] 25 | |     static ref STRUCTURE_REGEX: Regex = Regex::new(
[INFO] [stderr] 26 | |         "\
[INFO] [stderr] 27 | |          (?P<keyword>part|piece|play|section|voice)|\
[INFO] [stderr] ...  |
[INFO] [stderr] 52 | |     ).trust();
[INFO] [stderr] 53 | | }
[INFO] [stderr]    | |_^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(deprecated)]` on by default
[INFO] [stderr]    = note: this warning originates in a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated constant `std::sync::ONCE_INIT`: the `new` function is now preferred
[INFO] [stderr]   --> src/lexing/mod.rs:24:1
[INFO] [stderr]    |
[INFO] [stderr] 24 | / lazy_static! {
[INFO] [stderr] 25 | |     static ref STRUCTURE_REGEX: Regex = Regex::new(
[INFO] [stderr] 26 | |         "\
[INFO] [stderr] 27 | |          (?P<keyword>part|piece|play|section|voice)|\
[INFO] [stderr] ...  |
[INFO] [stderr] 52 | |     ).trust();
[INFO] [stderr] 53 | | }
[INFO] [stderr]    | |_^
[INFO] [stderr]    |
[INFO] [stderr]    = note: this warning originates in a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stderr] 
[INFO] [stderr] warning: 2 warnings emitted
[INFO] [stderr] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.14s
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/melo-20a43393246addfe
[INFO] [stdout] running 108 tests
[INFO] [stdout] test abc_generation::tests::test_div_tuplet ... ok
[INFO] [stdout] test abc_generation::tests::note_tied_across_triplet_bars ... ok
[INFO] [stdout] test abc_generation::tests::test_four_notes_in_sequence ... ok
[INFO] [stdout] test abc_generation::tests::test_eight_notes_in_sequence ... ok
[INFO] [stdout] test abc_generation::tests::long_notes_in_triplets ... ok
[INFO] [stdout] test abc_generation::tests::note_tied_across_triplets ... ok
[INFO] [stdout] test abc_generation::tests::test_sixteen_notes_in_sequence ... ok
[INFO] [stdout] test abc_generation::tests::rest_before_chord_not_duplicated ... ok
[INFO] [stdout] test abc_generation::tests::test_notes_with_rests ... ok
[INFO] [stdout] test abc_generation::tests::test_fast_triplets ... ok
[INFO] [stdout] test abc_generation::tests::test_quintuplet_in_4_4_time ... ok
[INFO] [stdout] test abc_generation::tests::test_two_notes_in_sequence ... ok
[INFO] [stdout] test abc_generation::tests::note_tied_across_bar ... ok
[INFO] [stdout] test abc_generation::tests::test_triplets_with_rests ... ok
[INFO] [stdout] test abc_generation::tests::test_four_notes_then_sixteen ... ok
[INFO] [stdout] test abc_generation::tests::three_notes_at_once ... ok
[INFO] [stdout] test abc_generation::tests::large_tuplets_fail ... ok
[INFO] [stdout] test abc_generation::tests::test_three_note_bar_in_3_4_time ... ok
[INFO] [stdout] test abc_generation::tests::test_triplet_in_4_4_time ... ok
[INFO] [stdout] test abc_generation::tests::test_triplets_in_3_4_time ... ok
[INFO] [stdout] test abc_generation::tests::test_two_notes_at_once ... ok
[INFO] [stdout] test abc_generation::tests::notes_with_lengths ... ok
[INFO] [stdout] test abc_generation::tests::test_even_faster_triplets ... ok
[INFO] [stdout] test abc_generation::tests::test_single_note ... ok
[INFO] [stdout] test abc_generation::tests::notes_with_dots ... ok
[INFO] [stdout] test lexing::tests::lex_complex_notes ... ok
[INFO] [stdout] test lexing::tests::lex_name ... ok
[INFO] [stdout] test lexing::tests::lex_empty_key ... ok
[INFO] [stdout] test lexing::tests::lex_blank_lines ... ok
[INFO] [stdout] test lexing::tests::invalid_tokens_in_stave ... ok
[INFO] [stdout] test lexing::tests::lex_note ... ok
[INFO] [stdout] test lexing::tests::lex_multiple_fields ... ok
[INFO] [stdout] test abc_generation::tests::triplet_chords ... ok
[INFO] [stdout] test lexing::tests::invalid_tokens ... ok
[INFO] [stdout] test lexing::tests::lex_name_with_spaces ... ok
[INFO] [stdout] test lexing::tests::lex_all_staves_key ... ok
[INFO] [stdout] test lexing::tests::comments_ignored ... ok
[INFO] [stdout] test lexing::tests::empty_file ... ok
[INFO] [stdout] test lexing::tests::lex_note_length ... ok
[INFO] [stdout] test lexing::tests::lex_numbers ... ok
[INFO] [stdout] test lexing::tests::lex_piece ... ok
[INFO] [stdout] test lexing::tests::lex_part ... ok
[INFO] [stdout] test lexing::tests::insignificant_whitespace_ignored ... ok
[INFO] [stdout] test lexing::tests::lex_play_part ... ok
[INFO] [stdout] test abc_generation::tests::rest_across_bars ... ok
[INFO] [stdout] test lexing::tests::lex_play ... ok
[INFO] [stdout] test lexing::tests::lex_symbols ... ok
[INFO] [stdout] test lexing::tests::lex_voice ... ok
[INFO] [stdout] test lexing::tests::lex_quoted_name_with_quotes_in_it ... ok
[INFO] [stdout] test lexing::tests::right_brace_can_break_stave_within_one_line ... ok
[INFO] [stdout] test parsing::tests::fail_on_overflowed_length ... ok
[INFO] [stdout] test notes::tests::test_lcm ... ok
[INFO] [stdout] test parsing::tests::fail_when_hit_notes_are_encountered_in_incompatible_staves ... ok
[INFO] [stdout] test parsing::tests::fail_to_parse_invalid_attributes ... ok
[INFO] [stdout] test lexing::tests::lex_ridiculous_field_name ... ok
[INFO] [stdout] test parsing::tests::fail_when_notes_before_repeat_sign ... ok
[INFO] [stdout] test parsing::tests::fail_when_notes_after_repeat_sign ... ok
[INFO] [stdout] test notes::tests::test_note_to_midi ... ok
[INFO] [stdout] test notes::tests::round_trip_flat_conversions ... ok
[INFO] [stdout] test notes::tests::test_note_to_abc ... ok
[INFO] [stdout] test parsing::tests::parse_attributes_in_piece ... ok
[INFO] [stdout] test notes::tests::round_trip_sharp_conversions ... ok
[INFO] [stdout] test parsing::tests::parse_attributes_with_trailing_comma ... ok
[INFO] [stdout] test parsing::tests::parse_empty_voiceless_play_node ... ok
[INFO] [stdout] test lexing::tests::semicolon_can_break_stave_within_one_line ... ok
[INFO] [stdout] test parsing::tests::fail_on_underflowed_length ... ok
[INFO] [stdout] test parsing::tests::fail_on_unexpected_length ... ok
[INFO] [stdout] test parsing::tests::parse_empty_file ... ok
[INFO] [stdout] test parsing::tests::parse_play_node_with_extra_barlines ... ok
[INFO] [stdout] test parsing::tests::parse_note_with_length ... ok
[INFO] [stdout] test parsing::tests::parse_multiple_concurrent_melody_lines_broken_up_by_blank_line ... ok
[INFO] [stdout] test parsing::tests::parse_attributes_without_commas ... ok
[INFO] [stdout] test parsing::tests::parse_multiple_empty_pieces ... ok
[INFO] [stdout] test parsing::tests::parse_play_node_with_melody_notes ... ok
[INFO] [stdout] test parsing::tests::parse_empty_voice ... ok
[INFO] [stdout] test parsing::tests::parse_multiple_concurrent_melody_lines ... ok
[INFO] [stdout] test parsing::tests::parse_empty_piece ... ok
[INFO] [stdout] test parsing::tests::parse_empty_play_node ... ok
[INFO] [stdout] test sequencing::tests::dots_do_not_carry_across_staves ... ok
[INFO] [stdout] test parsing::tests::parse_repeat ... ok
[INFO] [stdout] test parsing::tests::parse_valueless_attribute ... ok
[INFO] [stdout] test parsing::tests::parse_voice_attributes ... ok
[INFO] [stdout] test parsing::tests::parse_play_node_with_two_staves ... ok
[INFO] [stdout] test parsing::tests::parse_stave_split_over_multiple_lines ... ok
[INFO] [stdout] test parsing::tests::parse_play_node_with_percussive_notes ... ok
[INFO] [stdout] test parsing::tests::parse_rest_with_length ... ok
[INFO] [stdout] test sequencing::tests::sequence_empty_piece ... ok
[INFO] [stdout] test sequencing::tests::threes_against_twos ... ok
[INFO] [stdout] test sequencing::tests::voice_with_dots ... ok
[INFO] [stdout] test sequencing::tests::repeat_bars ... ok
[INFO] [stdout] test sequencing::tests::fail_first_bar_repeat ... ok
[INFO] [stdout] test sequencing::tests::voice_with_note_lengths ... ok
[INFO] [stdout] test sequencing::tests::fail_when_notes_moved_out_of_range ... ok
[INFO] [stdout] test sequencing::tests::notes_can_be_tied_across_bars ... ok
[INFO] [stdout] test sequencing::tests::voice_with_mismatched_play ... ok
[INFO] [stdout] test sequencing::tests::voice_with_two_staves ... ok
[INFO] [stdout] test sequencing::tests::repeat_bars_twice ... ok
[INFO] [stdout] test sequencing::tests::piece_with_empty_voice ... ok
[INFO] [stdout] test sequencing::tests::piece_with_attributes ... ok
[INFO] [stdout] test lexing::tests::lex_field_in_block ... ok
[INFO] [stdout] test sequencing::tests::voice_with_single_note ... ok
[INFO] [stdout] test sequencing::tests::voice_with_two_notes ... ok
[INFO] [stdout] test parsing::tests::fail_parsing_too_many_staves_after_blank_line ... ok
[INFO] [stdout] test lexing::tests::lex_section ... ok
[INFO] [stdout] test lexing::tests::lex_quoted_name ... ok
[INFO] [stdout] test parsing::tests::parse_play_node_with_stave ... ok
[INFO] [stdout] test sequencing::tests::voice_with_leading_dots ... ok
[INFO] [stdout] test parsing::tests::parse_empty_piece_with_trailing_tokens_fails ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 108 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/melo-5d067268d9999df2
[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
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/compile_pieces_to_abc_tests-dc972ab62ad29433
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test minimal_melody ... ok
[INFO] [stdout] test minimal_chords ... ok
[INFO] [stdout] test minimal_drums ... ok
[INFO] [stdout] test multiple_instruments ... ok
[INFO] [stdout] test too_many_staves ... ok
[INFO] [stdout] test repeats ... ok
[INFO] [stdout] test polyrhythms ... ok
[INFO] [stdout] test time_and_tempo ... ok
[INFO] [stdout] test rondo_alla_turca ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/compile_to_abc_tests-9809f78996d01145
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test triplets ... ok
[INFO] [stdout] test variable_drum_bars ... ok
[INFO] [stdout] test quintuplets ... ok
[INFO] [stdout] test voice_args ... ok
[INFO] [stdout] test simple_melody ... ok
[INFO] [stdout] test not_sextuplets ... ok
[INFO] [stdout] test variable_stave_drum_bars ... ok
[INFO] [stdout] test octave_shift ... ok
[INFO] [stdout] test longer_melody ... ok
[INFO] [stdout] test simple_drums ... ok
[INFO] [stdout] test complex_melody ... ok
[INFO] [stdout] test triple_time_expansion ... ok
[INFO] [stdout] test fifths ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests melo
[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
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "4a80ea094e98cfe906eb7e8a9e254f9b1b7e65b9a3abcfac0ecc928bac7b8c9d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4a80ea094e98cfe906eb7e8a9e254f9b1b7e65b9a3abcfac0ecc928bac7b8c9d", kill_on_drop: false }`
[INFO] [stdout] 4a80ea094e98cfe906eb7e8a9e254f9b1b7e65b9a3abcfac0ecc928bac7b8c9d
