Nov 01 19:22:01.066 INFO testing Mistodon/melo against 1.30.0 for beta-1.31-1
Nov 01 19:22:01.067 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-5/1.30.0:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-1/1.30.0:/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 +1.30.0 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 01 19:22:01.470 INFO blam! 285d115e2350da2d0b004f24aa4b66264ff8fca3a1cc90c32f6f115b88f23c9d
Nov 01 19:22:01.472 INFO running `"docker" "start" "-a" "285d115e2350da2d0b004f24aa4b66264ff8fca3a1cc90c32f6f115b88f23c9d"`
Nov 01 19:22:02.491 INFO kablam! usermod: no changes
Nov 01 19:22:02.631 INFO kablam!    Compiling num-bigint v0.1.41
Nov 01 19:22:02.632 INFO kablam!    Compiling uuid v0.1.18
Nov 01 19:22:02.633 INFO kablam!    Compiling structopt v0.1.7
Nov 01 19:22:03.951 INFO kablam!    Compiling mktemp v0.3.1
Nov 01 19:22:05.888 INFO kablam!    Compiling num-rational v0.1.41
Nov 01 19:22:07.748 INFO kablam!    Compiling num v0.1.41
Nov 01 19:22:08.484 INFO kablam!    Compiling rimd v0.0.1
Nov 01 19:22:10.620 INFO kablam!    Compiling melo v0.1.0 (/source)
Nov 01 19:22:21.055 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 18.53s
Nov 01 19:22:21.067 INFO kablam! su: No module specific data is present
Nov 01 19:22:21.806 INFO running `"docker" "rm" "-f" "285d115e2350da2d0b004f24aa4b66264ff8fca3a1cc90c32f6f115b88f23c9d"`
Nov 01 19:22:22.119 INFO blam! 285d115e2350da2d0b004f24aa4b66264ff8fca3a1cc90c32f6f115b88f23c9d
Nov 01 19:22:22.128 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-5/1.30.0:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-1/1.30.0:/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 +1.30.0 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 01 19:22:22.535 INFO blam! 796057ca9fb796445efcd494ed36ab44d94e591bd4b4b0848bbedd2cba1e24a7
Nov 01 19:22:22.544 INFO running `"docker" "start" "-a" "796057ca9fb796445efcd494ed36ab44d94e591bd4b4b0848bbedd2cba1e24a7"`
Nov 01 19:22:24.210 INFO kablam! usermod: no changes
Nov 01 19:22:24.437 INFO kablam!    Compiling pretty_assertions v0.4.1
Nov 01 19:22:25.358 INFO kablam!    Compiling melo v0.1.0 (/source)
Nov 01 19:22:32.979 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 8.74s
Nov 01 19:22:32.989 INFO kablam! su: No module specific data is present
Nov 01 19:22:33.413 INFO running `"docker" "rm" "-f" "796057ca9fb796445efcd494ed36ab44d94e591bd4b4b0848bbedd2cba1e24a7"`
Nov 01 19:22:33.696 INFO blam! 796057ca9fb796445efcd494ed36ab44d94e591bd4b4b0848bbedd2cba1e24a7
Nov 01 19:22:33.699 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-5/1.30.0:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-1/1.30.0:/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 +1.30.0 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 01 19:22:33.995 INFO blam! ddf42297a5faff6427e512e15b715be24db8da36c39e1e15368f76ccd40ea4a8
Nov 01 19:22:33.997 INFO running `"docker" "start" "-a" "ddf42297a5faff6427e512e15b715be24db8da36c39e1e15368f76ccd40ea4a8"`
Nov 01 19:22:34.855 INFO kablam! usermod: no changes
Nov 01 19:22:34.975 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.08s
Nov 01 19:22:34.992 INFO kablam!      Running /target/debug/deps/melo-95ff9685d78b217a
Nov 01 19:22:35.003 INFO blam! 
Nov 01 19:22:35.004 INFO blam! running 108 tests
Nov 01 19:22:35.049 INFO blam! test abc_generation::tests::large_tuplets_fail ... ok
Nov 01 19:22:35.049 INFO blam! test abc_generation::tests::rest_across_bars ... ok
Nov 01 19:22:35.050 INFO blam! test abc_generation::tests::test_div_tuplet ... ok
Nov 01 19:22:35.050 INFO blam! test abc_generation::tests::note_tied_across_triplet_bars ... ok
Nov 01 19:22:35.050 INFO blam! test abc_generation::tests::note_tied_across_bar ... ok
Nov 01 19:22:35.050 INFO blam! test abc_generation::tests::rest_before_chord_not_duplicated ... ok
Nov 01 19:22:35.051 INFO blam! test abc_generation::tests::notes_with_dots ... ok
Nov 01 19:22:35.051 INFO blam! test abc_generation::tests::long_notes_in_triplets ... ok
Nov 01 19:22:35.055 INFO blam! test abc_generation::tests::test_eight_notes_in_sequence ... ok
Nov 01 19:22:35.055 INFO blam! test abc_generation::tests::test_four_notes_in_sequence ... ok
Nov 01 19:22:35.056 INFO blam! test abc_generation::tests::notes_with_lengths ... ok
Nov 01 19:22:35.057 INFO blam! test abc_generation::tests::test_even_faster_triplets ... ok
Nov 01 19:22:35.057 INFO blam! test abc_generation::tests::test_notes_with_rests ... ok
Nov 01 19:22:35.059 INFO blam! test abc_generation::tests::note_tied_across_triplets ... ok
Nov 01 19:22:35.069 INFO blam! test abc_generation::tests::test_quintuplet_in_4_4_time ... ok
Nov 01 19:22:35.069 INFO blam! test abc_generation::tests::test_sixteen_notes_in_sequence ... ok
Nov 01 19:22:35.069 INFO blam! test abc_generation::tests::test_fast_triplets ... ok
Nov 01 19:22:35.071 INFO blam! test abc_generation::tests::test_triplet_in_4_4_time ... ok
Nov 01 19:22:35.075 INFO blam! test abc_generation::tests::test_single_note ... ok
Nov 01 19:22:35.075 INFO blam! test abc_generation::tests::test_triplets_with_rests ... ok
Nov 01 19:22:35.075 INFO blam! test abc_generation::tests::three_notes_at_once ... ok
Nov 01 19:22:35.080 INFO blam! test abc_generation::tests::test_three_note_bar_in_3_4_time ... ok
Nov 01 19:22:35.081 INFO blam! test abc_generation::tests::test_two_notes_at_once ... ok
Nov 01 19:22:35.084 INFO blam! test abc_generation::tests::triplet_chords ... ok
Nov 01 19:22:35.084 INFO blam! test abc_generation::tests::test_four_notes_then_sixteen ... ok
Nov 01 19:22:35.085 INFO blam! test abc_generation::tests::test_triplets_in_3_4_time ... ok
Nov 01 19:22:35.086 INFO blam! test abc_generation::tests::test_two_notes_in_sequence ... ok
Nov 01 19:22:35.088 INFO blam! test lexing::tests::insignificant_whitespace_ignored ... ok
Nov 01 19:22:35.089 INFO blam! test lexing::tests::empty_file ... ok
Nov 01 19:22:35.091 INFO blam! test lexing::tests::comments_ignored ... ok
Nov 01 19:22:35.091 INFO blam! test lexing::tests::invalid_tokens ... ok
Nov 01 19:22:35.091 INFO blam! test lexing::tests::lex_blank_lines ... ok
Nov 01 19:22:35.091 INFO blam! test lexing::tests::lex_complex_notes ... ok
Nov 01 19:22:35.092 INFO blam! test lexing::tests::invalid_tokens_in_stave ... ok
Nov 01 19:22:35.092 INFO blam! test lexing::tests::lex_note ... ok
Nov 01 19:22:35.093 INFO blam! test lexing::tests::lex_name_with_spaces ... ok
Nov 01 19:22:35.098 INFO blam! test lexing::tests::lex_numbers ... ok
Nov 01 19:22:35.104 INFO blam! test lexing::tests::lex_multiple_fields ... ok
Nov 01 19:22:35.104 INFO blam! test lexing::tests::lex_field_in_block ... ok
Nov 01 19:22:35.106 INFO blam! test lexing::tests::lex_name ... ok
Nov 01 19:22:35.106 INFO blam! test lexing::tests::lex_part ... ok
Nov 01 19:22:35.111 INFO blam! test lexing::tests::lex_note_length ... ok
Nov 01 19:22:35.111 INFO blam! test lexing::tests::lex_empty_key ... ok
Nov 01 19:22:35.115 INFO blam! test lexing::tests::lex_piece ... ok
Nov 01 19:22:35.115 INFO blam! test lexing::tests::lex_all_staves_key ... ok
Nov 01 19:22:35.123 INFO blam! test lexing::tests::lex_quoted_name ... ok
Nov 01 19:22:35.123 INFO blam! test lexing::tests::lex_section ... ok
Nov 01 19:22:35.123 INFO blam! test lexing::tests::lex_quoted_name_with_quotes_in_it ... ok
Nov 01 19:22:35.124 INFO blam! test notes::tests::round_trip_flat_conversions ... ok
Nov 01 19:22:35.125 INFO blam! test notes::tests::round_trip_sharp_conversions ... ok
Nov 01 19:22:35.125 INFO blam! test notes::tests::test_lcm ... ok
Nov 01 19:22:35.125 INFO blam! test notes::tests::test_note_to_abc ... ok
Nov 01 19:22:35.131 INFO blam! test lexing::tests::semicolon_can_break_stave_within_one_line ... ok
Nov 01 19:22:35.133 INFO blam! test notes::tests::test_note_to_midi ... ok
Nov 01 19:22:35.133 INFO blam! test parsing::tests::fail_on_overflowed_length ... ok
Nov 01 19:22:35.135 INFO blam! test lexing::tests::lex_symbols ... ok
Nov 01 19:22:35.141 INFO blam! test lexing::tests::lex_play ... ok
Nov 01 19:22:35.141 INFO blam! test lexing::tests::lex_voice ... ok
Nov 01 19:22:35.141 INFO blam! test lexing::tests::lex_play_part ... ok
Nov 01 19:22:35.141 INFO blam! test parsing::tests::fail_parsing_too_many_staves_after_blank_line ... ok
Nov 01 19:22:35.142 INFO blam! test lexing::tests::right_brace_can_break_stave_within_one_line ... ok
Nov 01 19:22:35.144 INFO blam! test lexing::tests::lex_ridiculous_field_name ... ok
Nov 01 19:22:35.151 INFO blam! test parsing::tests::fail_on_unexpected_length ... ok
Nov 01 19:22:35.151 INFO blam! test parsing::tests::fail_when_notes_after_repeat_sign ... ok
Nov 01 19:22:35.171 INFO blam! test parsing::tests::fail_on_underflowed_length ... ok
Nov 01 19:22:35.171 INFO blam! test parsing::tests::fail_to_parse_invalid_attributes ... ok
Nov 01 19:22:35.171 INFO blam! test parsing::tests::parse_attributes_in_piece ... ok
Nov 01 19:22:35.171 INFO blam! test parsing::tests::fail_when_notes_before_repeat_sign ... ok
Nov 01 19:22:35.171 INFO blam! test parsing::tests::parse_attributes_with_trailing_comma ... ok
Nov 01 19:22:35.171 INFO blam! test parsing::tests::fail_when_hit_notes_are_encountered_in_incompatible_staves ... ok
Nov 01 19:22:35.175 INFO blam! test parsing::tests::parse_empty_file ... ok
Nov 01 19:22:35.175 INFO blam! test parsing::tests::parse_attributes_without_commas ... ok
Nov 01 19:22:35.191 INFO blam! test parsing::tests::parse_empty_piece ... ok
Nov 01 19:22:35.191 INFO blam! test parsing::tests::parse_empty_voiceless_play_node ... ok
Nov 01 19:22:35.191 INFO blam! test parsing::tests::parse_multiple_concurrent_melody_lines ... ok
Nov 01 19:22:35.203 INFO blam! test parsing::tests::parse_play_node_with_melody_notes ... ok
Nov 01 19:22:35.203 INFO blam! test parsing::tests::parse_note_with_length ... ok
Nov 01 19:22:35.203 INFO blam! test parsing::tests::parse_empty_voice ... ok
Nov 01 19:22:35.203 INFO blam! test parsing::tests::parse_empty_play_node ... ok
Nov 01 19:22:35.203 INFO blam! test parsing::tests::parse_play_node_with_extra_barlines ... ok
Nov 01 19:22:35.203 INFO blam! test parsing::tests::parse_multiple_empty_pieces ... ok
Nov 01 19:22:35.203 INFO blam! test parsing::tests::parse_play_node_with_two_staves ... ok
Nov 01 19:22:35.205 INFO blam! test parsing::tests::parse_multiple_concurrent_melody_lines_broken_up_by_blank_line ... ok
Nov 01 19:22:35.219 INFO blam! test parsing::tests::parse_repeat ... ok
Nov 01 19:22:35.238 INFO blam! test parsing::tests::parse_stave_split_over_multiple_lines ... ok
Nov 01 19:22:35.239 INFO blam! test sequencing::tests::dots_do_not_carry_across_staves ... ok
Nov 01 19:22:35.239 INFO blam! test parsing::tests::parse_play_node_with_stave ... ok
Nov 01 19:22:35.239 INFO blam! test parsing::tests::parse_play_node_with_percussive_notes ... ok
Nov 01 19:22:35.240 INFO blam! test parsing::tests::parse_voice_attributes ... ok
Nov 01 19:22:35.243 INFO blam! test parsing::tests::parse_valueless_attribute ... ok
Nov 01 19:22:35.245 INFO blam! test sequencing::tests::repeat_bars ... ok
Nov 01 19:22:35.245 INFO blam! test sequencing::tests::fail_first_bar_repeat ... ok
Nov 01 19:22:35.245 INFO blam! test parsing::tests::parse_rest_with_length ... ok
Nov 01 19:22:35.245 INFO blam! test sequencing::tests::fail_when_notes_moved_out_of_range ... ok
Nov 01 19:22:35.246 INFO blam! test sequencing::tests::notes_can_be_tied_across_bars ... ok
Nov 01 19:22:35.247 INFO blam! test sequencing::tests::piece_with_attributes ... ok
Nov 01 19:22:35.249 INFO blam! test sequencing::tests::voice_with_leading_dots ... ok
Nov 01 19:22:35.256 INFO blam! test sequencing::tests::voice_with_mismatched_play ... ok
Nov 01 19:22:35.257 INFO blam! test sequencing::tests::piece_with_empty_voice ... ok
Nov 01 19:22:35.270 INFO blam! test sequencing::tests::voice_with_note_lengths ... ok
Nov 01 19:22:35.270 INFO blam! test sequencing::tests::sequence_empty_piece ... ok
Nov 01 19:22:35.271 INFO blam! test sequencing::tests::threes_against_twos ... ok
Nov 01 19:22:35.271 INFO blam! test sequencing::tests::voice_with_dots ... ok
Nov 01 19:22:35.271 INFO blam! test sequencing::tests::voice_with_single_note ... ok
Nov 01 19:22:35.283 INFO blam! test sequencing::tests::voice_with_two_notes ... ok
Nov 01 19:22:35.283 INFO blam! test sequencing::tests::repeat_bars_twice ... ok
Nov 01 19:22:35.295 INFO blam! test sequencing::tests::voice_with_two_staves ... ok
Nov 01 19:22:35.311 INFO blam! test parsing::tests::parse_empty_piece_with_trailing_tokens_fails ... ok
Nov 01 19:22:35.311 INFO kablam!      Running /target/debug/deps/melo-42babe967b028248
Nov 01 19:22:35.311 INFO blam! 
Nov 01 19:22:35.311 INFO blam! test result: ok. 108 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 19:22:35.311 INFO blam! 
Nov 01 19:22:35.334 INFO blam! 
Nov 01 19:22:35.334 INFO kablam!      Running /target/debug/deps/compile_pieces_to_abc_tests-bc14f7dd60c3dc8a
Nov 01 19:22:35.334 INFO blam! running 0 tests
Nov 01 19:22:35.334 INFO blam! 
Nov 01 19:22:35.334 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 19:22:35.334 INFO blam! 
Nov 01 19:22:35.334 INFO blam! 
Nov 01 19:22:35.334 INFO blam! running 9 tests
Nov 01 19:22:35.475 INFO blam! test minimal_melody ... ok
Nov 01 19:22:35.478 INFO blam! test minimal_drums ... ok
Nov 01 19:22:35.479 INFO blam! test polyrhythms ... ok
Nov 01 19:22:35.479 INFO blam! test minimal_chords ... ok
Nov 01 19:22:35.485 INFO blam! test multiple_instruments ... ok
Nov 01 19:22:35.490 INFO blam! test repeats ... ok
Nov 01 19:22:35.490 INFO blam! test time_and_tempo ... ok
Nov 01 19:22:35.519 INFO blam! test too_many_staves ... ok
Nov 01 19:22:35.571 INFO blam! test rondo_alla_turca ... ok
Nov 01 19:22:35.571 INFO kablam!      Running /target/debug/deps/compile_to_abc_tests-097e873442a055cd
Nov 01 19:22:35.571 INFO blam! 
Nov 01 19:22:35.571 INFO blam! test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 19:22:35.571 INFO blam! 
Nov 01 19:22:35.579 INFO blam! 
Nov 01 19:22:35.579 INFO blam! running 13 tests
Nov 01 19:22:35.635 INFO blam! test fifths ... ok
Nov 01 19:22:35.651 INFO blam! test triple_time_expansion ... ok
Nov 01 19:22:35.655 INFO blam! test quintuplets ... ok
Nov 01 19:22:35.664 INFO blam! test triplets ... ok
Nov 01 19:22:35.664 INFO blam! test octave_shift ... ok
Nov 01 19:22:35.664 INFO blam! test variable_drum_bars ... ok
Nov 01 19:22:35.664 INFO blam! test complex_melody ... ok
Nov 01 19:22:35.665 INFO blam! test simple_melody ... ok
Nov 01 19:22:35.665 INFO blam! test not_sextuplets ... ok
Nov 01 19:22:35.665 INFO blam! test simple_drums ... ok
Nov 01 19:22:35.671 INFO blam! test voice_args ... ok
Nov 01 19:22:35.672 INFO blam! test longer_melody ... ok
Nov 01 19:22:35.675 INFO blam! test variable_stave_drum_bars ... ok
Nov 01 19:22:35.676 INFO blam! 
Nov 01 19:22:35.676 INFO blam! test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 19:22:35.676 INFO blam! 
Nov 01 19:22:35.683 INFO kablam!    Doc-tests melo
Nov 01 19:22:38.646 INFO blam! 
Nov 01 19:22:38.646 INFO blam! running 0 tests
Nov 01 19:22:38.646 INFO blam! 
Nov 01 19:22:38.646 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 19:22:38.646 INFO blam! 
Nov 01 19:22:38.667 INFO kablam! su: No module specific data is present
Nov 01 19:22:39.863 INFO running `"docker" "rm" "-f" "ddf42297a5faff6427e512e15b715be24db8da36c39e1e15368f76ccd40ea4a8"`
Nov 01 19:22:40.171 INFO blam! ddf42297a5faff6427e512e15b715be24db8da36c39e1e15368f76ccd40ea4a8
