Nov 02 19:50:00.531 INFO testing gen-epub-book-2.3.1 against beta-2018-10-30 for beta-1.31-1
Nov 02 19:50:00.532 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-7/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 02 19:50:00.920 INFO blam! 1453b9adeea01662ef62018f128f671b9432c2b77bf17b850162d0afd2c51db4
Nov 02 19:50:00.921 INFO running `"docker" "start" "-a" "1453b9adeea01662ef62018f128f671b9432c2b77bf17b850162d0afd2c51db4"`
Nov 02 19:50:01.403 INFO kablam! usermod: no changes
Nov 02 19:50:01.735 INFO kablam!    Compiling gen-epub-book v2.3.1 (/source)
Nov 02 19:50:24.156 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 22.73s
Nov 02 19:50:24.169 INFO kablam! su: No module specific data is present
Nov 02 19:50:24.595 INFO running `"docker" "rm" "-f" "1453b9adeea01662ef62018f128f671b9432c2b77bf17b850162d0afd2c51db4"`
Nov 02 19:50:24.704 INFO blam! 1453b9adeea01662ef62018f128f671b9432c2b77bf17b850162d0afd2c51db4
Nov 02 19:50:24.706 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-7/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 02 19:50:24.877 INFO blam! 209b9d51f6ee1d7d78d42571b609bea7a34875822beade97598e8bd2107ce159
Nov 02 19:50:24.879 INFO running `"docker" "start" "-a" "209b9d51f6ee1d7d78d42571b609bea7a34875822beade97598e8bd2107ce159"`
Nov 02 19:50:25.267 INFO kablam! usermod: no changes
Nov 02 19:50:25.459 INFO kablam!    Compiling gen-epub-book v2.3.1 (/source)
Nov 02 19:50:39.643 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 14.35s
Nov 02 19:50:39.651 INFO kablam! su: No module specific data is present
Nov 02 19:50:40.099 INFO running `"docker" "rm" "-f" "209b9d51f6ee1d7d78d42571b609bea7a34875822beade97598e8bd2107ce159"`
Nov 02 19:50:40.294 INFO blam! 209b9d51f6ee1d7d78d42571b609bea7a34875822beade97598e8bd2107ce159
Nov 02 19:50:40.303 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-7/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 02 19:50:40.652 INFO blam! f46e792ce2a1a4fa36452a9dac3a7b1485a6f96ce39ddb9d056fa3a41d245f60
Nov 02 19:50:40.654 INFO running `"docker" "start" "-a" "f46e792ce2a1a4fa36452a9dac3a7b1485a6f96ce39ddb9d056fa3a41d245f60"`
Nov 02 19:50:41.449 INFO kablam! usermod: no changes
Nov 02 19:50:41.727 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.24s
Nov 02 19:50:41.749 INFO kablam!      Running /target/debug/deps/gen_epub_book-d20ec200984e212a
Nov 02 19:50:41.754 INFO kablam!      Running /target/debug/deps/lib-1f7098a59b944d69
Nov 02 19:50:41.755 INFO blam! 
Nov 02 19:50:41.755 INFO blam! running 0 tests
Nov 02 19:50:41.755 INFO blam! 
Nov 02 19:50:41.755 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 02 19:50:41.755 INFO blam! 
Nov 02 19:50:41.763 INFO blam! 
Nov 02 19:50:41.763 INFO blam! running 108 tests
Nov 02 19:50:41.766 INFO blam! test error::exit_value::parse ... ok
Nov 02 19:50:41.767 INFO blam! test error::exit_value::required_element_missing ... ok
Nov 02 19:50:41.767 INFO blam! test error::print::io::more::normal_non_e ... ok
Nov 02 19:50:41.774 INFO blam! test error::print::io::more::normal_e ... ok
Nov 02 19:50:41.775 INFO blam! test error::print::io::more::single_non_e ... ok
Nov 02 19:50:41.775 INFO blam! test error::print::io::no_more::empty ... ok
Nov 02 19:50:41.775 INFO blam! test error::exit_value::wrong_file_state ... ok
Nov 02 19:50:41.775 INFO blam! test error::print::file_not_found ... ok
Nov 02 19:50:41.775 INFO blam! test error::exit_value::wrong_element_amount ... ok
Nov 02 19:50:41.775 INFO blam! test error::print::io::no_more::single_e ... ok
Nov 02 19:50:41.775 INFO blam! test error::exit_value::io ... ok
Nov 02 19:50:41.775 INFO blam! test error::exit_value::file_not_found ... ok
Nov 02 19:50:41.775 INFO blam! test error::print::io::more::single_e ... ok
Nov 02 19:50:41.775 INFO blam! test error::print::io::more::empty ... ok
Nov 02 19:50:41.775 INFO blam! test error::print::io::no_more::single_non_e ... ok
Nov 02 19:50:41.775 INFO blam! test error::print::io::no_more::normal_e ... ok
Nov 02 19:50:41.775 INFO blam! test error::print::io::no_more::normal_non_e ... ok
Nov 02 19:50:41.783 INFO blam! test ops::book::from_elements::correct::no_cover ... ok
Nov 02 19:50:41.783 INFO blam! test error::print::required_element_missing ... ok
Nov 02 19:50:41.783 INFO blam! test error::print::wrong_element_amount ... ok
Nov 02 19:50:41.792 INFO blam! test error::print::parse::no_more ... ok
Nov 02 19:50:41.792 INFO blam! test ops::book::from_elements::incorrect::cover::mixed_network_first ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::from_elements::incorrect::cover::two_file ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::from_elements::incorrect::cover::mixed_file_first ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::from_elements::correct::file_cover ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::from_elements::correct::network_cover ... ok
Nov 02 19:50:41.811 INFO blam! test error::print::wrong_file_state ... ok
Nov 02 19:50:41.811 INFO blam! test error::print::parse::more ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::from_elements::incorrect::duplicate::ordering ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::from_elements::incorrect::cover::two_network ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::from_elements::incorrect::duplicate::author ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::from_elements::incorrect::duplicate::name ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::from_elements::incorrect::missing::language ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::from_elements::incorrect::missing::date ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::normalise_paths::no_verbose::bad_type ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::normalise_paths::no_verbose::correct ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::normalise_paths::no_verbose::nonexistant ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::from_elements::incorrect::missing::name ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::from_elements::incorrect::missing::ordering ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::from_elements::incorrect::duplicate::date ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::from_elements::incorrect::duplicate::language ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::normalise_paths::verbose::nonexistant ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::normalise_paths::verbose::bad_type ... ok
Nov 02 19:50:41.811 INFO blam! test ops::book::normalise_paths::verbose::correct ... ok
Nov 02 19:50:41.811 INFO blam! test ops::element::display::content ... ok
Nov 02 19:50:41.811 INFO blam! test ops::element::display::language ... ok
Nov 02 19:50:41.811 INFO blam! test ops::element::display::include ... ok
Nov 02 19:50:41.811 INFO blam! test ops::element::display::name ... ok
Nov 02 19:50:41.811 INFO blam! test ops::element::display::network_cover ... ok
Nov 02 19:50:41.811 INFO blam! test ops::element::display::network_image_content ... ok
Nov 02 19:50:41.811 INFO blam! test ops::element::display::network_include ... ok
Nov 02 19:50:41.811 INFO blam! test ops::element::display::string_content ... ok
Nov 02 19:50:41.811 INFO blam! test ops::element::name::author ... ok
Nov 02 19:50:41.811 INFO blam! test ops::element::name::content ... ok
Nov 02 19:50:41.811 INFO blam! test ops::element::name::cover ... ok
Nov 02 19:50:41.811 INFO blam! test ops::element::name::date ... ok
Nov 02 19:50:41.811 INFO blam! test ops::element::name::image_content ... ok
Nov 02 19:50:41.811 INFO blam! test ops::element::name::include ... ok
Nov 02 19:50:41.823 INFO blam! test ops::element::name::language ... ok
Nov 02 19:50:41.823 INFO blam! test ops::element::display::date ... ok
Nov 02 19:50:41.823 INFO blam! test ops::book::from_elements::incorrect::missing::author ... ok
Nov 02 19:50:41.823 INFO blam! test ops::element::display::image_content ... ok
Nov 02 19:50:41.823 INFO blam! test ops::element::display::cover ... ok
Nov 02 19:50:41.823 INFO blam! test ops::element::display::author ... ok
Nov 02 19:50:41.823 INFO blam! test ops::element::name::name ... ok
Nov 02 19:50:41.823 INFO blam! test ops::element::name::network_cover ... ok
Nov 02 19:50:41.824 INFO blam! test ops::element::parse::elements::author ... ok
Nov 02 19:50:41.824 INFO blam! test ops::element::parse::elements::content ... ok
Nov 02 19:50:41.824 INFO blam! test ops::element::parse::elements::date_free ... ok
Nov 02 19:50:41.824 INFO blam! test ops::element::parse::elements::date_rigid ... ok
Nov 02 19:50:41.824 INFO blam! test ops::element::name::network_image_content ... ok
Nov 02 19:50:41.824 INFO blam! test ops::element::name::network_include ... ok
Nov 02 19:50:41.824 INFO blam! test ops::element::name::string_content ... ok
Nov 02 19:50:41.824 INFO blam! test ops::element::parse::elements::cover ... ok
Nov 02 19:50:41.824 INFO blam! test ops::element::parse::elements::image_content ... ok
Nov 02 19:50:41.831 INFO blam! test ops::element::parse::elements::include ... ok
Nov 02 19:50:41.831 INFO blam! test ops::element::parse::elements::name ... ok
Nov 02 19:50:41.831 INFO blam! test ops::element::parse::elements::network_cover ... ok
Nov 02 19:50:41.831 INFO blam! test ops::element::parse::elements::network_image_content ... ok
Nov 02 19:50:41.831 INFO blam! test ops::element::parse::elements::string_content ... ok
Nov 02 19:50:41.831 INFO blam! test ops::element::parse::errors::datetime_free ... ok
Nov 02 19:50:41.831 INFO blam! test ops::element::parse::elements::network_include ... ok
Nov 02 19:50:41.831 INFO blam! test ops::element::parse::elements::language ... ok
Nov 02 19:50:41.831 INFO blam! test ops::element::parse::errors::datetime_rigid ... ok
Nov 02 19:50:41.831 INFO blam! test ops::element::parse::not_description ... ok
Nov 02 19:50:41.831 INFO blam! test ops::element::parse::errors::url ... ok
Nov 02 19:50:41.831 INFO blam! test ops::include_dir::display::unnamed ... ok
Nov 02 19:50:41.831 INFO blam! test ops::include_dir::display::named ... ok
Nov 02 19:50:41.831 INFO blam! test ops::element::parse::trimming ... ok
Nov 02 19:50:41.831 INFO blam! test ops::element::parse::unrecognised ... ok
Nov 02 19:50:41.831 INFO blam! test ops::include_dir::parse::correct::named ... ok
Nov 02 19:50:41.882 INFO blam! test ops::find_title::non_containing ... ok
Nov 02 19:50:41.883 INFO kablam!    Doc-tests gen-epub-book
Nov 02 19:50:41.883 INFO blam! test ops::find_title::containing ... ok
Nov 02 19:50:41.883 INFO blam! test ops::element::parse::roundtrip ... ok
Nov 02 19:50:41.883 INFO blam! test ops::include_dir::parse::incorrect::invalid::unnamed ... ok
Nov 02 19:50:41.883 INFO blam! test ops::include_dir::parse::incorrect::invalid::named ... ok
Nov 02 19:50:41.883 INFO blam! test ops::include_dir::parse::incorrect::nonexistant::named ... ok
Nov 02 19:50:41.883 INFO blam! test ops::include_dir::parse::incorrect::nonexistant::unnamed ... ok
Nov 02 19:50:41.883 INFO blam! test ops::parse_descriptor::bubbling ... ok
Nov 02 19:50:41.883 INFO blam! test ops::include_dir::parse::correct::unnamed ... ok
Nov 02 19:50:41.883 INFO blam! test util::uppercase_first::already_upper ... ok
Nov 02 19:50:41.883 INFO blam! test util::uppercase_first::multi ... ok
Nov 02 19:50:41.883 INFO blam! test util::uppercase_first::simple ... ok
Nov 02 19:50:41.883 INFO blam! test util::uppercase_first::single_already_upper ... ok
Nov 02 19:50:41.883 INFO blam! test util::uppercase_first::empty ... ok
Nov 02 19:50:41.883 INFO blam! test util::uppercase_first::single ... ok
Nov 02 19:50:41.883 INFO blam! test util::uppercase_first::multi_already_upper ... ok
Nov 02 19:50:41.883 INFO blam! test ops::parse_descriptor::generic ... ok
Nov 02 19:50:41.883 INFO blam! 
Nov 02 19:50:41.883 INFO blam! test result: ok. 108 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 02 19:50:41.883 INFO blam! 
Nov 02 19:50:54.227 INFO blam! 
Nov 02 19:50:54.227 INFO blam! running 25 tests
Nov 02 19:51:54.231 INFO blam! test src/error.rs - error::Error::print_error (line 67) ... test src/error.rs - error::Error::print_error (line 67) has been running for over 60 seconds
Nov 02 19:51:54.231 INFO blam! test src/ops/book.rs - ops::book::EPubBook::normalise_paths (line 191) ... test src/ops/book.rs - ops::book::EPubBook::normalise_paths (line 191) has been running for over 60 seconds
Nov 02 19:51:54.231 INFO blam! test src/ops/book.rs - ops::book::EPubBook::write_zip (line 253) ... test src/ops/book.rs - ops::book::EPubBook::write_zip (line 253) has been running for over 60 seconds
Nov 02 19:51:54.231 INFO blam! test src/ops/book.rs - ops::book::EPubBook::from_elements (line 64) ... test src/ops/book.rs - ops::book::EPubBook::from_elements (line 64) has been running for over 60 seconds
Nov 02 19:51:54.231 INFO blam! test src/ops/element.rs - ops::element::BookElement::name (line 227) ... test src/ops/element.rs - ops::element::BookElement::name (line 227) has been running for over 60 seconds
Nov 02 19:51:54.231 INFO blam! test src/error.rs - error::Error::exit_value (line 114) ... test src/error.rs - error::Error::exit_value (line 114) has been running for over 60 seconds
Nov 02 19:51:54.231 INFO blam! test src/ops/element.rs - ops::element::BookElement (line 16) ... test src/ops/element.rs - ops::element::BookElement (line 16) has been running for over 60 seconds
Nov 02 19:51:54.231 INFO blam! test src/ops/book.rs - ops::book::EPubBook::write_zip_ext (line 311) ... test src/ops/book.rs - ops::book::EPubBook::write_zip_ext (line 311) has been running for over 60 seconds
Nov 02 19:52:16.651 INFO blam! test src/error.rs - error::Error::exit_value (line 114) ... ok
Nov 02 19:52:19.091 INFO blam! test src/error.rs - error::Error::print_error (line 67) ... ok
Nov 02 19:52:27.015 INFO blam! test src/ops/element.rs - ops::element::BookElement::name (line 227) ... ok
Nov 02 19:52:30.759 INFO blam! test src/ops/element.rs - ops::element::BookElement (line 16) ... ok
Nov 02 19:52:32.799 INFO blam! test src/ops/book.rs - ops::book::EPubBook::normalise_paths (line 191) ... ok
Nov 02 19:52:34.495 INFO blam! test src/ops/book.rs - ops::book::EPubBook::from_elements (line 64) ... ok
Nov 02 19:52:44.461 INFO blam! test src/ops/book.rs - ops::book::EPubBook::write_zip_ext (line 311) ... ok
Nov 02 19:52:49.975 INFO blam! test src/ops/book.rs - ops::book::EPubBook::write_zip (line 253) ... ok
Nov 02 19:53:16.651 INFO blam! test src/ops/element.rs - ops::element::BookElement::parse (line 150) ... test src/ops/element.rs - ops::element::BookElement::parse (line 150) has been running for over 60 seconds
Nov 02 19:53:19.091 INFO blam! test src/ops/element.rs - ops::element::BookElement::parse (line 160) ... test src/ops/element.rs - ops::element::BookElement::parse (line 160) has been running for over 60 seconds
Nov 02 19:53:27.019 INFO blam! test src/ops/element.rs - ops::element::BookElement::parse (line 171) ... test src/ops/element.rs - ops::element::BookElement::parse (line 171) has been running for over 60 seconds
Nov 02 19:53:30.763 INFO blam! test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::directory_name (line 38) ... test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::directory_name (line 38) has been running for over 60 seconds
Nov 02 19:53:32.803 INFO blam! test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::packed_id (line 99) ... test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::packed_id (line 99) has been running for over 60 seconds
Nov 02 19:53:34.495 INFO blam! test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::packed_name (line 68) ... test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::packed_name (line 68) has been running for over 60 seconds
Nov 02 19:53:44.479 INFO blam! test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::resolve (line 127) ... test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::resolve (line 127) has been running for over 60 seconds
Nov 02 19:53:46.655 INFO blam! test src/ops/element.rs - ops::element::BookElement::parse (line 160) ... ok
Nov 02 19:53:49.982 INFO blam! test src/ops/mod.rs - ops::find_file (line 138) ... test src/ops/mod.rs - ops::find_file (line 138) has been running for over 60 seconds
Nov 02 19:53:56.327 INFO blam! test src/ops/element.rs - ops::element::BookElement::parse (line 150) ... ok
Nov 02 19:54:03.763 INFO blam! test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::directory_name (line 38) ... ok
Nov 02 19:54:05.648 INFO blam! test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::packed_name (line 68) ... ok
Nov 02 19:54:08.853 INFO blam! test src/ops/element.rs - ops::element::BookElement::parse (line 171) ... ok
Nov 02 19:54:12.187 INFO blam! test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::packed_id (line 99) ... ok
Nov 02 19:54:19.791 INFO blam! test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::resolve (line 127) ... ok
Nov 02 19:54:20.698 INFO blam! test src/ops/mod.rs - ops::find_file (line 138) ... ok
Nov 02 19:54:46.655 INFO blam! test src/ops/mod.rs - ops::find_title (line 92) ... test src/ops/mod.rs - ops::find_title (line 92) has been running for over 60 seconds
Nov 02 19:54:56.346 INFO blam! test src/ops/mod.rs - ops::parse_descriptor (line 36) ... test src/ops/mod.rs - ops::parse_descriptor (line 36) has been running for over 60 seconds
Nov 02 19:55:03.747 INFO blam! test src/options.rs - options (line 7) ... test src/options.rs - options (line 7) has been running for over 60 seconds
Nov 02 19:55:05.651 INFO blam! test src/util.rs - util::book_filename (line 65) ... test src/util.rs - util::book_filename (line 65) has been running for over 60 seconds
Nov 02 19:55:08.863 INFO blam! test src/util.rs - util::download_to (line 140) ... test src/util.rs - util::download_to (line 140) has been running for over 60 seconds
Nov 02 19:55:12.191 INFO blam! test src/util.rs - util::uppercase_first (line 35) ... test src/util.rs - util::uppercase_first (line 35) has been running for over 60 seconds
Nov 02 19:55:19.795 INFO blam! test src/util.rs - util::write_string_content (line 104) ... test src/util.rs - util::write_string_content (line 104) has been running for over 60 seconds
Nov 02 19:55:20.699 INFO blam! test src/util.rs - util::xhtml_path_id (line 53) ... test src/util.rs - util::xhtml_path_id (line 53) has been running for over 60 seconds
Nov 02 19:55:34.251 INFO blam! test src/ops/mod.rs - ops::find_title (line 92) ... ok
Nov 02 19:55:36.433 INFO blam! test src/ops/mod.rs - ops::parse_descriptor (line 36) ... ok
Nov 02 19:55:37.763 INFO blam! test src/options.rs - options (line 7) ... ok
Nov 02 19:55:44.975 INFO blam! test src/util.rs - util::uppercase_first (line 35) ... ok
Nov 02 19:55:46.115 INFO blam! test src/util.rs - util::book_filename (line 65) ... ok
Nov 02 19:55:48.631 INFO blam! test src/util.rs - util::write_string_content (line 104) ... ok
Nov 02 19:55:50.383 INFO blam! test src/util.rs - util::xhtml_path_id (line 53) ... ok
Nov 02 19:55:50.496 INFO blam! test src/util.rs - util::download_to (line 140) ... FAILED
Nov 02 19:55:59.847 INFO blam! test src/util.rs - util::xhtml_url_id (line 85) ... ok
Nov 02 19:55:59.847 INFO blam! 
Nov 02 19:55:59.848 INFO blam! failures:
Nov 02 19:55:59.848 INFO blam! 
Nov 02 19:55:59.849 INFO blam! ---- src/util.rs - util::download_to (line 140) stdout ----
Nov 02 19:55:59.849 INFO blam! thread 'src/util.rs - util::download_to (line 140)' panicked at 'test executable failed:
Nov 02 19:55:59.849 INFO blam! 
Nov 02 19:55:59.849 INFO blam! thread 'main' panicked at 'assertion failed: `(left == right)`
Nov 02 19:55:59.850 INFO blam!   left: `Err(Io { desc: "network content", op: "request", more: None })`,
Nov 02 19:55:59.850 INFO blam!  right: `Ok(())`', src/util.rs:8:1
Nov 02 19:55:59.850 INFO blam! stack backtrace:
Nov 02 19:55:59.850 INFO blam!    0:     0x55e76c50f2af - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c55afa80a996a32
Nov 02 19:55:59.851 INFO blam!                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Nov 02 19:55:59.851 INFO blam!    1:     0x55e76c5189f7 - std::sys_common::backtrace::print::hcef907ea7a07cd40
Nov 02 19:55:59.851 INFO blam!                                at libstd/sys_common/backtrace.rs:71
Nov 02 19:55:59.852 INFO blam!                                at libstd/sys_common/backtrace.rs:59
Nov 02 19:55:59.852 INFO blam!    2:     0x55e76c51350f - std::panicking::default_hook::{{closure}}::hf541876c65f36ea7
Nov 02 19:55:59.852 INFO blam!                                at libstd/panicking.rs:211
Nov 02 19:55:59.852 INFO blam!    3:     0x55e76c513274 - std::panicking::default_hook::h4ecc06b30ae4459d
Nov 02 19:55:59.853 INFO blam!                                at libstd/panicking.rs:227
Nov 02 19:55:59.853 INFO blam!    4:     0x55e76c513bee - std::panicking::rust_panic_with_hook::h0cc6d9cc9f34a947
Nov 02 19:55:59.853 INFO blam!                                at libstd/panicking.rs:476
Nov 02 19:55:59.853 INFO blam!    5:     0x55e76c513791 - std::panicking::continue_panic_fmt::hc71ad5f01496e320
Nov 02 19:55:59.854 INFO blam!                                at libstd/panicking.rs:390
Nov 02 19:55:59.854 INFO blam!    6:     0x55e76c5136de - std::panicking::begin_panic_fmt::hdb958223ae20ca60
Nov 02 19:55:59.854 INFO blam!                                at libstd/panicking.rs:345
Nov 02 19:55:59.854 INFO blam!    7:     0x55e76bffa265 - rust_out::main::h944e552f3f67b4ba
Nov 02 19:55:59.855 INFO blam!    8:     0x55e76bff9fb2 - std::rt::lang_start::{{closure}}::h55d770898514aeb4
Nov 02 19:55:59.855 INFO blam!    9:     0x55e76c513612 - std::panicking::try::do_call::h203c4989fde7f201
Nov 02 19:55:59.855 INFO blam!                                at libstd/rt.rs:59
Nov 02 19:55:59.855 INFO blam!                                at libstd/panicking.rs:310
Nov 02 19:55:59.856 INFO blam!   10:     0x55e76c523c29 - __rust_maybe_catch_panic
Nov 02 19:55:59.856 INFO blam!                                at libpanic_unwind/lib.rs:102
Nov 02 19:55:59.856 INFO blam!   11:     0x55e76c5042ea - std::rt::lang_start_internal::h80fd76ad39d9c8d9
Nov 02 19:55:59.856 INFO blam!                                at libstd/panicking.rs:289
Nov 02 19:55:59.857 INFO blam!                                at libstd/panic.rs:392
Nov 02 19:55:59.857 INFO blam!                                at libstd/rt.rs:58
Nov 02 19:55:59.857 INFO blam!   12:     0x55e76bff9f94 - std::rt::lang_start::h6dd5f188d9e0f86d
Nov 02 19:55:59.857 INFO blam!   13:     0x55e76bffa4ba - main
Nov 02 19:55:59.858 INFO blam!   14:     0x7efc33ea482f - __libc_start_main
Nov 02 19:55:59.858 INFO blam!   15:     0x55e76bff86c8 - _start
Nov 02 19:55:59.858 INFO blam!   16:                0x0 - <unknown>
Nov 02 19:55:59.858 INFO kablam! error: test failed, to rerun pass '--doc'
Nov 02 19:55:59.859 INFO blam! 
Nov 02 19:55:59.859 INFO blam! ', librustdoc/test.rs:367:17
Nov 02 19:55:59.859 INFO blam! stack backtrace:
Nov 02 19:55:59.860 INFO blam!    0:     0x7fc9838076ff - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c55afa80a996a32
Nov 02 19:55:59.860 INFO kablam! su: No module specific data is present
Nov 02 19:55:59.860 INFO blam!                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Nov 02 19:55:59.860 INFO blam!    1:     0x7fc9837ec697 - std::sys_common::backtrace::print::hcef907ea7a07cd40
Nov 02 19:55:59.861 INFO blam!                                at libstd/sys_common/backtrace.rs:71
Nov 02 19:55:59.861 INFO blam!                                at libstd/sys_common/backtrace.rs:59
Nov 02 19:55:59.861 INFO blam!    2:     0x7fc983812acf - std::panicking::default_hook::{{closure}}::hf541876c65f36ea7
Nov 02 19:55:59.861 INFO blam!                                at libstd/panicking.rs:211
Nov 02 19:55:59.862 INFO blam!    3:     0x7fc9838127ce - std::panicking::default_hook::h4ecc06b30ae4459d
Nov 02 19:55:59.862 INFO blam!                                at libstd/panicking.rs:221
Nov 02 19:55:59.862 INFO blam!    4:     0x7fc985aae6d1 - rustc::util::common::panic_hook::hf4e6f5c3b281764b
Nov 02 19:55:59.862 INFO blam!    5:     0x7fc9838132c6 - std::panicking::rust_panic_with_hook::h0cc6d9cc9f34a947
Nov 02 19:55:59.863 INFO blam!                                at libstd/panicking.rs:480
Nov 02 19:55:59.865 INFO blam!    6:     0x7fc983812e11 - std::panicking::continue_panic_fmt::hc71ad5f01496e320
Nov 02 19:55:59.865 INFO blam!                                at libstd/panicking.rs:390
Nov 02 19:55:59.866 INFO blam!    7:     0x7fc983812d5e - std::panicking::begin_panic_fmt::hdb958223ae20ca60
Nov 02 19:55:59.866 INFO blam!                                at libstd/panicking.rs:345
Nov 02 19:55:59.866 INFO blam!    8:     0x559dc5f99a38 - <rustdoc::test::Collector as rustdoc::test::Tester>::add_test::{{closure}}::{{closure}}::{{closure}}::h1097dd2aed0bc349
Nov 02 19:55:59.867 INFO blam!                                at librustdoc/test.rs:367
Nov 02 19:55:59.867 INFO blam!                                at librustdoc/test.rs:596
Nov 02 19:55:59.867 INFO blam!    9:     0x559dc5f4ec78 - <scoped_tls::ScopedKey<T>>::set::h9bba31b35056dc07
Nov 02 19:55:59.868 INFO blam!                                at /cargo/registry/src/github.com-1ecc6299db9ec823/scoped-tls-0.1.2/src/lib.rs:155
Nov 02 19:55:59.868 INFO blam!                                at libsyntax/lib.rs:106
Nov 02 19:55:59.868 INFO blam!                                at /cargo/registry/src/github.com-1ecc6299db9ec823/scoped-tls-0.1.2/src/lib.rs:155
Nov 02 19:55:59.868 INFO blam!   10:     0x559dc5d54481 - syntax::with_globals::h4fd10729776cd915
Nov 02 19:55:59.869 INFO blam!                                at libsyntax/lib.rs:105
Nov 02 19:55:59.869 INFO blam!   11:     0x559dc5e075cb - std::panicking::try::do_call::he572b5001749b5c7
Nov 02 19:55:59.869 INFO blam!                                at librustdoc/test.rs:593
Nov 02 19:55:59.870 INFO blam!                                at libstd/panic.rs:313
Nov 02 19:55:59.870 INFO blam!                                at libstd/panicking.rs:310
Nov 02 19:55:59.870 INFO blam!   12:     0x7fc983820de9 - __rust_maybe_catch_panic
Nov 02 19:55:59.870 INFO blam!                                at libpanic_unwind/lib.rs:102
Nov 02 19:55:59.871 INFO blam!   13:     0x559dc5e29079 - rustc_driver::in_named_rustc_thread::hc8aa36ae7168454b
Nov 02 19:55:59.871 INFO blam!                                at libstd/panicking.rs:289
Nov 02 19:55:59.871 INFO blam!                                at libstd/panic.rs:392
Nov 02 19:55:59.871 INFO blam!                                at librustc_driver/lib.rs:1546
Nov 02 19:55:59.872 INFO blam!   14:     0x559dc5f67960 - <F as alloc::boxed::FnBox<A>>::call_box::hf53e55f306710650
Nov 02 19:55:59.872 INFO blam!                                at librustdoc/test.rs:593
Nov 02 19:55:59.872 INFO blam!                                at liballoc/boxed.rs:672
Nov 02 19:55:59.873 INFO blam!   15:     0x7fc984e7f142 - <F as alloc::boxed::FnBox<A>>::call_box::hecf56d722ce7bb71
Nov 02 19:55:59.873 INFO blam!                                at libtest/lib.rs:1461
Nov 02 19:55:59.873 INFO blam!                                at liballoc/boxed.rs:672
Nov 02 19:55:59.873 INFO blam!   16:     0x7fc983820de9 - __rust_maybe_catch_panic
Nov 02 19:55:59.873 INFO blam!                                at libpanic_unwind/lib.rs:102
Nov 02 19:55:59.874 INFO blam!   17:     0x7fc984ea7412 - std::sys_common::backtrace::__rust_begin_short_backtrace::h1bb71a7386fd3269
Nov 02 19:55:59.874 INFO blam!                                at libstd/panicking.rs:289
Nov 02 19:55:59.874 INFO blam!                                at libstd/panic.rs:392
Nov 02 19:55:59.874 INFO blam!                                at libtest/lib.rs:1423
Nov 02 19:55:59.875 INFO blam!                                at libstd/sys_common/backtrace.rs:136
Nov 02 19:55:59.875 INFO blam!   18:     0x7fc984ea81b4 - std::panicking::try::do_call::h9b94719c3074bb5c
Nov 02 19:55:59.875 INFO blam!                                at libstd/thread/mod.rs:409
Nov 02 19:55:59.875 INFO blam!                                at libstd/panic.rs:313
Nov 02 19:55:59.876 INFO blam!                                at libstd/panicking.rs:310
Nov 02 19:55:59.876 INFO blam!   19:     0x7fc983820de9 - __rust_maybe_catch_panic
Nov 02 19:55:59.876 INFO blam!                                at libpanic_unwind/lib.rs:102
Nov 02 19:55:59.876 INFO blam!   20:     0x7fc984e9090c - <F as alloc::boxed::FnBox<A>>::call_box::hb3bcd66d16fd3e84
Nov 02 19:55:59.877 INFO blam!                                at libstd/panicking.rs:289
Nov 02 19:55:59.877 INFO blam!                                at libstd/panic.rs:392
Nov 02 19:55:59.877 INFO blam!                                at libstd/thread/mod.rs:408
Nov 02 19:55:59.877 INFO blam!                                at liballoc/boxed.rs:672
Nov 02 19:55:59.878 INFO blam!   21:     0x7fc98380da8d - std::sys_common::thread::start_thread::had0c80d121669d29
Nov 02 19:55:59.878 INFO blam!                                at liballoc/boxed.rs:682
Nov 02 19:55:59.878 INFO blam!                                at libstd/sys_common/thread.rs:24
Nov 02 19:55:59.878 INFO blam!   22:     0x7fc9837e3435 - std::sys::unix::thread::Thread::new::thread_start::h4a5b66a70d76f47f
Nov 02 19:55:59.879 INFO blam!                                at libstd/sys/unix/thread.rs:90
Nov 02 19:55:59.879 INFO blam!   23:     0x7fc98336f6b9 - start_thread
Nov 02 19:55:59.879 INFO blam!   24:     0x7fc982e8f41c - clone
Nov 02 19:55:59.879 INFO blam!   25:                0x0 - <unknown>
Nov 02 19:55:59.880 INFO blam! query stack during panic:
Nov 02 19:55:59.880 INFO blam! end of query stack
Nov 02 19:55:59.881 INFO blam! 
Nov 02 19:55:59.881 INFO blam! 
Nov 02 19:55:59.881 INFO blam! failures:
Nov 02 19:55:59.881 INFO blam!     src/util.rs - util::download_to (line 140)
Nov 02 19:55:59.882 INFO blam! 
Nov 02 19:55:59.882 INFO blam! test result: FAILED. 24 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Nov 02 19:55:59.882 INFO blam! 
Nov 02 19:56:00.287 INFO running `"docker" "rm" "-f" "f46e792ce2a1a4fa36452a9dac3a7b1485a6f96ce39ddb9d056fa3a41d245f60"`
Nov 02 19:56:00.520 INFO blam! f46e792ce2a1a4fa36452a9dac3a7b1485a6f96ce39ddb9d056fa3a41d245f60
