Nov 01 19:21:56.060 INFO testing Mistodon/melo against beta-2018-10-30 for beta-1.31-1
Nov 01 19:21:56.061 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-6/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 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:21:56.618 INFO blam! 3a01ea1b32479d851ef00cce0fc2833d2751f26cabeb4d9e3674e172de566251
Nov 01 19:21:56.618 INFO running `"docker" "start" "-a" "3a01ea1b32479d851ef00cce0fc2833d2751f26cabeb4d9e3674e172de566251"`
Nov 01 19:21:57.135 INFO kablam! usermod: no changes
Nov 01 19:21:57.250 INFO kablam!    Compiling uuid v0.1.18
Nov 01 19:21:57.250 INFO kablam!    Compiling structopt-derive v0.1.6
Nov 01 19:21:57.250 INFO kablam!    Compiling rimd v0.0.1
Nov 01 19:21:58.403 INFO kablam!    Compiling mktemp v0.3.1
Nov 01 19:22:02.660 INFO kablam!    Compiling melo v0.1.0 (/source)
Nov 01 19:22:12.164 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 15.01s
Nov 01 19:22:12.172 INFO kablam! su: No module specific data is present
Nov 01 19:22:12.481 INFO running `"docker" "rm" "-f" "3a01ea1b32479d851ef00cce0fc2833d2751f26cabeb4d9e3674e172de566251"`
Nov 01 19:22:12.599 INFO blam! 3a01ea1b32479d851ef00cce0fc2833d2751f26cabeb4d9e3674e172de566251
Nov 01 19:22:12.601 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-6/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 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:12.854 INFO blam! e03150c774b5b8524ee9da6567952370540de253dc5ed54593c154c91da4e0bb
Nov 01 19:22:12.856 INFO running `"docker" "start" "-a" "e03150c774b5b8524ee9da6567952370540de253dc5ed54593c154c91da4e0bb"`
Nov 01 19:22:14.487 INFO kablam! usermod: no changes
Nov 01 19:22:14.643 INFO kablam!    Compiling pretty_assertions v0.4.1
Nov 01 19:22:15.671 INFO kablam!    Compiling melo v0.1.0 (/source)
Nov 01 19:22:25.731 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 11.21s
Nov 01 19:22:25.740 INFO kablam! su: No module specific data is present
Nov 01 19:22:26.467 INFO running `"docker" "rm" "-f" "e03150c774b5b8524ee9da6567952370540de253dc5ed54593c154c91da4e0bb"`
Nov 01 19:22:26.739 INFO blam! e03150c774b5b8524ee9da6567952370540de253dc5ed54593c154c91da4e0bb
Nov 01 19:22:26.741 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-6/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 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:27.132 INFO blam! 50cec6ad672ea765c4ca5541a52593a987a35c0b5c82bf62f853cde779126685
Nov 01 19:22:27.135 INFO running `"docker" "start" "-a" "50cec6ad672ea765c4ca5541a52593a987a35c0b5c82bf62f853cde779126685"`
Nov 01 19:22:28.627 INFO kablam! usermod: no changes
Nov 01 19:22:28.807 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.15s
Nov 01 19:22:28.808 INFO kablam!      Running /target/debug/deps/melo-53ff10bad7230d39
Nov 01 19:22:28.811 INFO blam! 
Nov 01 19:22:28.811 INFO blam! running 108 tests
Nov 01 19:22:28.919 INFO blam! test abc_generation::tests::notes_with_lengths ... ok
Nov 01 19:22:28.927 INFO blam! test abc_generation::tests::rest_before_chord_not_duplicated ... ok
Nov 01 19:22:28.931 INFO blam! test abc_generation::tests::long_notes_in_triplets ... ok
Nov 01 19:22:28.943 INFO blam! test abc_generation::tests::test_eight_notes_in_sequence ... ok
Nov 01 19:22:28.943 INFO blam! test abc_generation::tests::test_div_tuplet ... ok
Nov 01 19:22:28.943 INFO blam! test abc_generation::tests::note_tied_across_bar ... ok
Nov 01 19:22:28.951 INFO blam! test abc_generation::tests::test_fast_triplets ... ok
Nov 01 19:22:28.951 INFO blam! test abc_generation::tests::test_even_faster_triplets ... ok
Nov 01 19:22:28.951 INFO blam! test abc_generation::tests::test_four_notes_in_sequence ... ok
Nov 01 19:22:28.955 INFO blam! test abc_generation::tests::note_tied_across_triplets ... ok
Nov 01 19:22:28.955 INFO blam! test abc_generation::tests::rest_across_bars ... ok
Nov 01 19:22:28.959 INFO blam! test abc_generation::tests::large_tuplets_fail ... ok
Nov 01 19:22:28.959 INFO blam! test abc_generation::tests::test_four_notes_then_sixteen ... ok
Nov 01 19:22:28.959 INFO blam! test abc_generation::tests::note_tied_across_triplet_bars ... ok
Nov 01 19:22:28.963 INFO blam! test abc_generation::tests::notes_with_dots ... ok
Nov 01 19:22:28.967 INFO blam! test abc_generation::tests::test_quintuplet_in_4_4_time ... ok
Nov 01 19:22:28.967 INFO blam! test abc_generation::tests::test_single_note ... ok
Nov 01 19:22:28.967 INFO blam! test abc_generation::tests::test_sixteen_notes_in_sequence ... ok
Nov 01 19:22:28.967 INFO blam! test abc_generation::tests::test_notes_with_rests ... ok
Nov 01 19:22:28.971 INFO blam! test abc_generation::tests::test_triplet_in_4_4_time ... ok
Nov 01 19:22:28.971 INFO blam! test abc_generation::tests::test_three_note_bar_in_3_4_time ... ok
Nov 01 19:22:28.975 INFO blam! test abc_generation::tests::test_triplets_in_3_4_time ... ok
Nov 01 19:22:28.975 INFO blam! test abc_generation::tests::test_two_notes_in_sequence ... ok
Nov 01 19:22:28.975 INFO blam! test abc_generation::tests::test_triplets_with_rests ... ok
Nov 01 19:22:28.979 INFO blam! test abc_generation::tests::triplet_chords ... ok
Nov 01 19:22:28.979 INFO blam! test abc_generation::tests::test_two_notes_at_once ... ok
Nov 01 19:22:28.979 INFO blam! test lexing::tests::empty_file ... ok
Nov 01 19:22:28.983 INFO blam! test lexing::tests::comments_ignored ... ok
Nov 01 19:22:28.983 INFO blam! test abc_generation::tests::three_notes_at_once ... ok
Nov 01 19:22:28.983 INFO blam! test lexing::tests::invalid_tokens ... ok
Nov 01 19:22:28.983 INFO blam! test lexing::tests::insignificant_whitespace_ignored ... ok
Nov 01 19:22:28.987 INFO blam! test lexing::tests::lex_all_staves_key ... ok
Nov 01 19:22:28.987 INFO blam! test lexing::tests::lex_blank_lines ... ok
Nov 01 19:22:28.995 INFO blam! test lexing::tests::invalid_tokens_in_stave ... ok
Nov 01 19:22:28.995 INFO blam! test lexing::tests::lex_complex_notes ... ok
Nov 01 19:22:28.995 INFO blam! test lexing::tests::lex_empty_key ... ok
Nov 01 19:22:28.995 INFO blam! test lexing::tests::lex_name ... ok
Nov 01 19:22:28.995 INFO blam! test lexing::tests::lex_note ... ok
Nov 01 19:22:28.999 INFO blam! test lexing::tests::lex_multiple_fields ... ok
Nov 01 19:22:29.003 INFO blam! test lexing::tests::lex_play ... ok
Nov 01 19:22:29.004 INFO blam! test lexing::tests::lex_name_with_spaces ... ok
Nov 01 19:22:29.005 INFO blam! test lexing::tests::lex_piece ... ok
Nov 01 19:22:29.011 INFO blam! test lexing::tests::lex_quoted_name ... ok
Nov 01 19:22:29.013 INFO blam! test lexing::tests::lex_field_in_block ... ok
Nov 01 19:22:29.014 INFO blam! test lexing::tests::lex_play_part ... ok
Nov 01 19:22:29.014 INFO blam! test lexing::tests::lex_ridiculous_field_name ... ok
Nov 01 19:22:29.016 INFO blam! test lexing::tests::lex_numbers ... ok
Nov 01 19:22:29.016 INFO blam! test lexing::tests::lex_note_length ... ok
Nov 01 19:22:29.016 INFO blam! test lexing::tests::lex_part ... ok
Nov 01 19:22:29.016 INFO blam! test lexing::tests::lex_quoted_name_with_quotes_in_it ... ok
Nov 01 19:22:29.023 INFO blam! test lexing::tests::lex_section ... ok
Nov 01 19:22:29.023 INFO blam! test lexing::tests::lex_voice ... ok
Nov 01 19:22:29.023 INFO blam! test lexing::tests::right_brace_can_break_stave_within_one_line ... ok
Nov 01 19:22:29.023 INFO blam! test lexing::tests::lex_symbols ... ok
Nov 01 19:22:29.023 INFO blam! test notes::tests::test_lcm ... ok
Nov 01 19:22:29.023 INFO blam! test notes::tests::round_trip_sharp_conversions ... ok
Nov 01 19:22:29.023 INFO blam! test notes::tests::test_note_to_abc ... ok
Nov 01 19:22:29.023 INFO blam! test notes::tests::test_note_to_midi ... ok
Nov 01 19:22:29.031 INFO blam! test parsing::tests::fail_on_unexpected_length ... ok
Nov 01 19:22:29.031 INFO blam! test parsing::tests::fail_on_overflowed_length ... ok
Nov 01 19:22:29.031 INFO blam! test parsing::tests::fail_on_underflowed_length ... ok
Nov 01 19:22:29.031 INFO blam! test parsing::tests::fail_parsing_too_many_staves_after_blank_line ... ok
Nov 01 19:22:29.031 INFO blam! test parsing::tests::fail_to_parse_invalid_attributes ... ok
Nov 01 19:22:29.031 INFO blam! test parsing::tests::fail_when_hit_notes_are_encountered_in_incompatible_staves ... ok
Nov 01 19:22:29.031 INFO blam! test lexing::tests::semicolon_can_break_stave_within_one_line ... ok
Nov 01 19:22:29.031 INFO blam! test notes::tests::round_trip_flat_conversions ... ok
Nov 01 19:22:29.031 INFO blam! test parsing::tests::parse_attributes_with_trailing_comma ... ok
Nov 01 19:22:29.032 INFO blam! test parsing::tests::fail_when_notes_before_repeat_sign ... ok
Nov 01 19:22:29.035 INFO blam! test parsing::tests::parse_attributes_in_piece ... ok
Nov 01 19:22:29.040 INFO blam! test parsing::tests::parse_attributes_without_commas ... ok
Nov 01 19:22:29.040 INFO blam! test parsing::tests::fail_when_notes_after_repeat_sign ... ok
Nov 01 19:22:29.040 INFO blam! test parsing::tests::parse_empty_play_node ... ok
Nov 01 19:22:29.040 INFO blam! test parsing::tests::parse_empty_file ... ok
Nov 01 19:22:29.051 INFO blam! test parsing::tests::parse_empty_piece ... ok
Nov 01 19:22:29.051 INFO blam! test parsing::tests::parse_empty_voice ... ok
Nov 01 19:22:29.051 INFO blam! test parsing::tests::parse_multiple_concurrent_melody_lines_broken_up_by_blank_line ... ok
Nov 01 19:22:29.051 INFO blam! test parsing::tests::parse_note_with_length ... ok
Nov 01 19:22:29.051 INFO blam! test parsing::tests::parse_multiple_concurrent_melody_lines ... ok
Nov 01 19:22:29.051 INFO blam! test parsing::tests::parse_multiple_empty_pieces ... ok
Nov 01 19:22:29.052 INFO blam! test parsing::tests::parse_play_node_with_extra_barlines ... ok
Nov 01 19:22:29.052 INFO blam! test parsing::tests::parse_empty_voiceless_play_node ... ok
Nov 01 19:22:29.053 INFO blam! test parsing::tests::parse_play_node_with_percussive_notes ... ok
Nov 01 19:22:29.054 INFO blam! test parsing::tests::parse_valueless_attribute ... ok
Nov 01 19:22:29.054 INFO blam! test parsing::tests::parse_play_node_with_two_staves ... ok
Nov 01 19:22:29.055 INFO blam! test parsing::tests::parse_play_node_with_melody_notes ... ok
Nov 01 19:22:29.059 INFO blam! test parsing::tests::parse_rest_with_length ... ok
Nov 01 19:22:29.059 INFO blam! test parsing::tests::parse_repeat ... ok
Nov 01 19:22:29.060 INFO blam! test parsing::tests::parse_stave_split_over_multiple_lines ... ok
Nov 01 19:22:29.074 INFO blam! test sequencing::tests::fail_when_notes_moved_out_of_range ... ok
Nov 01 19:22:29.074 INFO blam! test parsing::tests::parse_voice_attributes ... ok
Nov 01 19:22:29.091 INFO blam! test sequencing::tests::piece_with_attributes ... ok
Nov 01 19:22:29.091 INFO blam! test sequencing::tests::notes_can_be_tied_across_bars ... ok
Nov 01 19:22:29.101 INFO blam! test sequencing::tests::repeat_bars ... ok
Nov 01 19:22:29.101 INFO blam! test sequencing::tests::piece_with_empty_voice ... ok
Nov 01 19:22:29.102 INFO blam! test sequencing::tests::dots_do_not_carry_across_staves ... ok
Nov 01 19:22:29.103 INFO blam! test parsing::tests::parse_play_node_with_stave ... ok
Nov 01 19:22:29.111 INFO blam! test sequencing::tests::repeat_bars_twice ... ok
Nov 01 19:22:29.111 INFO blam! test sequencing::tests::sequence_empty_piece ... ok
Nov 01 19:22:29.116 INFO blam! test sequencing::tests::voice_with_single_note ... ok
Nov 01 19:22:29.116 INFO blam! test sequencing::tests::fail_first_bar_repeat ... ok
Nov 01 19:22:29.131 INFO blam! test sequencing::tests::voice_with_leading_dots ... ok
Nov 01 19:22:29.135 INFO blam! test sequencing::tests::voice_with_note_lengths ... ok
Nov 01 19:22:29.139 INFO blam! test sequencing::tests::voice_with_mismatched_play ... ok
Nov 01 19:22:29.146 INFO blam! test sequencing::tests::voice_with_dots ... ok
Nov 01 19:22:29.146 INFO blam! test sequencing::tests::voice_with_two_staves ... ok
Nov 01 19:22:29.151 INFO blam! test sequencing::tests::threes_against_twos ... ok
Nov 01 19:22:29.156 INFO blam! test sequencing::tests::voice_with_two_notes ... ok
Nov 01 19:22:29.176 INFO blam! test parsing::tests::parse_empty_piece_with_trailing_tokens_fails ... ok
Nov 01 19:22:29.176 INFO blam! 
Nov 01 19:22:29.176 INFO blam! test result: ok. 108 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 19:22:29.176 INFO blam! 
Nov 01 19:22:29.181 INFO kablam!      Running /target/debug/deps/melo-80f827ad8aabe4f0
Nov 01 19:22:29.184 INFO blam! 
Nov 01 19:22:29.184 INFO blam! running 0 tests
Nov 01 19:22:29.184 INFO blam! 
Nov 01 19:22:29.184 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 19:22:29.184 INFO blam! 
Nov 01 19:22:29.184 INFO kablam!      Running /target/debug/deps/compile_pieces_to_abc_tests-b18867a47b63fcdf
Nov 01 19:22:29.186 INFO blam! 
Nov 01 19:22:29.186 INFO blam! running 9 tests
Nov 01 19:22:29.330 INFO blam! test time_and_tempo ... ok
Nov 01 19:22:29.351 INFO blam! test minimal_melody ... ok
Nov 01 19:22:29.362 INFO blam! test multiple_instruments ... ok
Nov 01 19:22:29.362 INFO blam! test minimal_drums ... ok
Nov 01 19:22:29.362 INFO blam! test polyrhythms ... ok
Nov 01 19:22:29.366 INFO blam! test repeats ... ok
Nov 01 19:22:29.367 INFO blam! test minimal_chords ... ok
Nov 01 19:22:29.375 INFO blam! test too_many_staves ... ok
Nov 01 19:22:29.503 INFO blam! test rondo_alla_turca ... ok
Nov 01 19:22:29.503 INFO kablam!      Running /target/debug/deps/compile_to_abc_tests-d34bae9c123c7e79
Nov 01 19:22:29.503 INFO blam! 
Nov 01 19:22:29.503 INFO blam! test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 19:22:29.503 INFO blam! 
Nov 01 19:22:29.507 INFO blam! 
Nov 01 19:22:29.507 INFO blam! running 13 tests
Nov 01 19:22:29.571 INFO blam! test quintuplets ... ok
Nov 01 19:22:29.587 INFO blam! test triple_time_expansion ... ok
Nov 01 19:22:29.611 INFO blam! test triplets ... ok
Nov 01 19:22:29.627 INFO blam! test variable_drum_bars ... ok
Nov 01 19:22:29.635 INFO blam! test variable_stave_drum_bars ... ok
Nov 01 19:22:29.640 INFO blam! test voice_args ... ok
Nov 01 19:22:29.696 INFO blam! test not_sextuplets ... ok
Nov 01 19:22:29.711 INFO blam! test complex_melody ... ok
Nov 01 19:22:29.715 INFO blam! test longer_melody ... ok
Nov 01 19:22:29.719 INFO blam! test simple_drums ... ok
Nov 01 19:22:29.727 INFO blam! test fifths ... ok
Nov 01 19:22:29.739 INFO blam! test simple_melody ... ok
Nov 01 19:22:29.739 INFO kablam!    Doc-tests melo
Nov 01 19:22:29.739 INFO blam! test octave_shift ... ok
Nov 01 19:22:29.739 INFO blam! 
Nov 01 19:22:29.739 INFO blam! test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 19:22:29.739 INFO blam! 
Nov 01 19:22:32.347 INFO blam! 
Nov 01 19:22:32.347 INFO blam! running 0 tests
Nov 01 19:22:32.348 INFO blam! 
Nov 01 19:22:32.348 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 19:22:32.348 INFO blam! 
Nov 01 19:22:32.349 INFO kablam! su: No module specific data is present
Nov 01 19:22:32.752 INFO running `"docker" "rm" "-f" "50cec6ad672ea765c4ca5541a52593a987a35c0b5c82bf62f853cde779126685"`
Nov 01 19:22:32.870 INFO blam! 50cec6ad672ea765c4ca5541a52593a987a35c0b5c82bf62f853cde779126685
