Oct 15 08:35:04.073 INFO testing Mistodon/melo against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling-1
Oct 15 08:35:04.074 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-2/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-2/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 15 08:35:04.621 INFO blam! 9eb276728ceff19464330372d98035b9ce2b6ccc48d5828a110d8bfd047c54a9
Oct 15 08:35:04.625 INFO running `"docker" "start" "-a" "9eb276728ceff19464330372d98035b9ce2b6ccc48d5828a110d8bfd047c54a9"`
Oct 15 08:35:05.803 INFO kablam! usermod: no changes
Oct 15 08:35:06.133 INFO kablam!    Compiling enum_primitive v0.1.1
Oct 15 08:35:06.133 INFO kablam!    Compiling uuid v0.1.18
Oct 15 08:35:06.147 INFO kablam!    Compiling structopt v0.1.7
Oct 15 08:35:06.147 INFO kablam!    Compiling failure v0.1.1
Oct 15 08:35:06.946 INFO kablam!    Compiling rimd v0.0.1
Oct 15 08:35:08.833 INFO kablam!    Compiling mktemp v0.3.1
Oct 15 08:35:11.439 INFO kablam!    Compiling melo v0.1.0 (/source)
Oct 15 08:35:21.527 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 15.68s
Oct 15 08:35:21.534 INFO kablam! su: No module specific data is present
Oct 15 08:35:22.448 INFO running `"docker" "rm" "-f" "9eb276728ceff19464330372d98035b9ce2b6ccc48d5828a110d8bfd047c54a9"`
Oct 15 08:35:22.743 INFO blam! 9eb276728ceff19464330372d98035b9ce2b6ccc48d5828a110d8bfd047c54a9
Oct 15 08:35:22.743 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-2/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-2/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 15 08:35:23.205 INFO blam! c1348edf2890e5a7fb39db98bbbaf6298a26d349ce6b6701bc42ad9e5fc5f09b
Oct 15 08:35:23.208 INFO running `"docker" "start" "-a" "c1348edf2890e5a7fb39db98bbbaf6298a26d349ce6b6701bc42ad9e5fc5f09b"`
Oct 15 08:35:24.643 INFO kablam! usermod: no changes
Oct 15 08:35:24.793 INFO kablam!    Compiling pretty_assertions v0.4.1
Oct 15 08:35:25.627 INFO kablam!    Compiling melo v0.1.0 (/source)
Oct 15 08:35:35.783 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 11.10s
Oct 15 08:35:35.791 INFO kablam! su: No module specific data is present
Oct 15 08:35:36.444 INFO running `"docker" "rm" "-f" "c1348edf2890e5a7fb39db98bbbaf6298a26d349ce6b6701bc42ad9e5fc5f09b"`
Oct 15 08:35:36.718 INFO blam! c1348edf2890e5a7fb39db98bbbaf6298a26d349ce6b6701bc42ad9e5fc5f09b
Oct 15 08:35:36.724 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-2/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-2/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 15 08:35:37.063 INFO blam! 1bca45838fb6e1aa7e516ad61f9965fbb3bb306b724e9c445a8977bd815438ca
Oct 15 08:35:37.066 INFO running `"docker" "start" "-a" "1bca45838fb6e1aa7e516ad61f9965fbb3bb306b724e9c445a8977bd815438ca"`
Oct 15 08:35:38.069 INFO kablam! usermod: no changes
Oct 15 08:35:38.215 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.10s
Oct 15 08:35:38.230 INFO kablam!      Running /target/debug/deps/melo-de2a1f964824915a
Oct 15 08:35:38.234 INFO blam! 
Oct 15 08:35:38.234 INFO blam! running 108 tests
Oct 15 08:35:38.281 INFO blam! test abc_generation::tests::rest_across_bars ... ok
Oct 15 08:35:38.282 INFO blam! test abc_generation::tests::notes_with_lengths ... ok
Oct 15 08:35:38.286 INFO blam! test abc_generation::tests::test_div_tuplet ... ok
Oct 15 08:35:38.288 INFO blam! test abc_generation::tests::note_tied_across_bar ... ok
Oct 15 08:35:38.293 INFO blam! test abc_generation::tests::notes_with_dots ... ok
Oct 15 08:35:38.310 INFO blam! test abc_generation::tests::long_notes_in_triplets ... ok
Oct 15 08:35:38.310 INFO blam! test abc_generation::tests::note_tied_across_triplets ... ok
Oct 15 08:35:38.311 INFO blam! test abc_generation::tests::rest_before_chord_not_duplicated ... ok
Oct 15 08:35:38.311 INFO blam! test abc_generation::tests::note_tied_across_triplet_bars ... ok
Oct 15 08:35:38.312 INFO blam! test abc_generation::tests::test_even_faster_triplets ... ok
Oct 15 08:35:38.312 INFO blam! test abc_generation::tests::large_tuplets_fail ... ok
Oct 15 08:35:38.314 INFO blam! test abc_generation::tests::test_eight_notes_in_sequence ... ok
Oct 15 08:35:38.319 INFO blam! test abc_generation::tests::test_four_notes_in_sequence ... ok
Oct 15 08:35:38.319 INFO blam! test abc_generation::tests::test_four_notes_then_sixteen ... ok
Oct 15 08:35:38.321 INFO blam! test abc_generation::tests::test_single_note ... ok
Oct 15 08:35:38.327 INFO blam! test abc_generation::tests::test_sixteen_notes_in_sequence ... ok
Oct 15 08:35:38.327 INFO blam! test abc_generation::tests::test_fast_triplets ... ok
Oct 15 08:35:38.328 INFO blam! test abc_generation::tests::test_three_note_bar_in_3_4_time ... ok
Oct 15 08:35:38.334 INFO blam! test abc_generation::tests::test_notes_with_rests ... ok
Oct 15 08:35:38.334 INFO blam! test abc_generation::tests::test_two_notes_at_once ... ok
Oct 15 08:35:38.335 INFO blam! test abc_generation::tests::test_triplets_in_3_4_time ... ok
Oct 15 08:35:38.338 INFO blam! test abc_generation::tests::triplet_chords ... ok
Oct 15 08:35:38.341 INFO blam! test abc_generation::tests::three_notes_at_once ... ok
Oct 15 08:35:38.344 INFO blam! test abc_generation::tests::test_two_notes_in_sequence ... ok
Oct 15 08:35:38.344 INFO blam! test abc_generation::tests::test_triplets_with_rests ... ok
Oct 15 08:35:38.345 INFO blam! test abc_generation::tests::test_quintuplet_in_4_4_time ... ok
Oct 15 08:35:38.347 INFO blam! test lexing::tests::comments_ignored ... ok
Oct 15 08:35:38.352 INFO blam! test lexing::tests::lex_blank_lines ... ok
Oct 15 08:35:38.352 INFO blam! test lexing::tests::empty_file ... ok
Oct 15 08:35:38.353 INFO blam! test lexing::tests::invalid_tokens_in_stave ... ok
Oct 15 08:35:38.353 INFO blam! test lexing::tests::invalid_tokens ... ok
Oct 15 08:35:38.355 INFO blam! test lexing::tests::lex_complex_notes ... ok
Oct 15 08:35:38.356 INFO blam! test lexing::tests::insignificant_whitespace_ignored ... ok
Oct 15 08:35:38.357 INFO blam! test lexing::tests::lex_all_staves_key ... ok
Oct 15 08:35:38.359 INFO blam! test lexing::tests::lex_empty_key ... ok
Oct 15 08:35:38.361 INFO blam! test lexing::tests::lex_field_in_block ... ok
Oct 15 08:35:38.361 INFO blam! test lexing::tests::lex_name_with_spaces ... ok
Oct 15 08:35:38.363 INFO blam! test abc_generation::tests::test_triplet_in_4_4_time ... ok
Oct 15 08:35:38.366 INFO blam! test lexing::tests::lex_name ... ok
Oct 15 08:35:38.366 INFO blam! test lexing::tests::lex_multiple_fields ... ok
Oct 15 08:35:38.367 INFO blam! test lexing::tests::lex_play ... ok
Oct 15 08:35:38.368 INFO blam! test lexing::tests::lex_note_length ... ok
Oct 15 08:35:38.368 INFO blam! test lexing::tests::lex_quoted_name ... ok
Oct 15 08:35:38.369 INFO blam! test lexing::tests::lex_note ... ok
Oct 15 08:35:38.370 INFO blam! test lexing::tests::lex_section ... ok
Oct 15 08:35:38.375 INFO blam! test lexing::tests::lex_part ... ok
Oct 15 08:35:38.375 INFO blam! test lexing::tests::lex_numbers ... ok
Oct 15 08:35:38.375 INFO blam! test lexing::tests::lex_symbols ... ok
Oct 15 08:35:38.375 INFO blam! test lexing::tests::lex_piece ... ok
Oct 15 08:35:38.379 INFO blam! test notes::tests::round_trip_sharp_conversions ... ok
Oct 15 08:35:38.380 INFO blam! test notes::tests::test_lcm ... ok
Oct 15 08:35:38.380 INFO blam! test notes::tests::round_trip_flat_conversions ... ok
Oct 15 08:35:38.380 INFO blam! test notes::tests::test_note_to_abc ... ok
Oct 15 08:35:38.381 INFO blam! test lexing::tests::lex_play_part ... ok
Oct 15 08:35:38.382 INFO blam! test lexing::tests::lex_quoted_name_with_quotes_in_it ... ok
Oct 15 08:35:38.383 INFO blam! test lexing::tests::lex_voice ... ok
Oct 15 08:35:38.385 INFO blam! test lexing::tests::semicolon_can_break_stave_within_one_line ... ok
Oct 15 08:35:38.386 INFO blam! test lexing::tests::right_brace_can_break_stave_within_one_line ... ok
Oct 15 08:35:38.388 INFO blam! test lexing::tests::lex_ridiculous_field_name ... ok
Oct 15 08:35:38.388 INFO blam! test notes::tests::test_note_to_midi ... ok
Oct 15 08:35:38.390 INFO blam! test parsing::tests::fail_on_overflowed_length ... ok
Oct 15 08:35:38.391 INFO blam! test parsing::tests::fail_when_hit_notes_are_encountered_in_incompatible_staves ... ok
Oct 15 08:35:38.397 INFO blam! test parsing::tests::fail_when_notes_before_repeat_sign ... ok
Oct 15 08:35:38.397 INFO blam! test parsing::tests::fail_when_notes_after_repeat_sign ... ok
Oct 15 08:35:38.397 INFO blam! test parsing::tests::fail_parsing_too_many_staves_after_blank_line ... ok
Oct 15 08:35:38.397 INFO blam! test parsing::tests::fail_on_unexpected_length ... ok
Oct 15 08:35:38.397 INFO blam! test parsing::tests::fail_to_parse_invalid_attributes ... ok
Oct 15 08:35:38.398 INFO blam! test parsing::tests::parse_empty_play_node ... ok
Oct 15 08:35:38.400 INFO blam! test parsing::tests::parse_empty_piece ... ok
Oct 15 08:35:38.400 INFO blam! test parsing::tests::fail_on_underflowed_length ... ok
Oct 15 08:35:38.401 INFO blam! test parsing::tests::parse_multiple_concurrent_melody_lines ... ok
Oct 15 08:35:38.401 INFO blam! test parsing::tests::parse_empty_file ... ok
Oct 15 08:35:38.403 INFO blam! test parsing::tests::parse_multiple_concurrent_melody_lines_broken_up_by_blank_line ... ok
Oct 15 08:35:38.403 INFO blam! test parsing::tests::parse_multiple_empty_pieces ... ok
Oct 15 08:35:38.405 INFO blam! test parsing::tests::parse_empty_voice ... ok
Oct 15 08:35:38.405 INFO blam! test parsing::tests::parse_attributes_without_commas ... ok
Oct 15 08:35:38.405 INFO blam! test parsing::tests::parse_attributes_in_piece ... ok
Oct 15 08:35:38.407 INFO blam! test parsing::tests::parse_empty_voiceless_play_node ... ok
Oct 15 08:35:38.408 INFO blam! test parsing::tests::parse_attributes_with_trailing_comma ... ok
Oct 15 08:35:38.409 INFO blam! test parsing::tests::parse_play_node_with_melody_notes ... ok
Oct 15 08:35:38.409 INFO blam! test parsing::tests::parse_play_node_with_stave ... ok
Oct 15 08:35:38.411 INFO blam! test parsing::tests::parse_note_with_length ... ok
Oct 15 08:35:38.412 INFO blam! test parsing::tests::parse_valueless_attribute ... ok
Oct 15 08:35:38.426 INFO blam! test parsing::tests::parse_rest_with_length ... ok
Oct 15 08:35:38.426 INFO blam! test parsing::tests::parse_play_node_with_extra_barlines ... ok
Oct 15 08:35:38.426 INFO blam! test parsing::tests::parse_repeat ... ok
Oct 15 08:35:38.426 INFO blam! test parsing::tests::parse_play_node_with_percussive_notes ... ok
Oct 15 08:35:38.426 INFO blam! test parsing::tests::parse_play_node_with_two_staves ... ok
Oct 15 08:35:38.427 INFO blam! test parsing::tests::parse_stave_split_over_multiple_lines ... ok
Oct 15 08:35:38.427 INFO blam! test parsing::tests::parse_voice_attributes ... ok
Oct 15 08:35:38.428 INFO blam! test sequencing::tests::dots_do_not_carry_across_staves ... ok
Oct 15 08:35:38.429 INFO blam! test sequencing::tests::repeat_bars ... ok
Oct 15 08:35:38.430 INFO blam! test sequencing::tests::piece_with_empty_voice ... ok
Oct 15 08:35:38.432 INFO blam! test sequencing::tests::repeat_bars_twice ... ok
Oct 15 08:35:38.444 INFO blam! test sequencing::tests::piece_with_attributes ... ok
Oct 15 08:35:38.444 INFO blam! test sequencing::tests::fail_when_notes_moved_out_of_range ... ok
Oct 15 08:35:38.444 INFO blam! test sequencing::tests::notes_can_be_tied_across_bars ... ok
Oct 15 08:35:38.445 INFO blam! test sequencing::tests::voice_with_dots ... ok
Oct 15 08:35:38.445 INFO blam! test sequencing::tests::sequence_empty_piece ... ok
Oct 15 08:35:38.447 INFO blam! test sequencing::tests::voice_with_mismatched_play ... ok
Oct 15 08:35:38.447 INFO blam! test sequencing::tests::fail_first_bar_repeat ... ok
Oct 15 08:35:38.449 INFO blam! test sequencing::tests::threes_against_twos ... ok
Oct 15 08:35:38.449 INFO blam! test sequencing::tests::voice_with_note_lengths ... ok
Oct 15 08:35:38.457 INFO blam! test sequencing::tests::voice_with_two_notes ... ok
Oct 15 08:35:38.457 INFO blam! test sequencing::tests::voice_with_leading_dots ... ok
Oct 15 08:35:38.458 INFO blam! test sequencing::tests::voice_with_single_note ... ok
Oct 15 08:35:38.459 INFO blam! test sequencing::tests::voice_with_two_staves ... ok
Oct 15 08:35:38.471 INFO blam! test parsing::tests::parse_empty_piece_with_trailing_tokens_fails ... ok
Oct 15 08:35:38.471 INFO blam! 
Oct 15 08:35:38.471 INFO blam! test result: ok. 108 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 15 08:35:38.471 INFO blam! 
Oct 15 08:35:38.474 INFO kablam!      Running /target/debug/deps/melo-e85778a54ff7bb0a
Oct 15 08:35:38.482 INFO blam! 
Oct 15 08:35:38.482 INFO blam! running 0 tests
Oct 15 08:35:38.482 INFO blam! 
Oct 15 08:35:38.482 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 15 08:35:38.482 INFO blam! 
Oct 15 08:35:38.483 INFO kablam!      Running /target/debug/deps/compile_pieces_to_abc_tests-5c1b31b6c8d2db74
Oct 15 08:35:38.485 INFO blam! 
Oct 15 08:35:38.485 INFO blam! running 9 tests
Oct 15 08:35:38.587 INFO blam! test minimal_drums ... ok
Oct 15 08:35:38.603 INFO blam! test minimal_melody ... ok
Oct 15 08:35:38.603 INFO blam! test polyrhythms ... ok
Oct 15 08:35:38.619 INFO blam! test minimal_chords ... ok
Oct 15 08:35:38.627 INFO blam! test repeats ... ok
Oct 15 08:35:38.643 INFO blam! test multiple_instruments ... ok
Oct 15 08:35:38.643 INFO blam! test time_and_tempo ... ok
Oct 15 08:35:38.659 INFO blam! test rondo_alla_turca ... ok
Oct 15 08:35:38.670 INFO kablam!      Running /target/debug/deps/compile_to_abc_tests-e7b50326cd9e99a6
Oct 15 08:35:38.670 INFO blam! test too_many_staves ... ok
Oct 15 08:35:38.670 INFO blam! 
Oct 15 08:35:38.670 INFO blam! test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 15 08:35:38.670 INFO blam! 
Oct 15 08:35:38.670 INFO blam! 
Oct 15 08:35:38.670 INFO blam! running 13 tests
Oct 15 08:35:38.783 INFO blam! test simple_drums ... ok
Oct 15 08:35:38.791 INFO blam! test complex_melody ... ok
Oct 15 08:35:38.791 INFO blam! test longer_melody ... ok
Oct 15 08:35:38.791 INFO blam! test quintuplets ... ok
Oct 15 08:35:38.791 INFO blam! test fifths ... ok
Oct 15 08:35:38.791 INFO blam! test simple_melody ... ok
Oct 15 08:35:38.807 INFO blam! test octave_shift ... ok
Oct 15 08:35:38.807 INFO blam! test not_sextuplets ... ok
Oct 15 08:35:38.807 INFO blam! test triple_time_expansion ... ok
Oct 15 08:35:38.807 INFO blam! test triplets ... ok
Oct 15 08:35:38.807 INFO blam! test variable_drum_bars ... ok
Oct 15 08:35:38.827 INFO blam! test variable_stave_drum_bars ... ok
Oct 15 08:35:38.827 INFO blam! test voice_args ... ok
Oct 15 08:35:38.827 INFO blam! 
Oct 15 08:35:38.827 INFO blam! test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 15 08:35:38.827 INFO blam! 
Oct 15 08:35:38.831 INFO kablam!    Doc-tests melo
Oct 15 08:35:40.806 INFO blam! 
Oct 15 08:35:40.806 INFO blam! running 0 tests
Oct 15 08:35:40.806 INFO blam! 
Oct 15 08:35:40.806 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 15 08:35:40.806 INFO blam! 
Oct 15 08:35:40.819 INFO kablam! su: No module specific data is present
Oct 15 08:35:41.215 INFO running `"docker" "rm" "-f" "1bca45838fb6e1aa7e516ad61f9965fbb3bb306b724e9c445a8977bd815438ca"`
Oct 15 08:35:41.300 INFO blam! 1bca45838fb6e1aa7e516ad61f9965fbb3bb306b724e9c445a8977bd815438ca