Oct 12 05:04:51.828 INFO testing bio-0.22.0 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling
Oct 12 05:04:51.828 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-6/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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 12 05:04:52.291 INFO blam! c499709a1d2dde5c14d27db28749e8d563336210dc22ad5b9cc055ac3965396a
Oct 12 05:04:52.293 INFO running `"docker" "start" "-a" "c499709a1d2dde5c14d27db28749e8d563336210dc22ad5b9cc055ac3965396a"`
Oct 12 05:04:53.584 INFO kablam! usermod: no changes
Oct 12 05:04:53.804 INFO kablam!    Compiling bv v0.7.4
Oct 12 05:04:53.804 INFO kablam!    Compiling bio-types v0.4.0
Oct 12 05:04:53.804 INFO kablam!    Compiling multimap v0.4.0
Oct 12 05:04:53.804 INFO kablam!    Compiling vec_map v0.8.1
Oct 12 05:05:01.884 INFO kablam!    Compiling bio v0.22.0 (/source)
Oct 12 05:05:06.845 INFO kablam! warning: unused `#[macro_use]` import
Oct 12 05:05:06.845 INFO kablam!    --> src/lib.rs:103:1
Oct 12 05:05:06.845 INFO kablam!     |
Oct 12 05:05:06.845 INFO kablam! 103 | #[macro_use]
Oct 12 05:05:06.845 INFO kablam!     | ^^^^^^^^^^^^
Oct 12 05:05:06.845 INFO kablam!     |
Oct 12 05:05:06.845 INFO kablam!     = note: #[warn(unused_imports)] on by default
Oct 12 05:05:06.845 INFO kablam! 
Oct 12 05:05:06.845 INFO kablam! warning: unused `#[macro_use]` import
Oct 12 05:05:06.846 INFO kablam!    --> src/lib.rs:117:1
Oct 12 05:05:06.846 INFO kablam!     |
Oct 12 05:05:06.846 INFO kablam! 117 | #[macro_use]
Oct 12 05:05:06.846 INFO kablam!     | ^^^^^^^^^^^^
Oct 12 05:05:06.846 INFO kablam! 
Oct 12 05:05:14.895 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 21.28s
Oct 12 05:05:14.896 INFO kablam! su: No module specific data is present
Oct 12 05:05:15.422 INFO running `"docker" "rm" "-f" "c499709a1d2dde5c14d27db28749e8d563336210dc22ad5b9cc055ac3965396a"`
Oct 12 05:05:15.664 INFO blam! c499709a1d2dde5c14d27db28749e8d563336210dc22ad5b9cc055ac3965396a
Oct 12 05:05:15.665 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-6/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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 12 05:05:16.025 INFO blam! 0238af66fa5c575ad95424f37e96a0754e484b30329f637c9412ff87ae72ef22
Oct 12 05:05:16.032 INFO running `"docker" "start" "-a" "0238af66fa5c575ad95424f37e96a0754e484b30329f637c9412ff87ae72ef22"`
Oct 12 05:05:17.264 INFO kablam! usermod: no changes
Oct 12 05:05:17.408 INFO kablam!    Compiling bio v0.22.0 (/source)
Oct 12 05:05:45.748 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 28.46s
Oct 12 05:05:45.756 INFO kablam! su: No module specific data is present
Oct 12 05:05:46.934 INFO running `"docker" "rm" "-f" "0238af66fa5c575ad95424f37e96a0754e484b30329f637c9412ff87ae72ef22"`
Oct 12 05:05:47.282 INFO blam! 0238af66fa5c575ad95424f37e96a0754e484b30329f637c9412ff87ae72ef22
Oct 12 05:05:47.288 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-6/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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 12 05:05:47.810 INFO blam! 64fa38bc53d934eac1ef441040fee7585edc60004a2a4ef4f3d4cad321156e2e
Oct 12 05:05:47.812 INFO running `"docker" "start" "-a" "64fa38bc53d934eac1ef441040fee7585edc60004a2a4ef4f3d4cad321156e2e"`
Oct 12 05:05:49.228 INFO kablam! usermod: no changes
Oct 12 05:05:49.468 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.20s
Oct 12 05:05:49.483 INFO kablam!      Running /target/debug/deps/bio-b5b66597cf70f368
Oct 12 05:05:49.491 INFO blam! 
Oct 12 05:05:49.491 INFO blam! running 227 tests
Oct 12 05:05:49.492 INFO blam! test alignment::pairwise::banded::banded::test_band_add_kmer ... ok
Oct 12 05:05:49.496 INFO blam! test alignment::distance::tests::test_hamming_dist_good ... ok
Oct 12 05:05:49.497 INFO blam! test alignment::pairwise::banded::banded::test_band_add_entry ... ok
Oct 12 05:05:49.509 INFO blam! test alignment::pairwise::banded::banded::test_aligner_new ... ok
Oct 12 05:05:49.509 INFO blam! test alignment::pairwise::banded::banded::test_blosum62 ... ok
Oct 12 05:05:49.520 INFO blam! test alignment::distance::tests::test_levenshtein_dist ... ok
Oct 12 05:05:49.521 INFO blam! test alignment::pairwise::banded::banded::test_global_affine_ins ... ok
Oct 12 05:05:49.521 INFO blam! test alignment::pairwise::banded::banded::test_global ... ok
Oct 12 05:05:49.522 INFO blam! test alignment::pairwise::banded::banded::test_global_affine_ins2 ... ok
Oct 12 05:05:49.523 INFO blam! test alignment::pairwise::banded::banded::test_global_right_del ... ok
Oct 12 05:05:49.540 INFO blam! test alignment::pairwise::banded::banded::test_insert_in_between_semiglobal ... ok
Oct 12 05:05:49.570 INFO blam! test alignment::pairwise::banded::banded::test_insert_only_semiglobal ... ok
Oct 12 05:05:49.619 INFO blam! test alignment::pairwise::banded::banded::test_issue11 ... ok
Oct 12 05:05:49.624 INFO blam! test alignment::pairwise::banded::banded::test_band_ends_inside ... ok
Oct 12 05:05:49.645 INFO blam! test alignment::pairwise::banded::banded::test_deletion ... ok
Oct 12 05:05:49.645 INFO blam! test alignment::pairwise::banded::banded::test_band_starts_inside ... ok
Oct 12 05:05:49.648 INFO blam! test alignment::pairwise::banded::banded::test_issue12_1 ... ok
Oct 12 05:05:49.653 INFO blam! test alignment::pairwise::banded::banded::test_left_aligned_del ... ok
Oct 12 05:05:49.657 INFO blam! test alignment::pairwise::banded::banded::test_left_aligned_ins ... ok
Oct 12 05:05:49.662 INFO blam! test alignment::pairwise::banded::banded::test_local_affine_ins2 ... ok
Oct 12 05:05:49.680 INFO blam! test alignment::pairwise::banded::banded::test_issue12_3 ... ok
Oct 12 05:05:49.680 INFO blam! test alignment::pairwise::banded::banded::test_local ... ok
Oct 12 05:05:49.705 INFO blam! test alignment::pairwise::banded::banded::test_local_empty ... ok
Oct 12 05:05:49.789 INFO blam! test alignment::pairwise::banded::banded::test_insertion ... ok
Oct 12 05:05:49.789 INFO blam! test alignment::pairwise::banded::banded::test_issue12_2 ... ok
Oct 12 05:05:49.790 INFO blam! test alignment::pairwise::banded::banded::test_longer_string_all_operations ... ok
Oct 12 05:05:49.912 INFO blam! test alignment::pairwise::banded::banded::test_overhangs3 ... ok
Oct 12 05:05:49.942 INFO blam! test alignment::pairwise::banded::banded::test_overhangs4 ... ok
Oct 12 05:05:49.952 INFO blam! test alignment::pairwise::banded::banded::test_semiglobal ... ok
Oct 12 05:05:49.952 INFO blam! test alignment::pairwise::banded::banded::test_semiglobal_gap_open_lt_mismatch ... ok
Oct 12 05:05:49.954 INFO blam! test alignment::pairwise::banded::banded::test_semiglobal_simple ... ok
Oct 12 05:05:49.980 INFO blam! test alignment::pairwise::banded::banded::test_band_is_fully_inside ... ok
Oct 12 05:05:49.988 INFO blam! test alignment::pairwise::banded::banded::test_xclip_prefix_custom ... ok
Oct 12 05:05:50.008 INFO blam! test alignment::pairwise::banded::banded::test_overhangs2 ... ok
Oct 12 05:05:50.008 INFO blam! test alignment::pairwise::banded::banded::test_xclip_suffix_custom ... ok
Oct 12 05:05:50.008 INFO blam! test alignment::pairwise::banded::banded::test_overhangs1 ... ok
Oct 12 05:05:50.008 INFO blam! test alignment::pairwise::banded::banded::test_overhangs5 ... ok
Oct 12 05:05:50.016 INFO blam! test alignment::pairwise::tests::test_aligner_new ... ok
Oct 12 05:05:50.017 INFO blam! test alignment::pairwise::tests::test_global ... ok
Oct 12 05:05:50.017 INFO blam! test alignment::pairwise::tests::test_global_affine_ins ... ok
Oct 12 05:05:50.024 INFO blam! test alignment::pairwise::tests::test_global_affine_ins2 ... ok
Oct 12 05:05:50.028 INFO blam! test alignment::pairwise::tests::test_global_right_del ... ok
Oct 12 05:05:50.028 INFO blam! test alignment::pairwise::tests::test_insert_in_between_semiglobal ... ok
Oct 12 05:05:50.028 INFO blam! test alignment::pairwise::tests::test_insert_only_semiglobal ... ok
Oct 12 05:05:50.028 INFO blam! test alignment::pairwise::tests::test_issue11 ... ok
Oct 12 05:05:50.032 INFO blam! test alignment::pairwise::tests::test_issue12_1 ... ok
Oct 12 05:05:50.036 INFO blam! test alignment::pairwise::banded::banded::test_yclip_suffix_custom ... ok
Oct 12 05:05:50.036 INFO blam! test alignment::pairwise::tests::test_blosum62 ... ok
Oct 12 05:05:50.036 INFO blam! test alignment::pairwise::tests::test_issue12_2 ... ok
Oct 12 05:05:50.052 INFO blam! test alignment::pairwise::banded::banded::test_yclip_prefix_custom ... ok
Oct 12 05:05:50.052 INFO blam! test alignment::pairwise::tests::test_left_aligned_ins ... ok
Oct 12 05:05:50.052 INFO blam! test alignment::pairwise::tests::test_left_aligned_del ... ok
Oct 12 05:05:50.052 INFO blam! test alignment::pairwise::tests::test_issue12_3 ... ok
Oct 12 05:05:50.052 INFO blam! test alignment::pairwise::tests::test_local ... ok
Oct 12 05:05:50.052 INFO blam! test alignment::pairwise::tests::test_scoring_from_scores ... ok
Oct 12 05:05:50.068 INFO blam! test alignment::pairwise::tests::test_longer_string_all_operations ... ok
Oct 12 05:05:50.068 INFO blam! test alignment::pairwise::tests::test_semiglobal ... ok
Oct 12 05:05:50.068 INFO blam! test alignment::pairwise::tests::test_semiglobal_gap_open_lt_mismatch ... ok
Oct 12 05:05:50.077 INFO blam! test alignment::distance::tests::test_hamming_dist_bad ... ok
Oct 12 05:05:50.077 INFO blam! test alignment::pairwise::tests::test_xclip_suffix_custom ... ok
Oct 12 05:05:50.077 INFO blam! test alignment::pairwise::tests::test_semiglobal_simple ... ok
Oct 12 05:05:50.077 INFO blam! test alignment::pairwise::tests::test_xclip_prefix_custom ... ok
Oct 12 05:05:50.077 INFO blam! test alignment::sparse::sparse_alignment::test_expanded_matches ... ok
Oct 12 05:05:50.084 INFO blam! test alignment::pairwise::tests::test_yclip_prefix_custom ... ok
Oct 12 05:05:50.084 INFO blam! test alignment::sparse::sparse_alignment::test_lcskpp0 ... ok
Oct 12 05:05:50.084 INFO blam! test alignment::pairwise::tests::test_yclip_suffix_custom ... ok
Oct 12 05:05:50.084 INFO blam! test alignment::sparse::sparse_alignment::test_find_kmer_matches ... ok
Oct 12 05:05:50.105 INFO blam! test alignment::sparse::sparse_alignment::test_lcskpp1 ... ok
Oct 12 05:05:50.105 INFO blam! test alignment::pairwise::tests::traceback_cell ... ok
Oct 12 05:05:50.105 INFO blam! test alignment::sparse::sparse_alignment::test_lcskpp_same ... ok
Oct 12 05:05:50.105 INFO blam! test alignment::sparse::sparse_alignment::test_lcskpp2 ... ok
Oct 12 05:05:50.105 INFO blam! test alignment::pairwise::tests::test_local_affine_ins2 ... ok
Oct 12 05:05:50.105 INFO blam! test alignment::sparse::sparse_alignment::test_sdpkpp_same ... ok
Oct 12 05:05:50.105 INFO blam! test alignment::sparse::sparse_alignment::test_sdp1 ... ok
Oct 12 05:05:50.125 INFO blam! test alphabets::protein::tests::is_no_word ... ok
Oct 12 05:05:50.125 INFO blam! test alignment::sparse::sparse_alignment::test_sdp2 ... ok
Oct 12 05:05:50.125 INFO blam! test alphabets::protein::tests::number_is_no_word ... ok
Oct 12 05:05:50.125 INFO blam! test alignment::sparse::sparse_alignment::test_sdp ... ok
Oct 12 05:05:50.132 INFO blam! test alphabets::rna::tests::is_no_word ... ok
Oct 12 05:05:50.132 INFO blam! test alphabets::rna::tests::is_word ... ok
Oct 12 05:05:50.132 INFO blam! test alphabets::rna::tests::number_is_no_word ... ok
Oct 12 05:05:50.132 INFO blam! test alphabets::rna::tests::symbol_is_no_word ... ok
Oct 12 05:05:50.132 INFO blam! test alphabets::rna::tests::test_reverse_complement ... ok
Oct 12 05:05:50.132 INFO blam! test data_structures::bit_tree::test_bit_tree::test_bit_tree ... ok
Oct 12 05:05:50.132 INFO blam! test data_structures::bitenc::tests::test_bitenc ... ok
Oct 12 05:05:50.142 INFO blam! test data_structures::bitenc::tests::test_issue29 ... ok
Oct 12 05:05:50.142 INFO blam! test data_structures::bitenc::tests::test_push_values ... ok
Oct 12 05:05:50.142 INFO blam! test data_structures::bwt::tests::test_bwtfind ... ok
Oct 12 05:05:50.142 INFO blam! test data_structures::bwt::tests::test_invert_bwt ... ok
Oct 12 05:05:50.142 INFO blam! test data_structures::bwt::tests::test_occ ... ok
Oct 12 05:05:50.142 INFO blam! test data_structures::fmindex::tests::test_fmindex ... ok
Oct 12 05:05:50.142 INFO blam! test data_structures::fmindex::tests::test_init_interval ... ok
Oct 12 05:05:50.148 INFO blam! test alphabets::protein::tests::symbol_is_no_word ... ok
Oct 12 05:05:50.148 INFO blam! test alignment::sparse::sparse_alignment::test_sdpkpp_tandem_repeat ... ok
Oct 12 05:05:50.156 INFO blam! test data_structures::interval_tree::tests::from_iterator ... ok
Oct 12 05:05:50.169 INFO blam! test data_structures::fmindex::tests::test_smems ... ok
Oct 12 05:05:50.169 INFO blam! test alignment::sparse::sparse_alignment::test_lcskpp_tandem_repeat ... ok
Oct 12 05:05:50.169 INFO blam! test alignment::pairwise::banded::banded::test_substitutions ... ok
Oct 12 05:05:50.169 INFO blam! test alphabets::protein::tests::is_word ... ok
Oct 12 05:05:50.171 INFO blam! test data_structures::interval_tree::tests::iter_mut ... ok
Oct 12 05:05:50.172 INFO blam! test data_structures::qgram_index::tests::test_exact_matches_self ... ok
Oct 12 05:05:50.192 INFO blam! test data_structures::qgram_index::tests::test_exact_matches ... ok
Oct 12 05:05:50.208 INFO blam! test data_structures::qgram_index::tests::test_qgram_matches ... ok
Oct 12 05:05:50.208 INFO blam! test data_structures::interval_tree::tests::zero_width_ranges ... ok
Oct 12 05:05:50.208 INFO blam! test data_structures::interval_tree::tests::test_insertion_and_intersection ... ok
Oct 12 05:05:50.208 INFO blam! test data_structures::rank_select::tests::test_rank_select ... ok
Oct 12 05:05:50.208 INFO blam! test data_structures::qgram_index::tests::test_matches ... ok
Oct 12 05:05:50.208 INFO blam! test data_structures::suffix_array::tests::test_buckets ... ok
Oct 12 05:05:50.224 INFO blam! test data_structures::rank_select::tests::test_select ... ok
Oct 12 05:05:50.224 INFO blam! test data_structures::suffix_array::tests::test_issue10_1 ... ok
Oct 12 05:05:50.224 INFO blam! test data_structures::suffix_array::tests::test_handles_sentinels_properly ... ok
Oct 12 05:05:50.228 INFO blam! test data_structures::suffix_array::tests::test_pos ... ok
Oct 12 05:05:50.228 INFO blam! test data_structures::suffix_array::tests::test_lms_pos ... ok
Oct 12 05:05:50.228 INFO blam! test data_structures::rank_select::tests::test_single_select ... ok
Oct 12 05:05:50.232 INFO blam! test io::bed::tests::test_reader ... ok
Oct 12 05:05:50.236 INFO blam! test io::bed::tests::test_writer ... ok
Oct 12 05:05:50.236 INFO blam! test io::fasta::tests::test_index_sequences ... ok
Oct 12 05:05:50.248 INFO blam! test data_structures::fmindex::tests::test_issue39 ... ok
Oct 12 05:05:50.264 INFO blam! test data_structures::suffix_array::tests::test_issue10_2 ... ok
Oct 12 05:05:50.264 INFO blam! test data_structures::suffix_array::tests::test_pos_types ... ok
Oct 12 05:05:50.264 INFO blam! test io::fasta::tests::test_indexed_reader ... ok
Oct 12 05:05:50.272 INFO blam! test io::fasta::tests::test_indexed_reader_bad_reader ... ok
Oct 12 05:05:50.272 INFO blam! test io::fasta::tests::test_indexed_reader_by_rid_all ... ok
Oct 12 05:05:50.272 INFO blam! test io::fasta::tests::test_indexed_reader_crlf ... ok
Oct 12 05:05:50.276 INFO blam! test io::fasta::tests::test_indexed_reader_all ... ok
Oct 12 05:05:50.290 INFO blam! test io::fasta::tests::test_indexed_reader_crlf_by_rid_all ... ok
Oct 12 05:05:50.290 INFO blam! test io::fasta::tests::test_indexed_reader_iter_all ... ok
Oct 12 05:05:50.290 INFO blam! test io::fasta::tests::test_indexed_reader_crlf_all ... ok
Oct 12 05:05:50.290 INFO blam! test io::fasta::tests::test_indexed_reader_iter ... ok
Oct 12 05:05:50.290 INFO blam! test io::fasta::tests::test_indexed_reader_iter_crlf_by_rid_all ... ok
Oct 12 05:05:50.304 INFO blam! test io::fasta::tests::test_indexed_reader_iter_read_fails ... ok
Oct 12 05:05:50.304 INFO blam! test io::fasta::tests::test_indexed_reader_iter_by_rid_all ... ok
Oct 12 05:05:50.304 INFO blam! test io::fasta::tests::test_indexed_reader_iter_crlf ... ok
Oct 12 05:05:50.304 INFO blam! test io::fasta::tests::test_indexed_reader_iter_crlf_all ... ok
Oct 12 05:05:50.308 INFO blam! test io::fasta::tests::test_indexed_reader_no_fetch_read_iter_fails ... ok
Oct 12 05:05:50.308 INFO blam! test io::fasta::tests::test_indexed_reader_iter_size_hint ... ok
Oct 12 05:05:50.308 INFO blam! test data_structures::interval_tree::tests::test_insertion_and_intersection_2 ... ok
Oct 12 05:05:50.308 INFO blam! test io::fasta::tests::test_indexed_reader_no_fetch_read_fails ... ok
Oct 12 05:05:50.308 INFO blam! test io::fasta::tests::test_indexed_reader_iter_seek_fails ... ok
Oct 12 05:05:50.308 INFO blam! test io::fasta::tests::test_reader ... ok
Oct 12 05:05:50.308 INFO blam! test io::fasta::tests::test_indexed_reader_reused_buffer ... ok
Oct 12 05:05:50.312 INFO blam! test io::fasta::tests::test_indexed_reader_read_seek_fails ... ok
Oct 12 05:05:50.312 INFO blam! test io::fasta::tests::test_indexed_reader_read_read_fails ... ok
Oct 12 05:05:50.316 INFO blam! test io::fasta::tests::test_indexed_reader_no_trailing_lf ... ok
Oct 12 05:05:50.316 INFO blam! test io::fasta::tests::test_reader_no_id ... ok
Oct 12 05:05:50.316 INFO blam! test io::fasta::tests::test_reader_read_fails ... ok
Oct 12 05:05:50.316 INFO blam! test io::fasta::tests::test_reader_non_ascii_sequence ... ok
Oct 12 05:05:50.316 INFO blam! test io::fasta::tests::test_record_with_attrs ... ok
Oct 12 05:05:50.316 INFO blam! test io::fastq::tests::test_reader ... ok
Oct 12 05:05:50.316 INFO blam! test io::fasta::tests::test_writer ... ok
Oct 12 05:05:50.316 INFO blam! test io::fastq::tests::test_record_with_attrs ... ok
Oct 12 05:05:50.316 INFO blam! test io::fastq::tests::test_writer ... ok
Oct 12 05:05:50.316 INFO blam! test io::fasta::tests::test_reader_read_fails_iter ... ok
Oct 12 05:05:50.320 INFO blam! test io::fasta::tests::test_reader_wrong_header ... ok
Oct 12 05:05:50.364 INFO blam! test io::gff::tests::test_reader_gtf2_dup_attr_keys ... ok
Oct 12 05:05:50.364 INFO blam! test io::gff::tests::test_convert_gtf2_to_gff3 ... ok
Oct 12 05:05:50.364 INFO blam! test io::gff::tests::test_reader_gtf2_2 ... ok
Oct 12 05:05:50.364 INFO blam! test io::gff::tests::test_reader_gff3 ... ok
Oct 12 05:05:50.364 INFO blam! test io::gff::tests::test_reader_gtf2 ... ok
Oct 12 05:05:50.376 INFO blam! test io::gff::tests::test_writer_gtf2 ... ok
Oct 12 05:05:50.376 INFO blam! test pattern_matching::bom::tests::test_delta ... ok
Oct 12 05:05:50.376 INFO blam! test io::gff::tests::test_writer_gff3 ... ok
Oct 12 05:05:50.376 INFO blam! test pattern_matching::bndm::tests::test_find_all ... ok
Oct 12 05:05:50.376 INFO blam! test pattern_matching::bom::tests::test_find_all ... ok
Oct 12 05:05:50.376 INFO blam! test pattern_matching::horspool::tests::test_find_all ... ok
Oct 12 05:05:50.376 INFO blam! test pattern_matching::horspool::tests::test_shift ... ok
Oct 12 05:05:50.376 INFO blam! test pattern_matching::kmp::tests::test_find_all_at_start ... ok
Oct 12 05:05:50.376 INFO blam! test pattern_matching::myers::tests::test_distance ... ok
Oct 12 05:05:50.377 INFO blam! test pattern_matching::myers::tests::test_long ... ok
Oct 12 05:05:50.377 INFO blam! test pattern_matching::kmp::tests::test_lps ... ok
Oct 12 05:05:50.377 INFO blam! test data_structures::suffix_array::tests::test_sorts_lexically ... ok
Oct 12 05:05:50.377 INFO blam! test pattern_matching::pssm::dnamotif::tests::find_motif ... ok
Oct 12 05:05:50.377 INFO blam! test alignment::pairwise::banded::banded::test_same ... ok
Oct 12 05:05:50.380 INFO blam! test pattern_matching::pssm::dnamotif::tests::simple_pssm ... ok
Oct 12 05:05:50.380 INFO blam! test pattern_matching::myers::tests::test_find_all_end ... ok
Oct 12 05:05:50.413 INFO blam! test pattern_matching::kmp::tests::test_delta ... ok
Oct 12 05:05:50.413 INFO blam! test pattern_matching::kmp::tests::test_find_all ... ok
Oct 12 05:05:50.413 INFO blam! test pattern_matching::pssm::dnamotif::tests::test_mono_err ... ok
Oct 12 05:05:50.413 INFO blam! test pattern_matching::pssm::protmotif::tests::test_inconsist_err ... ok
Oct 12 05:05:50.413 INFO blam! test pattern_matching::pssm::dnamotif::tests::test_inconsist_err ... ok
Oct 12 05:05:50.413 INFO blam! test pattern_matching::pssm::dnamotif::tests::test_info_content ... ok
Oct 12 05:05:50.416 INFO blam! test pattern_matching::pssm::protmotif::tests::test_mono_err ... ok
Oct 12 05:05:50.416 INFO blam! test pattern_matching::pssm::protmotif::tests::test_scoring ... ok
Oct 12 05:05:50.416 INFO blam! test pattern_matching::shift_and::tests::test_find_all ... ok
Oct 12 05:05:50.416 INFO blam! test pattern_matching::ukkonen::tests::test_find_all_end ... ok
Oct 12 05:05:50.416 INFO blam! test pattern_matching::ukkonen::tests::test_find_start ... ok
Oct 12 05:05:50.416 INFO blam! test scores::blosum62::tests::test_blosum62 ... ok
Oct 12 05:05:50.417 INFO blam! test pattern_matching::pssm::protmotif::tests::test_info_content ... ok
Oct 12 05:05:50.420 INFO blam! test scores::pam120::tests::test_pam120 ... ok
Oct 12 05:05:50.420 INFO blam! test scores::pam200::tests::test_pam200 ... ok
Oct 12 05:05:50.420 INFO blam! test scores::pam250::tests::test_pam250 ... ok
Oct 12 05:05:50.420 INFO blam! test stats::combinatorics::tests::test_comb ... ok
Oct 12 05:05:50.436 INFO blam! test stats::hmm::tests::test_discrete_backward_toy_example ... ok
Oct 12 05:05:50.436 INFO blam! test stats::combinatorics::tests::test_comb_scaled ... ok
Oct 12 05:05:50.436 INFO blam! test stats::hmm::tests::test_discrete_forward_toy_example ... ok
Oct 12 05:05:50.436 INFO blam! test stats::hmm::tests::test_discrete_viterbi_toy_example ... ok
Oct 12 05:05:50.436 INFO blam! test stats::hmm::tests::test_gaussian_forward_equals_backward_simple_example ... ok
Oct 12 05:05:50.436 INFO blam! test stats::hmm::tests::test_gaussian_forward_simple_example ... ok
Oct 12 05:05:50.436 INFO blam! test stats::hmm::tests::test_gaussian_viterbi_simple_example ... ok
Oct 12 05:05:50.436 INFO blam! test stats::pairhmm::tests::test_deletion ... ok
Oct 12 05:05:50.436 INFO blam! test stats::pairhmm::tests::test_insertion ... ok
Oct 12 05:05:50.436 INFO blam! test stats::hmm::tests::test_gaussian_backward_simple_example ... ok
Oct 12 05:05:50.456 INFO blam! test stats::pairhmm::tests::test_mismatch ... ok
Oct 12 05:05:50.456 INFO blam! test stats::pairhmm::tests::test_same ... ok
Oct 12 05:05:50.456 INFO blam! test stats::probs::cdf::test::test_cdf ... ok
Oct 12 05:05:50.456 INFO blam! test stats::probs::tests::test_cap_numerical_overshoot ... ok
Oct 12 05:05:50.456 INFO blam! test stats::probs::tests::test_empty_sum ... ok
Oct 12 05:05:50.456 INFO blam! test stats::probs::tests::test_cumsum ... ok
Oct 12 05:05:50.456 INFO blam! test stats::probs::tests::test_cap_numerical_overshoot_panic ... ok
Oct 12 05:05:50.456 INFO blam! test stats::probs::tests::test_sub ... ok
Oct 12 05:05:50.456 INFO blam! test stats::probs::tests::test_simpsons_integrate ... ok
Oct 12 05:05:50.464 INFO blam! test stats::probs::tests::test_sum_one_zero ... ok
Oct 12 05:05:50.464 INFO blam! test stats::probs::tests::test_trapezoidal_integrate ... ok
Oct 12 05:05:50.464 INFO blam! test stats::probs::tests::test_sum ... ok
Oct 12 05:05:50.472 INFO blam! test utils::interval::tests::negative_width_range ... ok
Oct 12 05:05:50.472 INFO blam! test utils::interval::tests::range_interval_conversions ... ok
Oct 12 05:05:50.472 INFO blam! test stats::probs::tests::test_zero ... ok
Oct 12 05:05:50.480 INFO blam! test utils::tests::test_prescan ... ok
Oct 12 05:05:50.480 INFO blam! test scores::pam40::tests::test_pam40 ... ok
Oct 12 05:05:50.480 INFO blam! test utils::tests::test_scan ... ok
Oct 12 05:05:50.480 INFO blam! test seq_analysis::orf::tests::test_orf ... ok
Oct 12 05:05:50.480 INFO blam! test stats::bayesian::tests::test_expected_fdr ... ok
Oct 12 05:05:50.480 INFO blam! test utils::tests::test_strand ... ok
Oct 12 05:05:50.480 INFO blam! test utils::text::tests::test_print_sequence ... ok
Oct 12 05:05:50.504 INFO blam! test stats::probs::tests::test_one_minus ... ok
Oct 12 05:05:50.692 INFO blam! test alignment::pairwise::banded::banded::test_big ... ok
Oct 12 05:05:50.728 INFO kablam!    Doc-tests bio
Oct 12 05:05:50.729 INFO blam! test stats::hmm::tests::test_discrete_forward_equals_backward_toy_example ... ok
Oct 12 05:05:50.729 INFO blam! 
Oct 12 05:05:50.729 INFO blam! test result: ok. 227 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 05:05:50.729 INFO blam! 
Oct 12 05:05:59.501 INFO blam! 
Oct 12 05:05:59.501 INFO blam! running 42 tests
Oct 12 05:06:51.142 INFO blam! test src/alignment/distance.rs - alignment::distance::hamming (line 16) ... ok
Oct 12 05:06:54.916 INFO blam! test <::custom_derive::custom_derive macros> - stats::probs::LogProb (line 46) ... ok
Oct 12 05:06:58.092 INFO blam! test src/alignment/distance.rs - alignment::distance::levenshtein (line 48) ... ok
Oct 12 05:06:58.669 INFO blam! test <::custom_derive::custom_derive macros> - stats::probs::Prob (line 46) ... ok
Oct 12 05:06:59.512 INFO blam! test <::custom_derive::custom_derive macros> - stats::probs::PHREDProb (line 46) ... test <::custom_derive::custom_derive macros> - stats::probs::PHREDProb (line 46) has been running for over 60 seconds
Oct 12 05:06:59.596 INFO blam! test src/alignment/pairwise/banded.rs - alignment::pairwise::banded (line 20) ... test src/alignment/pairwise/banded.rs - alignment::pairwise::banded (line 20) has been running for over 60 seconds
Oct 12 05:06:59.600 INFO blam! test src/alignment/pairwise/mod.rs - alignment::pairwise (line 13) ... test src/alignment/pairwise/mod.rs - alignment::pairwise (line 13) has been running for over 60 seconds
Oct 12 05:06:59.613 INFO blam! test src/alignment/sparse.rs - alignment::sparse (line 18) ... test src/alignment/sparse.rs - alignment::sparse (line 18) has been running for over 60 seconds
Oct 12 05:07:00.116 INFO blam! test <::custom_derive::custom_derive macros> - stats::probs::PHREDProb (line 46) ... ok
Oct 12 05:07:01.036 INFO blam! test src/alignment/pairwise/mod.rs - alignment::pairwise (line 13) ... ok
Oct 12 05:07:02.283 INFO blam! test src/alignment/pairwise/banded.rs - alignment::pairwise::banded (line 20) ... ok
Oct 12 05:07:04.921 INFO blam! test src/alignment/sparse.rs - alignment::sparse (line 18) ... ok
Oct 12 05:07:42.740 INFO blam! test src/alphabets/dna.rs - alphabets::dna (line 10) ... ok
Oct 12 05:07:48.952 INFO blam! test src/alphabets/rna.rs - alphabets::rna (line 10) ... ok
Oct 12 05:07:50.713 INFO blam! test src/data_structures/bit_tree.rs - data_structures::bit_tree (line 12) ... ok
Oct 12 05:07:53.956 INFO blam! test src/alphabets/mod.rs - alphabets (line 10) ... ok
Oct 12 05:07:57.868 INFO blam! test src/alphabets/protein.rs - alphabets::protein (line 10) ... ok
Oct 12 05:07:57.989 INFO blam! test src/data_structures/bwt.rs - data_structures::bwt::bwt (line 42) ... ok
Oct 12 05:07:58.202 INFO blam! test src/data_structures/fmindex.rs - data_structures::fmindex (line 12) ... ok
Oct 12 05:07:59.332 INFO blam! test src/data_structures/bitenc.rs - data_structures::bitenc (line 11) ... ok
Oct 12 05:08:22.648 INFO blam! test src/data_structures/fmindex.rs - data_structures::fmindex (line 34) ... ok
Oct 12 05:08:38.184 INFO blam! test src/data_structures/fmindex.rs - data_structures::fmindex::FMDIndex<DBWT, DLess, DOcc>::smems (line 266) ... ok
Oct 12 05:08:38.553 INFO blam! test src/data_structures/fmindex.rs - data_structures::fmindex::FMIndexable::backward_search (line 98) ... ok
Oct 12 05:08:40.179 INFO blam! test src/data_structures/rank_select.rs - data_structures::rank_select (line 11) ... ok
Oct 12 05:08:42.700 INFO blam! test src/data_structures/interval_tree.rs - data_structures::interval_tree (line 14) ... ok
Oct 12 05:08:42.944 INFO blam! test src/data_structures/qgram_index.rs - data_structures::qgram_index (line 10) ... ok
Oct 12 05:08:45.206 INFO blam! test src/data_structures/smallints.rs - data_structures::smallints (line 13) ... ok
Oct 12 05:08:48.456 INFO blam! test src/data_structures/suffix_array.rs - data_structures::suffix_array::lcp (line 239) ... ok
Oct 12 05:09:05.404 INFO blam! test src/data_structures/suffix_array.rs - data_structures::suffix_array::shortest_unique_substrings (line 304) ... ok
Oct 12 05:09:22.200 INFO blam! test src/io/bed.rs - io::bed (line 10) ... ok
Oct 12 05:09:23.634 INFO blam! test src/io/fasta.rs - io::fasta (line 10) ... ok
Oct 12 05:09:28.969 INFO blam! test src/io/fastq.rs - io::fastq (line 10) ... ok
Oct 12 05:09:29.962 INFO blam! test src/io/gff.rs - io::gff (line 14) ... ok
Oct 12 05:09:30.664 INFO blam! test src/lib.rs -  (line 31) ... ok
Oct 12 05:09:31.019 INFO blam! test src/data_structures/suffix_array.rs - data_structures::suffix_array::suffix_array (line 198) ... ok
Oct 12 05:09:34.072 INFO blam! test src/lib.rs -  (line 54) ... ok
Oct 12 05:10:01.757 INFO blam! test src/pattern_matching/bndm.rs - pattern_matching::bndm (line 12) ... ok
Oct 12 05:10:22.204 INFO blam! test src/pattern_matching/bom.rs - pattern_matching::bom (line 12) ... test src/pattern_matching/bom.rs - pattern_matching::bom (line 12) has been running for over 60 seconds
Oct 12 05:10:23.632 INFO blam! test src/pattern_matching/horspool.rs - pattern_matching::horspool (line 32) ... test src/pattern_matching/horspool.rs - pattern_matching::horspool (line 32) has been running for over 60 seconds
Oct 12 05:10:27.545 INFO blam! test src/pattern_matching/shift_and.rs - pattern_matching::shift_and (line 12) ... ok
Oct 12 05:10:28.107 INFO blam! test src/pattern_matching/bom.rs - pattern_matching::bom (line 12) ... ok
Oct 12 05:10:28.989 INFO blam! test src/pattern_matching/kmp.rs - pattern_matching::kmp (line 16) ... test src/pattern_matching/kmp.rs - pattern_matching::kmp (line 16) has been running for over 60 seconds
Oct 12 05:10:29.109 INFO blam! test src/pattern_matching/horspool.rs - pattern_matching::horspool (line 32) ... ok
Oct 12 05:10:29.968 INFO blam! test src/pattern_matching/myers.rs - pattern_matching::myers (line 13) ... test src/pattern_matching/myers.rs - pattern_matching::myers (line 13) has been running for over 60 seconds
Oct 12 05:10:31.021 INFO blam! test src/pattern_matching/ukkonen.rs - pattern_matching::ukkonen (line 17) ... test src/pattern_matching/ukkonen.rs - pattern_matching::ukkonen (line 17) has been running for over 60 seconds
Oct 12 05:10:34.080 INFO blam! test src/seq_analysis/orf.rs - seq_analysis::orf (line 12) ... test src/seq_analysis/orf.rs - seq_analysis::orf (line 12) has been running for over 60 seconds
Oct 12 05:10:36.289 INFO blam! test src/pattern_matching/myers.rs - pattern_matching::myers (line 13) ... ok
Oct 12 05:10:37.224 INFO blam! test src/pattern_matching/kmp.rs - pattern_matching::kmp (line 16) ... ok
Oct 12 05:10:37.944 INFO blam! test src/seq_analysis/orf.rs - seq_analysis::orf (line 12) ... ok
Oct 12 05:10:38.308 INFO blam! test src/pattern_matching/ukkonen.rs - pattern_matching::ukkonen (line 17) ... ok
Oct 12 05:10:46.144 INFO blam! test src/stats/hmm.rs - stats::hmm (line 15) ... ok
Oct 12 05:10:51.368 INFO blam! test src/stats/hmm.rs - stats::hmm (line 37) ... ok
Oct 12 05:10:51.368 INFO blam! 
Oct 12 05:10:51.368 INFO blam! test result: ok. 42 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 05:10:51.368 INFO blam! 
Oct 12 05:10:51.396 INFO kablam! su: No module specific data is present
Oct 12 05:10:52.440 INFO running `"docker" "rm" "-f" "64fa38bc53d934eac1ef441040fee7585edc60004a2a4ef4f3d4cad321156e2e"`
Oct 12 05:10:52.812 INFO blam! 64fa38bc53d934eac1ef441040fee7585edc60004a2a4ef4f3d4cad321156e2e