Dec 07 15:49:44.884 INFO testing gen-epub-book-2.3.1 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514 Dec 07 15:49:44.884 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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"` Dec 07 15:49:45.145 INFO [stdout] e5677eb058bdca09cb5a50ff364fd1d38a27d5e63fa942284e25d6956879b8e5 Dec 07 15:49:45.147 INFO running `"docker" "start" "-a" "e5677eb058bdca09cb5a50ff364fd1d38a27d5e63fa942284e25d6956879b8e5"` Dec 07 15:49:45.585 INFO [stderr] usermod: no changes Dec 07 15:49:45.905 INFO [stderr] Compiling zip v0.4.2 Dec 07 15:49:48.000 INFO [stderr] Compiling gen-epub-book v2.3.1 (/source) Dec 07 15:50:15.529 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 29.92s Dec 07 15:50:15.559 INFO [stderr] su: No module specific data is present Dec 07 15:50:16.369 INFO running `"docker" "inspect" "e5677eb058bdca09cb5a50ff364fd1d38a27d5e63fa942284e25d6956879b8e5"` Dec 07 15:50:16.558 INFO running `"docker" "rm" "-f" "e5677eb058bdca09cb5a50ff364fd1d38a27d5e63fa942284e25d6956879b8e5"` Dec 07 15:50:16.802 INFO [stdout] e5677eb058bdca09cb5a50ff364fd1d38a27d5e63fa942284e25d6956879b8e5 Dec 07 15:50:16.806 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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"` Dec 07 15:50:17.085 INFO [stdout] c54f44a2d39466f7bc417729cde600b810145551efde92c4ec5a4d5d66af7b49 Dec 07 15:50:17.090 INFO running `"docker" "start" "-a" "c54f44a2d39466f7bc417729cde600b810145551efde92c4ec5a4d5d66af7b49"` Dec 07 15:50:17.668 INFO [stderr] usermod: no changes Dec 07 15:50:17.819 INFO [stderr] Compiling gen-epub-book v2.3.1 (/source) Dec 07 15:50:32.438 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 14.79s Dec 07 15:50:32.454 INFO [stderr] su: No module specific data is present Dec 07 15:50:32.762 INFO running `"docker" "inspect" "c54f44a2d39466f7bc417729cde600b810145551efde92c4ec5a4d5d66af7b49"` Dec 07 15:50:32.864 INFO running `"docker" "rm" "-f" "c54f44a2d39466f7bc417729cde600b810145551efde92c4ec5a4d5d66af7b49"` Dec 07 15:50:32.987 INFO [stdout] c54f44a2d39466f7bc417729cde600b810145551efde92c4ec5a4d5d66af7b49 Dec 07 15:50:32.989 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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"` Dec 07 15:50:33.214 INFO [stdout] de8150eecf52f3cfedab13e0719930096293b6ec592de29802c1aa2fa3dd1234 Dec 07 15:50:33.218 INFO running `"docker" "start" "-a" "de8150eecf52f3cfedab13e0719930096293b6ec592de29802c1aa2fa3dd1234"` Dec 07 15:50:33.923 INFO [stderr] usermod: no changes Dec 07 15:50:34.155 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.20s Dec 07 15:50:34.181 INFO [stderr] Running /target/debug/deps/gen_epub_book-c9a48e77866f99bd Dec 07 15:50:34.192 INFO [stderr] Running /target/debug/deps/lib-587ec376e1292638 Dec 07 15:50:34.192 INFO [stdout] Dec 07 15:50:34.192 INFO [stdout] running 0 tests Dec 07 15:50:34.192 INFO [stdout] Dec 07 15:50:34.192 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 15:50:34.192 INFO [stdout] Dec 07 15:50:34.194 INFO [stdout] Dec 07 15:50:34.194 INFO [stdout] running 108 tests Dec 07 15:50:34.194 INFO [stdout] test error::print::io::more::empty ... ok Dec 07 15:50:34.194 INFO [stdout] test error::print::file_not_found ... ok Dec 07 15:50:34.194 INFO [stdout] test error::exit_value::wrong_file_state ... ok Dec 07 15:50:34.194 INFO [stdout] test error::exit_value::wrong_element_amount ... ok Dec 07 15:50:34.194 INFO [stdout] test error::exit_value::required_element_missing ... ok Dec 07 15:50:34.194 INFO [stdout] test error::print::io::more::normal_non_e ... ok Dec 07 15:50:34.194 INFO [stdout] test error::print::io::more::single_e ... ok Dec 07 15:50:34.194 INFO [stdout] test error::print::io::more::single_non_e ... ok Dec 07 15:50:34.200 INFO [stdout] test error::print::io::no_more::empty ... ok Dec 07 15:50:34.200 INFO [stdout] test error::print::io::more::normal_e ... ok Dec 07 15:50:34.200 INFO [stdout] test error::exit_value::io ... ok Dec 07 15:50:34.200 INFO [stdout] test error::exit_value::parse ... ok Dec 07 15:50:34.200 INFO [stdout] test error::print::io::no_more::normal_e ... ok Dec 07 15:50:34.200 INFO [stdout] test error::print::io::no_more::normal_non_e ... ok Dec 07 15:50:34.200 INFO [stdout] test error::print::io::no_more::single_e ... ok Dec 07 15:50:34.204 INFO [stdout] test error::print::wrong_file_state ... ok Dec 07 15:50:34.237 INFO [stdout] test error::exit_value::file_not_found ... ok Dec 07 15:50:34.237 INFO [stdout] test error::print::parse::no_more ... ok Dec 07 15:50:34.238 INFO [stdout] test error::print::wrong_element_amount ... ok Dec 07 15:50:34.238 INFO [stdout] test error::print::required_element_missing ... ok Dec 07 15:50:34.238 INFO [stdout] test error::print::io::no_more::single_non_e ... ok Dec 07 15:50:34.238 INFO [stdout] test error::print::parse::more ... ok Dec 07 15:50:34.240 INFO [stdout] test ops::book::from_elements::correct::network_cover ... ok Dec 07 15:50:34.241 INFO [stdout] test ops::book::from_elements::correct::file_cover ... ok Dec 07 15:50:34.241 INFO [stdout] test ops::book::from_elements::incorrect::cover::mixed_file_first ... ok Dec 07 15:50:34.242 INFO [stdout] test ops::book::from_elements::incorrect::cover::mixed_network_first ... ok Dec 07 15:50:34.242 INFO [stdout] test ops::book::from_elements::incorrect::duplicate::date ... ok Dec 07 15:50:34.242 INFO [stdout] test ops::book::from_elements::incorrect::duplicate::language ... ok Dec 07 15:50:34.242 INFO [stdout] test ops::book::from_elements::incorrect::duplicate::name ... ok Dec 07 15:50:34.242 INFO [stdout] test ops::book::from_elements::incorrect::duplicate::ordering ... ok Dec 07 15:50:34.242 INFO [stdout] test ops::book::from_elements::correct::no_cover ... ok Dec 07 15:50:34.243 INFO [stdout] test ops::book::from_elements::incorrect::cover::two_network ... ok Dec 07 15:50:34.243 INFO [stdout] test ops::book::from_elements::incorrect::missing::language ... ok Dec 07 15:50:34.244 INFO [stdout] test ops::book::from_elements::incorrect::missing::name ... ok Dec 07 15:50:34.244 INFO [stdout] test ops::book::from_elements::incorrect::cover::two_file ... ok Dec 07 15:50:34.246 INFO [stdout] test ops::book::from_elements::incorrect::missing::author ... ok Dec 07 15:50:34.260 INFO [stdout] test ops::book::from_elements::incorrect::missing::date ... ok Dec 07 15:50:34.260 INFO [stdout] test ops::book::from_elements::incorrect::duplicate::author ... ok Dec 07 15:50:34.261 INFO [stdout] test ops::book::normalise_paths::no_verbose::bad_type ... ok Dec 07 15:50:34.261 INFO [stdout] test ops::book::from_elements::incorrect::missing::ordering ... ok Dec 07 15:50:34.262 INFO [stdout] test ops::book::normalise_paths::no_verbose::correct ... ok Dec 07 15:50:34.262 INFO [stdout] test ops::element::display::cover ... ok Dec 07 15:50:34.262 INFO [stdout] test ops::element::display::date ... ok Dec 07 15:50:34.263 INFO [stdout] test ops::element::display::content ... ok Dec 07 15:50:34.263 INFO [stdout] test ops::book::normalise_paths::no_verbose::nonexistant ... ok Dec 07 15:50:34.264 INFO [stdout] test ops::element::display::author ... ok Dec 07 15:50:34.264 INFO [stdout] test ops::element::display::language ... ok Dec 07 15:50:34.264 INFO [stdout] test ops::element::display::name ... ok Dec 07 15:50:34.264 INFO [stdout] test ops::element::display::network_cover ... ok Dec 07 15:50:34.265 INFO [stdout] test ops::element::display::network_include ... ok Dec 07 15:50:34.265 INFO [stdout] test ops::element::display::image_content ... ok Dec 07 15:50:34.265 INFO [stdout] test ops::book::normalise_paths::verbose::bad_type ... ok Dec 07 15:50:34.265 INFO [stdout] test ops::element::display::include ... ok Dec 07 15:50:34.266 INFO [stdout] test ops::book::normalise_paths::verbose::correct ... ok Dec 07 15:50:34.267 INFO [stdout] test ops::book::normalise_paths::verbose::nonexistant ... ok Dec 07 15:50:34.268 INFO [stdout] test ops::element::name::cover ... ok Dec 07 15:50:34.269 INFO [stdout] test ops::element::display::network_image_content ... ok Dec 07 15:50:34.269 INFO [stdout] test ops::element::display::string_content ... ok Dec 07 15:50:34.269 INFO [stdout] test ops::element::name::author ... ok Dec 07 15:50:34.270 INFO [stdout] test ops::element::name::date ... ok Dec 07 15:50:34.270 INFO [stdout] test ops::element::name::network_cover ... ok Dec 07 15:50:34.270 INFO [stdout] test ops::element::name::image_content ... ok Dec 07 15:50:34.270 INFO [stdout] test ops::element::name::network_image_content ... ok Dec 07 15:50:34.270 INFO [stdout] test ops::element::name::language ... ok Dec 07 15:50:34.270 INFO [stdout] test ops::element::name::name ... ok Dec 07 15:50:34.276 INFO [stdout] test ops::element::name::content ... ok Dec 07 15:50:34.276 INFO [stdout] test ops::element::name::include ... ok Dec 07 15:50:34.285 INFO [stdout] test ops::element::name::string_content ... ok Dec 07 15:50:34.285 INFO [stdout] test ops::element::name::network_include ... ok Dec 07 15:50:34.285 INFO [stdout] test ops::element::parse::elements::content ... ok Dec 07 15:50:34.285 INFO [stdout] test ops::element::parse::elements::date_rigid ... ok Dec 07 15:50:34.285 INFO [stdout] test ops::element::parse::elements::date_free ... ok Dec 07 15:50:34.285 INFO [stdout] test ops::element::parse::elements::author ... ok Dec 07 15:50:34.285 INFO [stdout] test ops::element::parse::elements::cover ... ok Dec 07 15:50:34.292 INFO [stdout] test ops::element::parse::elements::include ... ok Dec 07 15:50:34.292 INFO [stdout] test ops::element::parse::elements::string_content ... ok Dec 07 15:50:34.292 INFO [stdout] test ops::element::parse::elements::language ... ok Dec 07 15:50:34.292 INFO [stdout] test ops::element::parse::elements::name ... ok Dec 07 15:50:34.312 INFO [stdout] test ops::element::parse::errors::datetime_free ... ok Dec 07 15:50:34.312 INFO [stdout] test ops::element::parse::errors::datetime_rigid ... ok Dec 07 15:50:34.312 INFO [stdout] test ops::element::parse::errors::url ... ok Dec 07 15:50:34.312 INFO [stdout] test ops::element::parse::elements::network_image_content ... ok Dec 07 15:50:34.312 INFO [stdout] test ops::element::parse::not_description ... ok Dec 07 15:50:34.313 INFO [stdout] test ops::element::parse::elements::network_include ... ok Dec 07 15:50:34.316 INFO [stdout] test ops::element::parse::elements::network_cover ... ok Dec 07 15:50:34.316 INFO [stdout] test ops::element::parse::elements::image_content ... ok Dec 07 15:50:34.316 INFO [stdout] test ops::element::parse::roundtrip ... ok Dec 07 15:50:34.324 INFO [stdout] test ops::element::parse::trimming ... ok Dec 07 15:50:34.324 INFO [stdout] test ops::element::parse::unrecognised ... ok Dec 07 15:50:34.324 INFO [stdout] test ops::include_dir::display::named ... ok Dec 07 15:50:34.324 INFO [stdout] test ops::include_dir::parse::correct::named ... ok Dec 07 15:50:34.324 INFO [stdout] test ops::include_dir::display::unnamed ... ok Dec 07 15:50:34.325 INFO [stdout] test ops::include_dir::parse::correct::unnamed ... ok Dec 07 15:50:34.340 INFO [stdout] test ops::include_dir::parse::incorrect::nonexistant::named ... ok Dec 07 15:50:34.340 INFO [stdout] test ops::include_dir::parse::incorrect::invalid::named ... ok Dec 07 15:50:34.340 INFO [stdout] test ops::include_dir::parse::incorrect::invalid::unnamed ... ok Dec 07 15:50:34.340 INFO [stdout] test ops::include_dir::parse::incorrect::nonexistant::unnamed ... ok Dec 07 15:50:34.340 INFO [stdout] test ops::parse_descriptor::generic ... ok Dec 07 15:50:34.341 INFO [stdout] test ops::find_title::non_containing ... ok Dec 07 15:50:34.344 INFO [stdout] test ops::parse_descriptor::bubbling ... ok Dec 07 15:50:34.345 INFO [stdout] test util::uppercase_first::empty ... ok Dec 07 15:50:34.345 INFO [stdout] test util::uppercase_first::already_upper ... ok Dec 07 15:50:34.345 INFO [stdout] test util::uppercase_first::multi ... ok Dec 07 15:50:34.345 INFO [stdout] test util::uppercase_first::single ... ok Dec 07 15:50:34.354 INFO [stdout] test util::uppercase_first::multi_already_upper ... ok Dec 07 15:50:34.354 INFO [stdout] test util::uppercase_first::simple ... ok Dec 07 15:50:34.356 INFO [stdout] test util::uppercase_first::single_already_upper ... ok Dec 07 15:50:34.368 INFO [stdout] test ops::find_title::containing ... ok Dec 07 15:50:34.368 INFO [stdout] Dec 07 15:50:34.368 INFO [stdout] test result: ok. 108 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 15:50:34.368 INFO [stdout] Dec 07 15:50:34.369 INFO [stderr] Doc-tests gen-epub-book Dec 07 15:50:51.036 INFO [stdout] Dec 07 15:50:51.036 INFO [stdout] running 25 tests Dec 07 15:51:51.056 INFO [stdout] 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 Dec 07 15:51:51.056 INFO [stdout] 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 Dec 07 15:51:51.056 INFO [stdout] 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 Dec 07 15:51:51.080 INFO [stdout] 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 Dec 07 15:51:51.080 INFO [stdout] 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 Dec 07 15:51:51.080 INFO [stdout] 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 Dec 07 15:51:51.080 INFO [stdout] 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 Dec 07 15:51:51.080 INFO [stdout] 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 Dec 07 15:52:49.724 INFO [stdout] test src/ops/book.rs - ops::book::EPubBook::normalise_paths (line 191) ... ok Dec 07 15:52:50.936 INFO [stdout] test src/error.rs - error::Error::exit_value (line 114) ... ok Dec 07 15:52:50.952 INFO [stdout] test src/ops/book.rs - ops::book::EPubBook::from_elements (line 64) ... ok Dec 07 15:52:54.148 INFO [stdout] test src/ops/element.rs - ops::element::BookElement::name (line 227) ... ok Dec 07 15:53:00.748 INFO [stdout] test src/error.rs - error::Error::print_error (line 67) ... ok Dec 07 15:53:06.023 INFO [stdout] test src/ops/element.rs - ops::element::BookElement (line 16) ... ok Dec 07 15:53:07.796 INFO [stdout] test src/ops/book.rs - ops::book::EPubBook::write_zip (line 253) ... ok Dec 07 15:53:18.957 INFO [stdout] test src/ops/book.rs - ops::book::EPubBook::write_zip_ext (line 311) ... ok Dec 07 15:53:49.732 INFO [stdout] 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 Dec 07 15:53:50.948 INFO [stdout] 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 Dec 07 15:53:50.956 INFO [stdout] 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 Dec 07 15:53:54.140 INFO [stdout] 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 Dec 07 15:54:00.760 INFO [stdout] 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 Dec 07 15:54:06.024 INFO [stdout] 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 Dec 07 15:54:07.800 INFO [stdout] 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 Dec 07 15:54:18.972 INFO [stdout] 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 Dec 07 15:54:34.752 INFO [stdout] test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::directory_name (line 38) ... ok Dec 07 15:54:41.940 INFO [stdout] test src/ops/element.rs - ops::element::BookElement::parse (line 150) ... ok Dec 07 15:54:52.816 INFO [stdout] test src/ops/element.rs - ops::element::BookElement::parse (line 160) ... ok Dec 07 15:54:55.176 INFO [stdout] test src/ops/element.rs - ops::element::BookElement::parse (line 171) ... ok Dec 07 15:54:55.471 INFO [stdout] test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::packed_name (line 68) ... ok Dec 07 15:54:56.652 INFO [stdout] test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::packed_id (line 99) ... ok Dec 07 15:55:00.600 INFO [stdout] test src/ops/include_dir.rs - ops::include_dir::IncludeDirectory::resolve (line 127) ... ok Dec 07 15:55:11.052 INFO [stdout] test src/ops/mod.rs - ops::find_file (line 138) ... ok Dec 07 15:55:34.756 INFO [stdout] 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 Dec 07 15:55:41.944 INFO [stdout] 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 Dec 07 15:55:52.816 INFO [stdout] test src/options.rs - options (line 7) ... test src/options.rs - options (line 7) has been running for over 60 seconds Dec 07 15:55:55.180 INFO [stdout] 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 Dec 07 15:55:55.469 INFO [stdout] 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 Dec 07 15:55:55.500 INFO [stdout] test src/ops/mod.rs - ops::find_title (line 92) ... ok Dec 07 15:55:56.104 INFO [stdout] test src/ops/mod.rs - ops::parse_descriptor (line 36) ... ok Dec 07 15:55:56.669 INFO [stdout] 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 Dec 07 15:55:59.272 INFO [stdout] test src/options.rs - options (line 7) ... ok Dec 07 15:56:00.612 INFO [stdout] 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 Dec 07 15:56:00.796 INFO [stdout] test src/util.rs - util::uppercase_first (line 35) ... ok Dec 07 15:56:04.888 INFO [stdout] test src/util.rs - util::book_filename (line 65) ... ok Dec 07 15:56:11.052 INFO [stdout] 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 Dec 07 15:56:11.116 INFO [stdout] test src/util.rs - util::download_to (line 140) ... FAILED Dec 07 15:56:12.808 INFO [stdout] test src/util.rs - util::write_string_content (line 104) ... ok Dec 07 15:56:13.516 INFO [stdout] test src/util.rs - util::xhtml_path_id (line 53) ... ok Dec 07 15:56:24.549 INFO [stdout] test src/util.rs - util::xhtml_url_id (line 85) ... ok Dec 07 15:56:24.549 INFO [stdout] Dec 07 15:56:24.549 INFO [stdout] failures: Dec 07 15:56:24.549 INFO [stdout] Dec 07 15:56:24.549 INFO [stdout] ---- src/util.rs - util::download_to (line 140) stdout ---- Dec 07 15:56:24.549 INFO [stdout] thread 'src/util.rs - util::download_to (line 140)' panicked at 'test executable failed: Dec 07 15:56:24.549 INFO [stdout] Dec 07 15:56:24.549 INFO [stdout] thread 'main' panicked at 'assertion failed: `(left == right)` Dec 07 15:56:24.549 INFO [stdout] left: `Err(Io { desc: "network content", op: "request", more: None })`, Dec 07 15:56:24.549 INFO [stdout] right: `Ok(())`', src/util.rs:8:1 Dec 07 15:56:24.549 INFO [stdout] stack backtrace: Dec 07 15:56:24.549 INFO [stdout] 0: 0x55fcd5d8cff3 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 07 15:56:24.549 INFO [stdout] 1: 0x55fcd5d87248 - std::sys_common::backtrace::_print::h95865c77318e98b7 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 07 15:56:24.549 INFO [stdout] 2: 0x55fcd5d8bac2 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/panicking.rs:211 Dec 07 15:56:24.549 INFO [stdout] 3: 0x55fcd5d8b82d - std::panicking::default_hook::h4eae6f26f73244c8 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/panicking.rs:227 Dec 07 15:56:24.549 INFO [stdout] 4: 0x55fcd5d8c1d0 - std::panicking::rust_panic_with_hook::h368d37fd53b59464 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/panicking.rs:491 Dec 07 15:56:24.549 INFO [stdout] 5: 0x55fcd5d8bd51 - std::panicking::continue_panic_fmt::h1599d634b3be4304 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/panicking.rs:398 Dec 07 15:56:24.549 INFO [stdout] 6: 0x55fcd5d8bc9e - std::panicking::begin_panic_fmt::h2c0a418aaab204b3 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/panicking.rs:353 Dec 07 15:56:24.549 INFO [stdout] 7: 0x55fcd586b883 - rust_out::main::h19287f9e3b324627 Dec 07 15:56:24.549 INFO [stdout] 8: 0x55fcd586b5d2 - std::rt::lang_start::{{closure}}::h55e056709a84a0fc Dec 07 15:56:24.549 INFO [stdout] 9: 0x55fcd5d8bbd2 - std::panicking::try::do_call::he36b7484b8577fb8 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/rt.rs:59 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/panicking.rs:310 Dec 07 15:56:24.549 INFO [stdout] 10: 0x55fcd5d9b179 - __rust_maybe_catch_panic Dec 07 15:56:24.549 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 15:56:24.549 INFO [stdout] 11: 0x55fcd5d8c663 - std::rt::lang_start_internal::h0d3f2f2668e3bb6a Dec 07 15:56:24.549 INFO [stdout] at src/libstd/panicking.rs:289 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/panic.rs:398 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/rt.rs:58 Dec 07 15:56:24.549 INFO [stdout] 12: 0x55fcd586b5b4 - std::rt::lang_start::hf856ee6567cd3a6c Dec 07 15:56:24.549 INFO [stdout] 13: 0x55fcd586bada - main Dec 07 15:56:24.549 INFO [stdout] 14: 0x7f5b8d87a82f - __libc_start_main Dec 07 15:56:24.549 INFO [stdout] 15: 0x55fcd5869d38 - _start Dec 07 15:56:24.549 INFO [stdout] 16: 0x0 - Dec 07 15:56:24.549 INFO [stdout] Dec 07 15:56:24.549 INFO [stdout] ', src/librustdoc/test.rs:358:17 Dec 07 15:56:24.549 INFO [stdout] stack backtrace: Dec 07 15:56:24.549 INFO [stdout] 0: 0x7fda2cc9dc73 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 07 15:56:24.549 INFO [stdout] 1: 0x7fda2cc95388 - std::sys_common::backtrace::_print::h95865c77318e98b7 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 07 15:56:24.549 INFO [stdout] 2: 0x7fda2cc9a6e2 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/panicking.rs:211 Dec 07 15:56:24.549 INFO [stdout] 3: 0x7fda2cc9a3cc - std::panicking::default_hook::h4eae6f26f73244c8 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/panicking.rs:221 Dec 07 15:56:24.549 INFO [stdout] 4: 0x7fda2ee8efa3 - rustc::util::common::panic_hook::hea1785835e82e2c5 Dec 07 15:56:24.549 INFO [stdout] 5: 0x7fda2cc9aec9 - std::panicking::rust_panic_with_hook::h368d37fd53b59464 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/panicking.rs:495 Dec 07 15:56:24.549 INFO [stdout] 6: 0x7fda2cc9a971 - std::panicking::continue_panic_fmt::h1599d634b3be4304 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/panicking.rs:398 Dec 07 15:56:24.549 INFO [stdout] 7: 0x7fda2cc9a8be - std::panicking::begin_panic_fmt::h2c0a418aaab204b3 Dec 07 15:56:24.549 INFO [stdout] at src/libstd/panicking.rs:353 Dec 07 15:56:24.549 INFO [stdout] 8: 0x55a8a2051d09 - rustdoc::test::run_test::h51becdd30fac872e Dec 07 15:56:24.549 INFO [stdout] at src/librustdoc/test.rs:358 Dec 07 15:56:24.549 INFO [stdout] 9: 0x55a8a1f5b60e - >::set::h47f05586637daa34 Dec 07 15:56:24.549 INFO [stdout] at src/librustdoc/test.rs:654 Dec 07 15:56:24.549 INFO [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/scoped-tls-0.1.2/src/lib.rs:155 Dec 07 15:56:24.549 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libsyntax/lib.rs:123 Dec 07 15:56:24.549 INFO [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/scoped-tls-0.1.2/src/lib.rs:155 Dec 07 15:56:24.549 INFO [stdout] 10: 0x55a8a1f1c7d1 - syntax::with_globals::h4ced7bf2f70f286c Dec 07 15:56:24.549 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libsyntax/lib.rs:122 Dec 07 15:56:24.550 INFO [stdout] 11: 0x55a8a1ee1eeb - std::panicking::try::do_call::h866d6739e1358aa1 Dec 07 15:56:24.550 INFO [stdout] at src/librustdoc/test.rs:651 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310 Dec 07 15:56:24.550 INFO [stdout] 12: 0x7fda2ccb72f9 - __rust_maybe_catch_panic Dec 07 15:56:24.550 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 15:56:24.550 INFO [stdout] 13: 0x55a8a1f54e29 - rustc_driver::in_named_rustc_thread::h9b90de8df47e8aa6 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/librustc_driver/lib.rs:1556 Dec 07 15:56:24.550 INFO [stdout] 14: 0x55a8a202e830 - >::call_box::h07d5494f7cee1aca Dec 07 15:56:24.550 INFO [stdout] at src/librustdoc/test.rs:651 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 15:56:24.550 INFO [stdout] 15: 0x7fda2e2fa872 - >::call_box::h6ce47fbf83b49ca8 Dec 07 15:56:24.550 INFO [stdout] at src/libtest/lib.rs:1464 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 15:56:24.550 INFO [stdout] 16: 0x7fda2ccb72f9 - __rust_maybe_catch_panic Dec 07 15:56:24.550 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 15:56:24.550 INFO [stdout] 17: 0x7fda2e2f24e3 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 15:56:24.550 INFO [stdout] at src/libtest/lib.rs:1426 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136 Dec 07 15:56:24.550 INFO [stdout] 18: 0x7fda2e2f3404 - std::panicking::try::do_call::h7a86b6211ebb5e72 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310 Dec 07 15:56:24.550 INFO [stdout] 19: 0x7fda2ccb72f9 - __rust_maybe_catch_panic Dec 07 15:56:24.550 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 07 15:56:24.550 INFO [stdout] 20: 0x7fda2e2fa9ac - >::call_box::h877dbe22cb3997f4 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476 Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673 Dec 07 15:56:24.550 INFO [stdout] 21: 0x7fda2ccaa81d - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd Dec 07 15:56:24.550 INFO [stdout] at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683 Dec 07 15:56:24.550 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 07 15:56:24.550 INFO [stdout] at src/libstd/sys/unix/thread.rs:90 Dec 07 15:56:24.550 INFO [stdout] 22: 0x7fda2ca1e6b9 - start_thread Dec 07 15:56:24.550 INFO [stdout] 23: 0x7fda2c33641c - clone Dec 07 15:56:24.550 INFO [stdout] 24: 0x0 - Dec 07 15:56:24.550 INFO [stdout] query stack during panic: Dec 07 15:56:24.550 INFO [stdout] end of query stack Dec 07 15:56:24.550 INFO [stdout] Dec 07 15:56:24.550 INFO [stdout] Dec 07 15:56:24.550 INFO [stdout] failures: Dec 07 15:56:24.550 INFO [stdout] src/util.rs - util::download_to (line 140) Dec 07 15:56:24.550 INFO [stdout] Dec 07 15:56:24.550 INFO [stdout] test result: FAILED. 24 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 15:56:24.550 INFO [stdout] Dec 07 15:56:24.632 INFO [stderr] error: test failed, to rerun pass '--doc' Dec 07 15:56:24.636 INFO [stderr] su: No module specific data is present Dec 07 15:56:25.290 INFO running `"docker" "inspect" "de8150eecf52f3cfedab13e0719930096293b6ec592de29802c1aa2fa3dd1234"` Dec 07 15:56:25.624 INFO running `"docker" "rm" "-f" "de8150eecf52f3cfedab13e0719930096293b6ec592de29802c1aa2fa3dd1234"` Dec 07 15:56:26.064 INFO [stdout] de8150eecf52f3cfedab13e0719930096293b6ec592de29802c1aa2fa3dd1234