Dec 03 11:02:24.057 INFO testing gen-epub-book-2.3.1 against 1.30.1 for beta-1.31-5
Dec 03 11:02:24.057 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-2/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/beta-1.31-5/1.30.1:/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 +1.30.1 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"`
Dec 03 11:02:24.335 INFO [stdout] a590bc781fd180e9b78df051f39be7e3fbe004e01a8d1cec455dd6ebc720047e
Dec 03 11:02:24.337 INFO running `"docker" "start" "-a" "a590bc781fd180e9b78df051f39be7e3fbe004e01a8d1cec455dd6ebc720047e"`
Dec 03 11:02:26.003 INFO [stderr] usermod: no changes
Dec 03 11:02:26.471 INFO [stderr]    Compiling flate2 v1.0.5
Dec 03 11:02:28.900 INFO [stderr]    Compiling zip v0.4.2
Dec 03 11:02:31.167 INFO [stderr]    Compiling gen-epub-book v2.3.1 (/source)
Dec 03 11:03:00.935 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 34.90s
Dec 03 11:03:00.945 INFO [stderr] su: No module specific data is present
Dec 03 11:03:01.453 INFO running `"docker" "inspect" "a590bc781fd180e9b78df051f39be7e3fbe004e01a8d1cec455dd6ebc720047e"`
Dec 03 11:03:01.705 INFO running `"docker" "rm" "-f" "a590bc781fd180e9b78df051f39be7e3fbe004e01a8d1cec455dd6ebc720047e"`
Dec 03 11:03:01.899 INFO [stdout] a590bc781fd180e9b78df051f39be7e3fbe004e01a8d1cec455dd6ebc720047e
Dec 03 11:03:01.901 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-2/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/beta-1.31-5/1.30.1:/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 +1.30.1 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"`
Dec 03 11:03:02.190 INFO [stdout] 48b819b646a19bfe8fd061e249ef0e7c5b69ee4fab6e18fb30c9cee62a688ca0
Dec 03 11:03:02.192 INFO running `"docker" "start" "-a" "48b819b646a19bfe8fd061e249ef0e7c5b69ee4fab6e18fb30c9cee62a688ca0"`
Dec 03 11:03:03.070 INFO [stderr] usermod: no changes
Dec 03 11:03:03.411 INFO [stderr]    Compiling gen-epub-book v2.3.1 (/source)
Dec 03 11:03:21.236 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 18.14s
Dec 03 11:03:21.253 INFO [stderr] su: No module specific data is present
Dec 03 11:03:21.553 INFO running `"docker" "inspect" "48b819b646a19bfe8fd061e249ef0e7c5b69ee4fab6e18fb30c9cee62a688ca0"`
Dec 03 11:03:21.661 INFO running `"docker" "rm" "-f" "48b819b646a19bfe8fd061e249ef0e7c5b69ee4fab6e18fb30c9cee62a688ca0"`
Dec 03 11:03:21.768 INFO [stdout] 48b819b646a19bfe8fd061e249ef0e7c5b69ee4fab6e18fb30c9cee62a688ca0
Dec 03 11:03:21.775 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-2/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/beta-1.31-5/1.30.1:/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 +1.30.1 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"`
Dec 03 11:03:22.042 INFO [stdout] d13f2f9798cb77c3805ac6cdb984ebd16d02cd2acaca829c3ac65a6c6b276d3e
Dec 03 11:03:22.046 INFO running `"docker" "start" "-a" "d13f2f9798cb77c3805ac6cdb984ebd16d02cd2acaca829c3ac65a6c6b276d3e"`
Dec 03 11:03:22.692 INFO [stderr] usermod: no changes
Dec 03 11:03:22.915 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.20s
Dec 03 11:03:22.937 INFO [stderr]      Running /target/debug/deps/gen_epub_book-894411d119307dac
Dec 03 11:03:22.942 INFO [stdout] 
Dec 03 11:03:22.942 INFO [stdout] running 0 tests
Dec 03 11:03:22.942 INFO [stdout] 
Dec 03 11:03:22.942 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 11:03:22.943 INFO [stdout] 
Dec 03 11:03:22.944 INFO [stderr]      Running /target/debug/deps/lib-826dc4e0c3c04ec0
Dec 03 11:03:22.947 INFO [stdout] 
Dec 03 11:03:22.947 INFO [stdout] running 108 tests
Dec 03 11:03:22.948 INFO [stdout] test error::print::io::more::empty ... ok
Dec 03 11:03:22.948 INFO [stdout] test error::exit_value::parse ... ok
Dec 03 11:03:22.949 INFO [stdout] test error::print::file_not_found ... ok
Dec 03 11:03:22.949 INFO [stdout] test error::exit_value::wrong_file_state ... ok
Dec 03 11:03:22.950 INFO [stdout] test error::exit_value::wrong_element_amount ... ok
Dec 03 11:03:22.950 INFO [stdout] test error::exit_value::required_element_missing ... ok
Dec 03 11:03:22.951 INFO [stdout] test error::print::io::more::normal_e ... ok
Dec 03 11:03:22.951 INFO [stdout] test error::print::io::more::normal_non_e ... ok
Dec 03 11:03:22.952 INFO [stdout] test error::print::io::more::single_e ... ok
Dec 03 11:03:22.952 INFO [stdout] test error::print::io::more::single_non_e ... ok
Dec 03 11:03:22.953 INFO [stdout] test error::exit_value::io ... ok
Dec 03 11:03:22.953 INFO [stdout] test error::print::io::no_more::normal_e ... ok
Dec 03 11:03:22.954 INFO [stdout] test error::print::io::no_more::normal_non_e ... ok
Dec 03 11:03:22.954 INFO [stdout] test error::print::io::no_more::single_e ... ok
Dec 03 11:03:22.955 INFO [stdout] test error::print::io::no_more::empty ... ok
Dec 03 11:03:22.955 INFO [stdout] test error::print::io::no_more::single_non_e ... ok
Dec 03 11:03:22.956 INFO [stdout] test error::print::parse::more ... ok
Dec 03 11:03:22.956 INFO [stdout] test error::print::parse::no_more ... ok
Dec 03 11:03:22.957 INFO [stdout] test error::exit_value::file_not_found ... ok
Dec 03 11:03:22.957 INFO [stdout] test error::print::required_element_missing ... ok
Dec 03 11:03:22.958 INFO [stdout] test error::print::wrong_element_amount ... ok
Dec 03 11:03:22.959 INFO [stdout] test error::print::wrong_file_state ... ok
Dec 03 11:03:22.959 INFO [stdout] test ops::book::from_elements::correct::file_cover ... ok
Dec 03 11:03:22.960 INFO [stdout] test ops::book::from_elements::correct::network_cover ... ok
Dec 03 11:03:22.961 INFO [stdout] test ops::book::from_elements::correct::no_cover ... ok
Dec 03 11:03:22.962 INFO [stdout] test ops::book::from_elements::incorrect::cover::mixed_file_first ... ok
Dec 03 11:03:22.963 INFO [stdout] test ops::book::from_elements::incorrect::cover::mixed_network_first ... ok
Dec 03 11:03:22.963 INFO [stdout] test ops::book::from_elements::incorrect::duplicate::language ... ok
Dec 03 11:03:22.964 INFO [stdout] test ops::book::from_elements::incorrect::cover::two_file ... ok
Dec 03 11:03:22.965 INFO [stdout] test ops::book::from_elements::incorrect::cover::two_network ... ok
Dec 03 11:03:22.965 INFO [stdout] test ops::book::from_elements::incorrect::duplicate::author ... ok
Dec 03 11:03:22.966 INFO [stdout] test ops::book::from_elements::incorrect::duplicate::date ... ok
Dec 03 11:03:22.966 INFO [stdout] test ops::book::from_elements::incorrect::duplicate::name ... ok
Dec 03 11:03:22.967 INFO [stdout] test ops::book::from_elements::incorrect::duplicate::ordering ... ok
Dec 03 11:03:22.967 INFO [stdout] test ops::book::from_elements::incorrect::missing::author ... ok
Dec 03 11:03:22.968 INFO [stdout] test ops::book::from_elements::incorrect::missing::date ... ok
Dec 03 11:03:22.968 INFO [stdout] test ops::book::from_elements::incorrect::missing::language ... ok
Dec 03 11:03:22.969 INFO [stdout] test ops::book::from_elements::incorrect::missing::name ... ok
Dec 03 11:03:22.970 INFO [stdout] test ops::book::from_elements::incorrect::missing::ordering ... ok
Dec 03 11:03:22.970 INFO [stdout] test ops::book::normalise_paths::no_verbose::bad_type ... ok
Dec 03 11:03:22.972 INFO [stdout] test ops::book::normalise_paths::no_verbose::correct ... ok
Dec 03 11:03:22.973 INFO [stdout] test ops::book::normalise_paths::no_verbose::nonexistant ... ok
Dec 03 11:03:22.974 INFO [stdout] test ops::book::normalise_paths::verbose::nonexistant ... ok
Dec 03 11:03:22.974 INFO [stdout] test ops::element::display::author ... ok
Dec 03 11:03:22.975 INFO [stdout] test ops::element::display::cover ... ok
Dec 03 11:03:22.975 INFO [stdout] test ops::element::display::content ... ok
Dec 03 11:03:22.976 INFO [stdout] test ops::element::display::image_content ... ok
Dec 03 11:03:22.976 INFO [stdout] test ops::element::display::date ... ok
Dec 03 11:03:22.977 INFO [stdout] test ops::element::display::language ... ok
Dec 03 11:03:22.977 INFO [stdout] test ops::element::display::include ... ok
Dec 03 11:03:22.978 INFO [stdout] test ops::element::display::name ... ok
Dec 03 11:03:22.978 INFO [stdout] test ops::element::display::network_cover ... ok
Dec 03 11:03:22.979 INFO [stdout] test ops::element::display::string_content ... ok
Dec 03 11:03:22.979 INFO [stdout] test ops::element::name::cover ... ok
Dec 03 11:03:22.983 INFO [stdout] test ops::element::display::network_image_content ... ok
Dec 03 11:03:22.983 INFO [stdout] test ops::element::display::network_include ... ok
Dec 03 11:03:22.983 INFO [stdout] test ops::element::name::content ... ok
Dec 03 11:03:22.983 INFO [stdout] test ops::book::normalise_paths::verbose::correct ... ok
Dec 03 11:03:22.983 INFO [stdout] test ops::element::name::author ... ok
Dec 03 11:03:22.983 INFO [stdout] test ops::element::name::date ... ok
Dec 03 11:03:22.983 INFO [stdout] test ops::book::normalise_paths::verbose::bad_type ... ok
Dec 03 11:03:22.983 INFO [stdout] test ops::element::name::image_content ... ok
Dec 03 11:03:22.983 INFO [stdout] test ops::element::name::include ... ok
Dec 03 11:03:22.983 INFO [stdout] test ops::element::name::name ... ok
Dec 03 11:03:22.983 INFO [stdout] test ops::element::parse::elements::author ... ok
Dec 03 11:03:22.984 INFO [stdout] test ops::element::name::network_image_content ... ok
Dec 03 11:03:22.984 INFO [stdout] test ops::element::name::language ... ok
Dec 03 11:03:22.984 INFO [stdout] test ops::element::name::network_cover ... ok
Dec 03 11:03:22.985 INFO [stdout] test ops::element::name::network_include ... ok
Dec 03 11:03:22.985 INFO [stdout] test ops::element::name::string_content ... ok
Dec 03 11:03:22.985 INFO [stdout] test ops::element::parse::elements::content ... ok
Dec 03 11:03:22.986 INFO [stdout] test ops::element::parse::elements::date_free ... ok
Dec 03 11:03:22.986 INFO [stdout] test ops::element::parse::elements::cover ... ok
Dec 03 11:03:22.986 INFO [stdout] test ops::element::parse::elements::include ... ok
Dec 03 11:03:22.987 INFO [stdout] test ops::element::parse::elements::image_content ... ok
Dec 03 11:03:22.987 INFO [stdout] test ops::element::parse::elements::date_rigid ... ok
Dec 03 11:03:22.988 INFO [stdout] test ops::element::parse::elements::network_cover ... ok
Dec 03 11:03:22.990 INFO [stdout] test ops::element::parse::elements::language ... ok
Dec 03 11:03:22.990 INFO [stdout] test ops::element::parse::elements::name ... ok
Dec 03 11:03:22.991 INFO [stdout] test ops::element::parse::elements::network_image_content ... ok
Dec 03 11:03:22.991 INFO [stdout] test ops::element::parse::elements::network_include ... ok
Dec 03 11:03:22.992 INFO [stdout] test ops::element::parse::not_description ... ok
Dec 03 11:03:22.992 INFO [stdout] test ops::element::parse::roundtrip ... ok
Dec 03 11:03:22.992 INFO [stdout] test ops::element::parse::trimming ... ok
Dec 03 11:03:22.993 INFO [stdout] test ops::element::parse::unrecognised ... ok
Dec 03 11:03:22.995 INFO [stdout] test ops::element::parse::elements::string_content ... ok
Dec 03 11:03:22.996 INFO [stdout] test ops::include_dir::display::named ... ok
Dec 03 11:03:22.997 INFO [stdout] test ops::include_dir::display::unnamed ... ok
Dec 03 11:03:22.997 INFO [stdout] test ops::find_title::non_containing ... ok
Dec 03 11:03:22.999 INFO [stdout] test ops::element::parse::errors::datetime_free ... ok
Dec 03 11:03:22.999 INFO [stdout] test ops::element::parse::errors::datetime_rigid ... ok
Dec 03 11:03:22.999 INFO [stdout] test ops::element::parse::errors::url ... ok
Dec 03 11:03:22.999 INFO [stdout] test ops::include_dir::parse::incorrect::invalid::named ... ok
Dec 03 11:03:23.000 INFO [stdout] test ops::find_title::containing ... ok
Dec 03 11:03:23.000 INFO [stdout] test util::uppercase_first::already_upper ... ok
Dec 03 11:03:23.000 INFO [stdout] test ops::parse_descriptor::bubbling ... ok
Dec 03 11:03:23.001 INFO [stdout] test ops::include_dir::parse::incorrect::nonexistant::unnamed ... ok
Dec 03 11:03:23.001 INFO [stdout] test util::uppercase_first::multi ... ok
Dec 03 11:03:23.001 INFO [stdout] test util::uppercase_first::multi_already_upper ... ok
Dec 03 11:03:23.001 INFO [stdout] test ops::parse_descriptor::generic ... ok
Dec 03 11:03:23.001 INFO [stdout] test util::uppercase_first::single ... ok
Dec 03 11:03:23.007 INFO [stdout] test util::uppercase_first::empty ... ok
Dec 03 11:03:23.007 INFO [stdout] test util::uppercase_first::simple ... ok
Dec 03 11:03:23.007 INFO [stdout] test ops::include_dir::parse::correct::named ... ok
Dec 03 11:03:23.007 INFO [stdout] test ops::include_dir::parse::incorrect::invalid::unnamed ... ok
Dec 03 11:03:23.007 INFO [stdout] test ops::include_dir::parse::correct::unnamed ... ok
Dec 03 11:03:23.007 INFO [stdout] test ops::include_dir::parse::incorrect::nonexistant::named ... ok
Dec 03 11:03:23.012 INFO [stdout] test util::uppercase_first::single_already_upper ... ok
Dec 03 11:03:23.012 INFO [stdout] 
Dec 03 11:03:23.012 INFO [stdout] test result: ok. 108 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 11:03:23.012 INFO [stdout] 
Dec 03 11:03:23.012 INFO [stderr]    Doc-tests gen-epub-book
Dec 03 11:03:43.535 INFO [stdout] 
Dec 03 11:03:43.535 INFO [stdout] running 25 tests
Dec 03 11:04:43.531 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 03 11:04:43.535 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 03 11:04:43.535 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 03 11:04:43.535 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 03 11:04:43.555 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 03 11:04:43.559 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 03 11:04:43.579 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 03 11:04:43.579 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 03 11:05:52.606 INFO [stdout] test src/ops/book.rs - ops::book::EPubBook::write_zip_ext (line 311) ... FAILED
Dec 03 11:05:52.611 INFO [stdout] test src/ops/book.rs - ops::book::EPubBook::from_elements (line 64) ... FAILED
Dec 03 11:05:56.752 INFO [stderr] error: process didn't exit successfully: `rustdoc --test /source/src/lib.rs --crate-name gen_epub_book -L dependency=/target/debug/deps -L native=/target/debug/build/bzip2-sys-081d77e9b8c7ebf4/out/lib -L dependency=/target/debug/deps --extern chrono=/target/debug/deps/libchrono-cfb4b6b7a5fa5344.rlib --extern clap=/target/debug/deps/libclap-48d86a8bf1cfa257.rlib --extern gen_epub_book=/target/debug/deps/libgen_epub_book-020ae674e5e9abe7.rlib --extern lazy_static=/target/debug/deps/liblazy_static-f155e732bcbe563f.rlib --extern mime_guess=/target/debug/deps/libmime_guess-f846c6486a6cc1b1.rlib --extern regex=/target/debug/deps/libregex-5ff533d10357ff1c.rlib --extern reqwest=/target/debug/deps/libreqwest-67211ad85439aaa9.rlib --extern url=/target/debug/deps/liburl-a70d2879a1f988e2.rlib --extern uuid=/target/debug/deps/libuuid-ff62042d1230207f.rlib --extern zip=/target/debug/deps/libzip-8cd00c353f255ebd.rlib` (signal: 9, SIGKILL: kill)
Dec 03 11:05:56.754 INFO [stderr] su: No module specific data is present
Dec 03 11:05:57.675 INFO running `"docker" "inspect" "d13f2f9798cb77c3805ac6cdb984ebd16d02cd2acaca829c3ac65a6c6b276d3e"`
Dec 03 11:05:57.927 INFO running `"docker" "rm" "-f" "d13f2f9798cb77c3805ac6cdb984ebd16d02cd2acaca829c3ac65a6c6b276d3e"`
Dec 03 11:05:58.219 INFO [stdout] d13f2f9798cb77c3805ac6cdb984ebd16d02cd2acaca829c3ac65a6c6b276d3e
