Nov 18 06:29:30.234 INFO testing melo-0.1.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 06:29:30.240 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 18 06:29:30.675 INFO [stdout] bc3b96173e63d139e4b66192ffa3858ba9f4130a503c42df3201619bc983692b
Nov 18 06:29:30.677 INFO running `"docker" "start" "-a" "bc3b96173e63d139e4b66192ffa3858ba9f4130a503c42df3201619bc983692b"`
Nov 18 06:29:31.174 INFO [stderr] usermod: no changes
Nov 18 06:29:31.320 INFO [stderr]    Compiling rimd v0.0.1
Nov 18 06:29:33.525 INFO [stderr]    Compiling melo v0.1.0 (/source)
Nov 18 06:29:41.055 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:41.055 INFO [stderr]    --> src/main.rs:325:18
Nov 18 06:29:41.056 INFO [stderr]     |
Nov 18 06:29:41.056 INFO [stderr] 325 |     let result = melo::compile_to_abc(&source, filename.and_then(Path::to_str))?;
Nov 18 06:29:41.056 INFO [stderr]     |                  ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:41.056 INFO [stderr]     |
Nov 18 06:29:41.057 INFO [stderr]     = note: #[warn(deprecated)] on by default
Nov 18 06:29:41.057 INFO [stderr] 
Nov 18 06:29:43.737 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 12.54s
Nov 18 06:29:43.746 INFO [stderr] su: No module specific data is present
Nov 18 06:29:44.379 INFO running `"docker" "inspect" "bc3b96173e63d139e4b66192ffa3858ba9f4130a503c42df3201619bc983692b"`
Nov 18 06:29:44.615 INFO running `"docker" "rm" "-f" "bc3b96173e63d139e4b66192ffa3858ba9f4130a503c42df3201619bc983692b"`
Nov 18 06:29:44.919 INFO [stdout] bc3b96173e63d139e4b66192ffa3858ba9f4130a503c42df3201619bc983692b
Nov 18 06:29:44.922 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 18 06:29:45.373 INFO [stdout] f931c4114f2d0a5c192088f31e5a42e48673daf3c669602aba820f4e51c8b95b
Nov 18 06:29:45.377 INFO running `"docker" "start" "-a" "f931c4114f2d0a5c192088f31e5a42e48673daf3c669602aba820f4e51c8b95b"`
Nov 18 06:29:46.319 INFO [stderr] usermod: no changes
Nov 18 06:29:46.411 INFO [stderr]    Compiling melo v0.1.0 (/source)
Nov 18 06:29:49.231 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.231 INFO [stderr]   --> tests/compile_to_abc_tests.rs:16:26
Nov 18 06:29:49.231 INFO [stderr]    |
Nov 18 06:29:49.231 INFO [stderr] 16 |             let result = melo::compile_to_abc(source, None).unwrap();
Nov 18 06:29:49.231 INFO [stderr]    |                          ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.231 INFO [stderr] ...
Nov 18 06:29:49.231 INFO [stderr] 23 | test_abc!(simple_drums);
Nov 18 06:29:49.231 INFO [stderr]    | ------------------------ in this macro invocation
Nov 18 06:29:49.231 INFO [stderr]    |
Nov 18 06:29:49.231 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 18 06:29:49.231 INFO [stderr] 
Nov 18 06:29:49.231 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.231 INFO [stderr]   --> tests/compile_to_abc_tests.rs:16:26
Nov 18 06:29:49.231 INFO [stderr]    |
Nov 18 06:29:49.231 INFO [stderr] 16 |             let result = melo::compile_to_abc(source, None).unwrap();
Nov 18 06:29:49.231 INFO [stderr]    |                          ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.231 INFO [stderr] ...
Nov 18 06:29:49.231 INFO [stderr] 24 | test_abc!(variable_drum_bars);
Nov 18 06:29:49.231 INFO [stderr]    | ------------------------------ in this macro invocation
Nov 18 06:29:49.231 INFO [stderr] 
Nov 18 06:29:49.231 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.231 INFO [stderr]   --> tests/compile_to_abc_tests.rs:16:26
Nov 18 06:29:49.231 INFO [stderr]    |
Nov 18 06:29:49.231 INFO [stderr] 16 |             let result = melo::compile_to_abc(source, None).unwrap();
Nov 18 06:29:49.231 INFO [stderr]    |                          ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.231 INFO [stderr] ...
Nov 18 06:29:49.231 INFO [stderr] 25 | test_abc!(variable_stave_drum_bars);
Nov 18 06:29:49.231 INFO [stderr]    | ------------------------------------ in this macro invocation
Nov 18 06:29:49.231 INFO [stderr] 
Nov 18 06:29:49.231 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.231 INFO [stderr]   --> tests/compile_to_abc_tests.rs:16:26
Nov 18 06:29:49.232 INFO [stderr]    |
Nov 18 06:29:49.232 INFO [stderr] 16 |             let result = melo::compile_to_abc(source, None).unwrap();
Nov 18 06:29:49.232 INFO [stderr]    |                          ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.232 INFO [stderr] ...
Nov 18 06:29:49.232 INFO [stderr] 26 | test_abc!(triple_time_expansion);
Nov 18 06:29:49.232 INFO [stderr]    | --------------------------------- in this macro invocation
Nov 18 06:29:49.232 INFO [stderr] 
Nov 18 06:29:49.232 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.232 INFO [stderr]   --> tests/compile_to_abc_tests.rs:16:26
Nov 18 06:29:49.232 INFO [stderr]    |
Nov 18 06:29:49.232 INFO [stderr] 16 |             let result = melo::compile_to_abc(source, None).unwrap();
Nov 18 06:29:49.232 INFO [stderr]    |                          ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.232 INFO [stderr] ...
Nov 18 06:29:49.232 INFO [stderr] 27 | test_abc!(triplets);
Nov 18 06:29:49.232 INFO [stderr]    | -------------------- in this macro invocation
Nov 18 06:29:49.232 INFO [stderr] 
Nov 18 06:29:49.232 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.232 INFO [stderr]   --> tests/compile_to_abc_tests.rs:16:26
Nov 18 06:29:49.232 INFO [stderr]    |
Nov 18 06:29:49.232 INFO [stderr] 16 |             let result = melo::compile_to_abc(source, None).unwrap();
Nov 18 06:29:49.232 INFO [stderr]    |                          ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.232 INFO [stderr] ...
Nov 18 06:29:49.232 INFO [stderr] 28 | test_abc!(quintuplets);
Nov 18 06:29:49.232 INFO [stderr]    | ----------------------- in this macro invocation
Nov 18 06:29:49.232 INFO [stderr] 
Nov 18 06:29:49.232 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.232 INFO [stderr]   --> tests/compile_to_abc_tests.rs:16:26
Nov 18 06:29:49.232 INFO [stderr]    |
Nov 18 06:29:49.232 INFO [stderr] 16 |             let result = melo::compile_to_abc(source, None).unwrap();
Nov 18 06:29:49.232 INFO [stderr]    |                          ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.232 INFO [stderr] ...
Nov 18 06:29:49.232 INFO [stderr] 29 | test_abc!(not_sextuplets);
Nov 18 06:29:49.232 INFO [stderr]    | -------------------------- in this macro invocation
Nov 18 06:29:49.232 INFO [stderr] 
Nov 18 06:29:49.232 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.232 INFO [stderr]   --> tests/compile_to_abc_tests.rs:16:26
Nov 18 06:29:49.232 INFO [stderr]    |
Nov 18 06:29:49.232 INFO [stderr] 16 |             let result = melo::compile_to_abc(source, None).unwrap();
Nov 18 06:29:49.232 INFO [stderr]    |                          ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.232 INFO [stderr] ...
Nov 18 06:29:49.232 INFO [stderr] 30 | test_abc!(voice_args);
Nov 18 06:29:49.232 INFO [stderr]    | ---------------------- in this macro invocation
Nov 18 06:29:49.232 INFO [stderr] 
Nov 18 06:29:49.232 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.232 INFO [stderr]   --> tests/compile_to_abc_tests.rs:16:26
Nov 18 06:29:49.232 INFO [stderr]    |
Nov 18 06:29:49.232 INFO [stderr] 16 |             let result = melo::compile_to_abc(source, None).unwrap();
Nov 18 06:29:49.232 INFO [stderr]    |                          ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.232 INFO [stderr] ...
Nov 18 06:29:49.232 INFO [stderr] 31 | test_abc!(octave_shift);
Nov 18 06:29:49.232 INFO [stderr]    | ------------------------ in this macro invocation
Nov 18 06:29:49.232 INFO [stderr] 
Nov 18 06:29:49.232 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.232 INFO [stderr]   --> tests/compile_to_abc_tests.rs:16:26
Nov 18 06:29:49.232 INFO [stderr]    |
Nov 18 06:29:49.232 INFO [stderr] 16 |             let result = melo::compile_to_abc(source, None).unwrap();
Nov 18 06:29:49.232 INFO [stderr]    |                          ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.232 INFO [stderr] ...
Nov 18 06:29:49.232 INFO [stderr] 32 | test_abc!(simple_melody);
Nov 18 06:29:49.232 INFO [stderr]    | ------------------------- in this macro invocation
Nov 18 06:29:49.232 INFO [stderr] 
Nov 18 06:29:49.232 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.232 INFO [stderr]   --> tests/compile_to_abc_tests.rs:16:26
Nov 18 06:29:49.232 INFO [stderr]    |
Nov 18 06:29:49.232 INFO [stderr] 16 |             let result = melo::compile_to_abc(source, None).unwrap();
Nov 18 06:29:49.232 INFO [stderr]    |                          ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.232 INFO [stderr] ...
Nov 18 06:29:49.232 INFO [stderr] 33 | test_abc!(complex_melody);
Nov 18 06:29:49.232 INFO [stderr]    | -------------------------- in this macro invocation
Nov 18 06:29:49.232 INFO [stderr] 
Nov 18 06:29:49.232 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.232 INFO [stderr]   --> tests/compile_to_abc_tests.rs:16:26
Nov 18 06:29:49.232 INFO [stderr]    |
Nov 18 06:29:49.232 INFO [stderr] 16 |             let result = melo::compile_to_abc(source, None).unwrap();
Nov 18 06:29:49.232 INFO [stderr]    |                          ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.232 INFO [stderr] ...
Nov 18 06:29:49.232 INFO [stderr] 34 | test_abc!(longer_melody);
Nov 18 06:29:49.232 INFO [stderr]    | ------------------------- in this macro invocation
Nov 18 06:29:49.232 INFO [stderr] 
Nov 18 06:29:49.232 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.232 INFO [stderr]   --> tests/compile_to_abc_tests.rs:16:26
Nov 18 06:29:49.232 INFO [stderr]    |
Nov 18 06:29:49.233 INFO [stderr] 16 |             let result = melo::compile_to_abc(source, None).unwrap();
Nov 18 06:29:49.233 INFO [stderr]    |                          ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.233 INFO [stderr] ...
Nov 18 06:29:49.233 INFO [stderr] 35 | test_abc!(fifths);
Nov 18 06:29:49.233 INFO [stderr]    | ------------------ in this macro invocation
Nov 18 06:29:49.233 INFO [stderr] 
Nov 18 06:29:49.591 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.591 INFO [stderr]   --> tests/compile_pieces_to_abc_tests.rs:13:19
Nov 18 06:29:49.591 INFO [stderr]    |
Nov 18 06:29:49.591 INFO [stderr] 13 |             match melo::compile_to_abc(source, Some(filename))
Nov 18 06:29:49.591 INFO [stderr]    |                   ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.591 INFO [stderr] ...
Nov 18 06:29:49.591 INFO [stderr] 26 | test_piece!(minimal_melody);
Nov 18 06:29:49.591 INFO [stderr]    | ---------------------------- in this macro invocation
Nov 18 06:29:49.591 INFO [stderr]    |
Nov 18 06:29:49.591 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 18 06:29:49.591 INFO [stderr] 
Nov 18 06:29:49.591 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.591 INFO [stderr]   --> tests/compile_pieces_to_abc_tests.rs:13:19
Nov 18 06:29:49.591 INFO [stderr]    |
Nov 18 06:29:49.591 INFO [stderr] 13 |             match melo::compile_to_abc(source, Some(filename))
Nov 18 06:29:49.591 INFO [stderr]    |                   ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.591 INFO [stderr] ...
Nov 18 06:29:49.591 INFO [stderr] 27 | test_piece!(minimal_drums);
Nov 18 06:29:49.591 INFO [stderr]    | --------------------------- in this macro invocation
Nov 18 06:29:49.591 INFO [stderr] 
Nov 18 06:29:49.591 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.591 INFO [stderr]   --> tests/compile_pieces_to_abc_tests.rs:13:19
Nov 18 06:29:49.591 INFO [stderr]    |
Nov 18 06:29:49.591 INFO [stderr] 13 |             match melo::compile_to_abc(source, Some(filename))
Nov 18 06:29:49.591 INFO [stderr]    |                   ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.591 INFO [stderr] ...
Nov 18 06:29:49.591 INFO [stderr] 28 | test_piece!(minimal_chords);
Nov 18 06:29:49.591 INFO [stderr]    | ---------------------------- in this macro invocation
Nov 18 06:29:49.591 INFO [stderr] 
Nov 18 06:29:49.591 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.591 INFO [stderr]   --> tests/compile_pieces_to_abc_tests.rs:13:19
Nov 18 06:29:49.591 INFO [stderr]    |
Nov 18 06:29:49.591 INFO [stderr] 13 |             match melo::compile_to_abc(source, Some(filename))
Nov 18 06:29:49.591 INFO [stderr]    |                   ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.591 INFO [stderr] ...
Nov 18 06:29:49.591 INFO [stderr] 29 | test_piece!(multiple_instruments);
Nov 18 06:29:49.591 INFO [stderr]    | ---------------------------------- in this macro invocation
Nov 18 06:29:49.591 INFO [stderr] 
Nov 18 06:29:49.591 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.591 INFO [stderr]   --> tests/compile_pieces_to_abc_tests.rs:13:19
Nov 18 06:29:49.591 INFO [stderr]    |
Nov 18 06:29:49.591 INFO [stderr] 13 |             match melo::compile_to_abc(source, Some(filename))
Nov 18 06:29:49.591 INFO [stderr]    |                   ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.591 INFO [stderr] ...
Nov 18 06:29:49.591 INFO [stderr] 30 | test_piece!(time_and_tempo);
Nov 18 06:29:49.591 INFO [stderr]    | ---------------------------- in this macro invocation
Nov 18 06:29:49.591 INFO [stderr] 
Nov 18 06:29:49.591 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.591 INFO [stderr]   --> tests/compile_pieces_to_abc_tests.rs:13:19
Nov 18 06:29:49.591 INFO [stderr]    |
Nov 18 06:29:49.591 INFO [stderr] 13 |             match melo::compile_to_abc(source, Some(filename))
Nov 18 06:29:49.591 INFO [stderr]    |                   ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.591 INFO [stderr] ...
Nov 18 06:29:49.591 INFO [stderr] 31 | test_piece!(polyrhythms);
Nov 18 06:29:49.591 INFO [stderr]    | ------------------------- in this macro invocation
Nov 18 06:29:49.591 INFO [stderr] 
Nov 18 06:29:49.591 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.591 INFO [stderr]   --> tests/compile_pieces_to_abc_tests.rs:13:19
Nov 18 06:29:49.591 INFO [stderr]    |
Nov 18 06:29:49.591 INFO [stderr] 13 |             match melo::compile_to_abc(source, Some(filename))
Nov 18 06:29:49.591 INFO [stderr]    |                   ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.591 INFO [stderr] ...
Nov 18 06:29:49.591 INFO [stderr] 32 | test_piece!(rondo_alla_turca);
Nov 18 06:29:49.591 INFO [stderr]    | ------------------------------ in this macro invocation
Nov 18 06:29:49.591 INFO [stderr] 
Nov 18 06:29:49.591 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:49.591 INFO [stderr]   --> tests/compile_pieces_to_abc_tests.rs:13:19
Nov 18 06:29:49.591 INFO [stderr]    |
Nov 18 06:29:49.591 INFO [stderr] 13 |             match melo::compile_to_abc(source, Some(filename))
Nov 18 06:29:49.591 INFO [stderr]    |                   ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:49.591 INFO [stderr] ...
Nov 18 06:29:49.591 INFO [stderr] 33 | test_piece!(too_many_staves);
Nov 18 06:29:49.591 INFO [stderr]    | ----------------------------- in this macro invocation
Nov 18 06:29:49.592 INFO [stderr] 
Nov 18 06:29:50.687 INFO [stderr] warning: use of deprecated item 'melo::compile_to_abc'
Nov 18 06:29:50.687 INFO [stderr]    --> src/main.rs:325:18
Nov 18 06:29:50.687 INFO [stderr]     |
Nov 18 06:29:50.687 INFO [stderr] 325 |     let result = melo::compile_to_abc(&source, filename.and_then(Path::to_str))?;
Nov 18 06:29:50.687 INFO [stderr]     |                  ^^^^^^^^^^^^^^^^^^^^
Nov 18 06:29:50.687 INFO [stderr]     |
Nov 18 06:29:50.687 INFO [stderr]     = note: #[warn(deprecated)] on by default
Nov 18 06:29:50.687 INFO [stderr] 
Nov 18 06:29:55.203 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.86s
Nov 18 06:29:55.207 INFO [stderr] su: No module specific data is present
Nov 18 06:29:56.340 INFO running `"docker" "inspect" "f931c4114f2d0a5c192088f31e5a42e48673daf3c669602aba820f4e51c8b95b"`
Nov 18 06:29:56.667 INFO running `"docker" "rm" "-f" "f931c4114f2d0a5c192088f31e5a42e48673daf3c669602aba820f4e51c8b95b"`
Nov 18 06:29:57.023 INFO [stdout] f931c4114f2d0a5c192088f31e5a42e48673daf3c669602aba820f4e51c8b95b
Nov 18 06:29:57.026 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 18 06:29:57.465 INFO [stdout] 1c6ca8a1abb6307a441fbab29c6bf7ba3ec294260a17777acb7aab81766184b8
Nov 18 06:29:57.467 INFO running `"docker" "start" "-a" "1c6ca8a1abb6307a441fbab29c6bf7ba3ec294260a17777acb7aab81766184b8"`
Nov 18 06:29:58.849 INFO [stderr] usermod: no changes
Nov 18 06:29:59.087 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.19s
Nov 18 06:29:59.100 INFO [stderr]      Running /target/debug/deps/melo-19f3783c9b5aeece
Nov 18 06:29:59.101 INFO [stdout] 
Nov 18 06:29:59.101 INFO [stdout] running 101 tests
Nov 18 06:29:59.156 INFO [stdout] test abc_generation::tests::long_notes_in_triplets ... ok
Nov 18 06:29:59.157 INFO [stdout] test abc_generation::tests::rest_across_bars ... ok
Nov 18 06:29:59.161 INFO [stdout] test abc_generation::tests::note_tied_across_triplets ... ok
Nov 18 06:29:59.162 INFO [stdout] test abc_generation::tests::rest_before_chord_not_duplicated ... ok
Nov 18 06:29:59.171 INFO [stdout] test abc_generation::tests::test_eight_notes_in_sequence ... ok
Nov 18 06:29:59.171 INFO [stdout] test abc_generation::tests::test_div_tuplet ... ok
Nov 18 06:29:59.171 INFO [stdout] test abc_generation::tests::test_even_faster_triplets ... ok
Nov 18 06:29:59.172 INFO [stdout] test abc_generation::tests::notes_with_lengths ... ok
Nov 18 06:29:59.175 INFO [stdout] test abc_generation::tests::notes_with_dots ... ok
Nov 18 06:29:59.175 INFO [stdout] test abc_generation::tests::note_tied_across_triplet_bars ... ok
Nov 18 06:29:59.175 INFO [stdout] test abc_generation::tests::large_tuplets_fail ... ok
Nov 18 06:29:59.179 INFO [stdout] test abc_generation::tests::test_four_notes_then_sixteen ... ok
Nov 18 06:29:59.179 INFO [stdout] test abc_generation::tests::test_notes_with_rests ... ok
Nov 18 06:29:59.181 INFO [stdout] test abc_generation::tests::test_sixteen_notes_in_sequence ... ok
Nov 18 06:29:59.182 INFO [stdout] test abc_generation::tests::test_single_note ... ok
Nov 18 06:29:59.182 INFO [stdout] test abc_generation::tests::note_tied_across_bar ... ok
Nov 18 06:29:59.183 INFO [stdout] test abc_generation::tests::test_triplet_in_4_4_time ... ok
Nov 18 06:29:59.184 INFO [stdout] test abc_generation::tests::test_quintuplet_in_4_4_time ... ok
Nov 18 06:29:59.186 INFO [stdout] test abc_generation::tests::test_two_notes_at_once ... ok
Nov 18 06:29:59.186 INFO [stdout] test abc_generation::tests::test_four_notes_in_sequence ... ok
Nov 18 06:29:59.187 INFO [stdout] test abc_generation::tests::test_fast_triplets ... ok
Nov 18 06:29:59.189 INFO [stdout] test abc_generation::tests::test_three_note_bar_in_3_4_time ... ok
Nov 18 06:29:59.195 INFO [stdout] test abc_generation::tests::triplet_chords ... ok
Nov 18 06:29:59.197 INFO [stdout] test lexing::tests::comments_ignored ... ok
Nov 18 06:29:59.197 INFO [stdout] test abc_generation::tests::test_triplets_with_rests ... ok
Nov 18 06:29:59.199 INFO [stdout] test abc_generation::tests::test_triplets_in_3_4_time ... ok
Nov 18 06:29:59.200 INFO [stdout] test lexing::tests::invalid_tokens ... ok
Nov 18 06:29:59.200 INFO [stdout] test lexing::tests::insignificant_whitespace_ignored ... ok
Nov 18 06:29:59.200 INFO [stdout] test lexing::tests::empty_file ... ok
Nov 18 06:29:59.201 INFO [stdout] test abc_generation::tests::test_two_notes_in_sequence ... ok
Nov 18 06:29:59.201 INFO [stdout] test lexing::tests::lex_complex_notes ... ok
Nov 18 06:29:59.207 INFO [stdout] test abc_generation::tests::three_notes_at_once ... ok
Nov 18 06:29:59.226 INFO [stdout] test lexing::tests::lex_multiple_fields ... ok
Nov 18 06:29:59.228 INFO [stdout] test lexing::tests::lex_name_with_spaces ... ok
Nov 18 06:29:59.229 INFO [stdout] test lexing::tests::lex_all_staves_key ... ok
Nov 18 06:29:59.231 INFO [stdout] test lexing::tests::invalid_tokens_in_stave ... ok
Nov 18 06:29:59.240 INFO [stdout] test lexing::tests::lex_part ... ok
Nov 18 06:29:59.243 INFO [stdout] test lexing::tests::lex_numbers ... ok
Nov 18 06:29:59.244 INFO [stdout] test lexing::tests::lex_note_length ... ok
Nov 18 06:29:59.251 INFO [stdout] test lexing::tests::lex_blank_lines ... ok
Nov 18 06:29:59.251 INFO [stdout] test lexing::tests::lex_empty_key ... ok
Nov 18 06:29:59.257 INFO [stdout] test lexing::tests::lex_field_in_block ... ok
Nov 18 06:29:59.258 INFO [stdout] test lexing::tests::lex_note ... ok
Nov 18 06:29:59.264 INFO [stdout] test lexing::tests::lex_piece ... ok
Nov 18 06:29:59.275 INFO [stdout] test lexing::tests::lex_section ... ok
Nov 18 06:29:59.275 INFO [stdout] test lexing::tests::lex_quoted_name_with_quotes_in_it ... ok
Nov 18 06:29:59.275 INFO [stdout] test lexing::tests::lex_play_part ... ok
Nov 18 06:29:59.283 INFO [stdout] test lexing::tests::lex_play ... ok
Nov 18 06:29:59.284 INFO [stdout] test lexing::tests::lex_quoted_name ... ok
Nov 18 06:29:59.285 INFO [stdout] test lexing::tests::right_brace_can_break_stave_within_one_line ... ok
Nov 18 06:29:59.286 INFO [stdout] test lexing::tests::lex_name ... ok
Nov 18 06:29:59.287 INFO [stdout] test notes::tests::round_trip_sharp_conversions ... ok
Nov 18 06:29:59.289 INFO [stdout] test lexing::tests::semicolon_can_break_stave_within_one_line ... ok
Nov 18 06:29:59.291 INFO [stdout] test notes::tests::round_trip_flat_conversions ... ok
Nov 18 06:29:59.295 INFO [stdout] test notes::tests::test_note_to_abc ... ok
Nov 18 06:29:59.295 INFO [stdout] test notes::tests::test_note_to_midi ... ok
Nov 18 06:29:59.306 INFO [stdout] test parsing::tests::fail_on_overflowed_length ... ok
Nov 18 06:29:59.306 INFO [stdout] test parsing::tests::fail_on_unexpected_length ... ok
Nov 18 06:29:59.306 INFO [stdout] test lexing::tests::lex_voice ... ok
Nov 18 06:29:59.315 INFO [stdout] test parsing::tests::parse_attributes_with_trailing_comma ... ok
Nov 18 06:29:59.315 INFO [stdout] test lexing::tests::lex_symbols ... ok
Nov 18 06:29:59.315 INFO [stdout] test lexing::tests::lex_ridiculous_field_name ... ok
Nov 18 06:29:59.315 INFO [stdout] test parsing::tests::fail_to_parse_invalid_attributes ... ok
Nov 18 06:29:59.315 INFO [stdout] test parsing::tests::fail_parsing_too_many_staves_after_blank_line ... ok
Nov 18 06:29:59.315 INFO [stdout] test parsing::tests::fail_on_underflowed_length ... ok
Nov 18 06:29:59.329 INFO [stdout] test parsing::tests::parse_attributes_in_piece ... ok
Nov 18 06:29:59.330 INFO [stdout] test parsing::tests::fail_when_hit_notes_are_encountered_in_incompatible_staves ... ok
Nov 18 06:29:59.334 INFO [stdout] test parsing::tests::parse_attributes_without_commas ... ok
Nov 18 06:29:59.334 INFO [stdout] test parsing::tests::parse_empty_file ... ok
Nov 18 06:29:59.339 INFO [stdout] test parsing::tests::parse_multiple_empty_pieces ... ok
Nov 18 06:29:59.340 INFO [stdout] test parsing::tests::parse_empty_play_node ... ok
Nov 18 06:29:59.355 INFO [stdout] test parsing::tests::parse_empty_piece ... ok
Nov 18 06:29:59.356 INFO [stdout] test parsing::tests::parse_empty_voice ... ok
Nov 18 06:29:59.360 INFO [stdout] test parsing::tests::parse_play_node_with_extra_barlines ... ok
Nov 18 06:29:59.373 INFO [stdout] test parsing::tests::parse_play_node_with_stave ... ok
Nov 18 06:29:59.380 INFO [stdout] test parsing::tests::parse_note_with_length ... ok
Nov 18 06:29:59.381 INFO [stdout] test parsing::tests::parse_play_node_with_melody_notes ... ok
Nov 18 06:29:59.381 INFO [stdout] test parsing::tests::parse_empty_voiceless_play_node ... ok
Nov 18 06:29:59.381 INFO [stdout] test parsing::tests::parse_multiple_concurrent_melody_lines ... ok
Nov 18 06:29:59.382 INFO [stdout] test parsing::tests::parse_valueless_attribute ... ok
Nov 18 06:29:59.382 INFO [stdout] test parsing::tests::parse_play_node_with_two_staves ... ok
Nov 18 06:29:59.394 INFO [stdout] test sequencing::tests::dots_do_not_carry_across_staves ... ok
Nov 18 06:29:59.395 INFO [stdout] test parsing::tests::parse_multiple_concurrent_melody_lines_broken_up_by_blank_line ... ok
Nov 18 06:29:59.396 INFO [stdout] test parsing::tests::parse_play_node_with_percussive_notes ... ok
Nov 18 06:29:59.398 INFO [stdout] test parsing::tests::parse_stave_split_over_multiple_lines ... ok
Nov 18 06:29:59.399 INFO [stdout] test parsing::tests::parse_rest_with_length ... ok
Nov 18 06:29:59.401 INFO [stdout] test parsing::tests::parse_voice_attributes ... ok
Nov 18 06:29:59.404 INFO [stdout] test sequencing::tests::fail_when_notes_moved_out_of_range ... ok
Nov 18 06:29:59.405 INFO [stdout] test sequencing::tests::piece_with_empty_voice ... ok
Nov 18 06:29:59.407 INFO [stdout] test sequencing::tests::notes_can_be_tied_across_bars ... ok
Nov 18 06:29:59.415 INFO [stdout] test sequencing::tests::voice_with_note_lengths ... ok
Nov 18 06:29:59.416 INFO [stdout] test sequencing::tests::piece_with_attributes ... ok
Nov 18 06:29:59.418 INFO [stdout] test sequencing::tests::threes_against_twos ... ok
Nov 18 06:29:59.421 INFO [stdout] test sequencing::tests::voice_with_two_notes ... ok
Nov 18 06:29:59.424 INFO [stdout] test sequencing::tests::voice_with_single_note ... ok
Nov 18 06:29:59.427 INFO [stdout] test sequencing::tests::voice_with_two_staves ... ok
Nov 18 06:29:59.428 INFO [stdout] test sequencing::tests::voice_with_dots ... ok
Nov 18 06:29:59.433 INFO [stdout] test sequencing::tests::sequence_empty_piece ... ok
Nov 18 06:29:59.438 INFO [stdout] test sequencing::tests::voice_with_mismatched_play ... ok
Nov 18 06:29:59.439 INFO [stdout] test sequencing::tests::voice_with_leading_dots ... ok
Nov 18 06:29:59.492 INFO [stdout] test parsing::tests::parse_empty_piece_with_trailing_tokens_fails ... ok
Nov 18 06:29:59.492 INFO [stdout] 
Nov 18 06:29:59.493 INFO [stdout] test result: ok. 101 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 06:29:59.493 INFO [stdout] 
Nov 18 06:29:59.498 INFO [stderr]      Running /target/debug/deps/melo-9b5885385af78dc1
Nov 18 06:29:59.502 INFO [stderr]      Running /target/debug/deps/compile_pieces_to_abc_tests-412deb0f670ba028
Nov 18 06:29:59.503 INFO [stdout] 
Nov 18 06:29:59.503 INFO [stdout] running 0 tests
Nov 18 06:29:59.503 INFO [stdout] 
Nov 18 06:29:59.503 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 06:29:59.503 INFO [stdout] 
Nov 18 06:29:59.503 INFO [stdout] 
Nov 18 06:29:59.503 INFO [stdout] running 8 tests
Nov 18 06:29:59.639 INFO [stdout] test minimal_melody ... ok
Nov 18 06:29:59.642 INFO [stdout] test minimal_chords ... ok
Nov 18 06:29:59.683 INFO [stdout] test minimal_drums ... ok
Nov 18 06:29:59.684 INFO [stdout] test multiple_instruments ... ok
Nov 18 06:29:59.684 INFO [stdout] test too_many_staves ... ok
Nov 18 06:29:59.684 INFO [stdout] test polyrhythms ... ok
Nov 18 06:29:59.685 INFO [stdout] test time_and_tempo ... ok
Nov 18 06:29:59.735 INFO [stdout] test rondo_alla_turca ... ok
Nov 18 06:29:59.735 INFO [stdout] 
Nov 18 06:29:59.736 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 06:29:59.736 INFO [stdout] 
Nov 18 06:29:59.736 INFO [stderr]      Running /target/debug/deps/compile_to_abc_tests-01052d3f3898d2f6
Nov 18 06:29:59.782 INFO [stdout] 
Nov 18 06:29:59.782 INFO [stdout] running 13 tests
Nov 18 06:29:59.822 INFO [stdout] test complex_melody ... ok
Nov 18 06:29:59.858 INFO [stdout] test longer_melody ... ok
Nov 18 06:29:59.876 INFO [stdout] test triple_time_expansion ... ok
Nov 18 06:29:59.880 INFO [stdout] test quintuplets ... ok
Nov 18 06:29:59.880 INFO [stdout] test triplets ... ok
Nov 18 06:29:59.887 INFO [stdout] test not_sextuplets ... ok
Nov 18 06:29:59.898 INFO [stdout] test voice_args ... ok
Nov 18 06:29:59.901 INFO [stdout] test fifths ... ok
Nov 18 06:29:59.901 INFO [stdout] test simple_melody ... ok
Nov 18 06:29:59.954 INFO [stdout] test octave_shift ... ok
Nov 18 06:29:59.954 INFO [stdout] test variable_stave_drum_bars ... ok
Nov 18 06:29:59.954 INFO [stdout] test simple_drums ... ok
Nov 18 06:29:59.955 INFO [stdout] test variable_drum_bars ... ok
Nov 18 06:29:59.955 INFO [stdout] 
Nov 18 06:29:59.955 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 06:29:59.956 INFO [stdout] 
Nov 18 06:29:59.956 INFO [stderr]    Doc-tests melo
Nov 18 06:30:03.367 INFO [stdout] 
Nov 18 06:30:03.367 INFO [stdout] running 0 tests
Nov 18 06:30:03.367 INFO [stdout] 
Nov 18 06:30:03.367 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 06:30:03.367 INFO [stdout] 
Nov 18 06:30:03.383 INFO [stderr] su: No module specific data is present
Nov 18 06:30:03.927 INFO running `"docker" "inspect" "1c6ca8a1abb6307a441fbab29c6bf7ba3ec294260a17777acb7aab81766184b8"`
Nov 18 06:30:04.085 INFO running `"docker" "rm" "-f" "1c6ca8a1abb6307a441fbab29c6bf7ba3ec294260a17777acb7aab81766184b8"`
Nov 18 06:30:04.188 INFO [stdout] 1c6ca8a1abb6307a441fbab29c6bf7ba3ec294260a17777acb7aab81766184b8