Dec 07 08:46:00.178 INFO testing lettre-openssl111-0.9.0 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 08:46:00.178 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 08:46:00.676 INFO [stdout] a40de8b5cf0e3eecf023a3a20f9658a4c7afd1516d388de271d105ead6c4db81
Dec 07 08:46:00.684 INFO running `"docker" "start" "-a" "a40de8b5cf0e3eecf023a3a20f9658a4c7afd1516d388de271d105ead6c4db81"`
Dec 07 08:46:01.788 INFO [stderr] usermod: no changes
Dec 07 08:46:01.952 INFO [stderr]    Compiling lettre-openssl111 v0.9.0 (/source)
Dec 07 08:46:09.198 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.39s
Dec 07 08:46:09.207 INFO [stderr] su: No module specific data is present
Dec 07 08:46:09.606 INFO running `"docker" "inspect" "a40de8b5cf0e3eecf023a3a20f9658a4c7afd1516d388de271d105ead6c4db81"`
Dec 07 08:46:09.746 INFO running `"docker" "rm" "-f" "a40de8b5cf0e3eecf023a3a20f9658a4c7afd1516d388de271d105ead6c4db81"`
Dec 07 08:46:09.891 INFO [stdout] a40de8b5cf0e3eecf023a3a20f9658a4c7afd1516d388de271d105ead6c4db81
Dec 07 08:46:09.893 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 08:46:10.096 INFO [stdout] 03995841b0c3ac80a0d9ea21cf4a6e8bfc9961755a20930db9584359e6ad4b5e
Dec 07 08:46:10.097 INFO running `"docker" "start" "-a" "03995841b0c3ac80a0d9ea21cf4a6e8bfc9961755a20930db9584359e6ad4b5e"`
Dec 07 08:46:10.647 INFO [stderr] usermod: no changes
Dec 07 08:46:10.832 INFO [stderr]    Compiling lettre-openssl111 v0.9.0 (/source)
Dec 07 08:46:35.028 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 24.36s
Dec 07 08:46:35.047 INFO [stderr] su: No module specific data is present
Dec 07 08:46:35.608 INFO running `"docker" "inspect" "03995841b0c3ac80a0d9ea21cf4a6e8bfc9961755a20930db9584359e6ad4b5e"`
Dec 07 08:46:35.900 INFO running `"docker" "rm" "-f" "03995841b0c3ac80a0d9ea21cf4a6e8bfc9961755a20930db9584359e6ad4b5e"`
Dec 07 08:46:36.159 INFO [stdout] 03995841b0c3ac80a0d9ea21cf4a6e8bfc9961755a20930db9584359e6ad4b5e
Dec 07 08:46:36.162 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 08:46:36.576 INFO [stdout] e2f370967d99b9b0d5f58753562d13c1cbf22dc5b4e8547aa69b658d52056902
Dec 07 08:46:36.578 INFO running `"docker" "start" "-a" "e2f370967d99b9b0d5f58753562d13c1cbf22dc5b4e8547aa69b658d52056902"`
Dec 07 08:46:37.660 INFO [stderr] usermod: no changes
Dec 07 08:46:37.827 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.15s
Dec 07 08:46:37.836 INFO [stdout] 
Dec 07 08:46:37.836 INFO [stderr]      Running /target/debug/deps/lettre-89d2e553eea973a0
Dec 07 08:46:37.836 INFO [stdout] running 24 tests
Dec 07 08:46:37.840 INFO [stdout] test smtp::authentication::test::test_login ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::authentication::test::test_xoauth2 ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::authentication::test::test_plain ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::client::mock::test::read_with_vec_test ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::client::mock::test::clone_test ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::client::test::test_codec ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::client::mock::test::write_take_test ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::client::mock::test::swap_test ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::response::test::test_category_fmt ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::response::test::test_code_display ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::response::test::test_code_new ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::response::test::test_response_first_line ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::response::test::test_response_first_word ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::response::test::test_response_from_str ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::response::test::test_response_has_code ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::response::test::test_response_is_positive ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::response::test::test_severity_fmt ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::util::tests::test ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::extension::test::test_serverinfo_fmt ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::extension::test::test_serverinfo ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::client::test::test_escape_crlf ... ok
Dec 07 08:46:37.840 INFO [stdout] test smtp::commands::test::test_display ... ok
Dec 07 08:46:37.842 INFO [stdout] test smtp::extension::test::test_extension_fmt ... ok
Dec 07 08:46:37.842 INFO [stdout] test smtp::extension::test::test_clientid_fmt ... ok
Dec 07 08:46:37.842 INFO [stdout] 
Dec 07 08:46:37.842 INFO [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 08:46:37.842 INFO [stdout] 
Dec 07 08:46:37.842 INFO [stderr]      Running /target/debug/deps/skeptic-bd4e15e470d76022
Dec 07 08:46:37.848 INFO [stdout] 
Dec 07 08:46:37.848 INFO [stdout] running 1 test
Dec 07 08:46:37.892 INFO [stdout] test book_test ... FAILED
Dec 07 08:46:37.892 INFO [stdout] 
Dec 07 08:46:37.892 INFO [stdout] failures:
Dec 07 08:46:37.892 INFO [stdout] 
Dec 07 08:46:37.892 INFO [stdout] ---- book_test stdout ----
Dec 07 08:46:37.892 INFO [stdout] thread 'book_test' panicked at 'called `Option::unwrap()` on a `None` value', src/libcore/option.rs:355:21
Dec 07 08:46:37.892 INFO [stdout] stack backtrace:
Dec 07 08:46:37.892 INFO [stdout]    0:     0x557533d304a3 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7
Dec 07 08:46:37.892 INFO [stdout]                                at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 07 08:46:37.892 INFO [stdout]    1:     0x557533d2ab58 - std::sys_common::backtrace::_print::h95865c77318e98b7
Dec 07 08:46:37.892 INFO [stdout]                                at src/libstd/sys_common/backtrace.rs:71
Dec 07 08:46:37.892 INFO [stdout]    2:     0x557533d2f412 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5
Dec 07 08:46:37.892 INFO [stdout]                                at src/libstd/sys_common/backtrace.rs:59
Dec 07 08:46:37.892 INFO [stdout]                                at src/libstd/panicking.rs:211
Dec 07 08:46:37.892 INFO [stdout]    3:     0x557533d2f0fc - std::panicking::default_hook::h4eae6f26f73244c8
Dec 07 08:46:37.892 INFO [stdout]                                at src/libstd/panicking.rs:221
Dec 07 08:46:37.892 INFO [stdout]    4:     0x557533d2fb20 - std::panicking::rust_panic_with_hook::h368d37fd53b59464
Dec 07 08:46:37.892 INFO [stdout]                                at src/libstd/panicking.rs:491
Dec 07 08:46:37.892 INFO [stdout]    5:     0x557533d2f6a1 - std::panicking::continue_panic_fmt::h1599d634b3be4304
Dec 07 08:46:37.892 INFO [stdout]                                at src/libstd/panicking.rs:398
Dec 07 08:46:37.892 INFO [stdout]    6:     0x557533d2f585 - rust_begin_unwind
Dec 07 08:46:37.892 INFO [stdout]                                at src/libstd/panicking.rs:325
Dec 07 08:46:37.892 INFO [stdout]    7:     0x557533d4424c - core::panicking::panic_fmt::hdc202e6077c95723
Dec 07 08:46:37.892 INFO [stdout]                                at src/libcore/panicking.rs:95
Dec 07 08:46:37.892 INFO [stdout]    8:     0x557533d4417b - core::panicking::panic::he64013e7bc5cd117
Dec 07 08:46:37.892 INFO [stdout]                                at src/libcore/panicking.rs:59
Dec 07 08:46:37.892 INFO [stdout]    9:     0x557533d19414 - <core::option::Option<T>>::unwrap::hc2318f379eebc13d
Dec 07 08:46:37.892 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/macros.rs:20
Dec 07 08:46:37.892 INFO [stdout]   10:     0x557533cb3a8b - skeptic::book_test::h592a89f6520476b3
Dec 07 08:46:37.892 INFO [stdout]                                at tests/skeptic.rs:29
Dec 07 08:46:37.892 INFO [stdout]   11:     0x557533cb3909 - skeptic::book_test::{{closure}}::hc9bd86b92ef07c43
Dec 07 08:46:37.892 INFO [stdout]                                at tests/skeptic.rs:26
Dec 07 08:46:37.892 INFO [stdout]   12:     0x557533cafc3d - core::ops::function::FnOnce::call_once::h44bce9e91685c7f7
Dec 07 08:46:37.892 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238
Dec 07 08:46:37.892 INFO [stdout]   13:     0x557533cbe7fe - <F as alloc::boxed::FnBox<A>>::call_box::h994167e0fc25f327
Dec 07 08:46:37.892 INFO [stdout]                                at src/libtest/lib.rs:1471
Dec 07 08:46:37.892 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238
Dec 07 08:46:37.892 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673
Dec 07 08:46:37.892 INFO [stdout]   14:     0x557533d429f9 - __rust_maybe_catch_panic
Dec 07 08:46:37.892 INFO [stdout]                                at src/libpanic_unwind/lib.rs:102
Dec 07 08:46:37.892 INFO [stdout]   15:     0x557533cb6703 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3
Dec 07 08:46:37.892 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289
Dec 07 08:46:37.892 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398
Dec 07 08:46:37.892 INFO [stdout]                                at src/libtest/lib.rs:1426
Dec 07 08:46:37.892 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136
Dec 07 08:46:37.892 INFO [stdout]   16:     0x557533cb7624 - std::panicking::try::do_call::h7a86b6211ebb5e72
Dec 07 08:46:37.893 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477
Dec 07 08:46:37.893 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319
Dec 07 08:46:37.893 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310
Dec 07 08:46:37.893 INFO [stdout]   17:     0x557533d429f9 - __rust_maybe_catch_panic
Dec 07 08:46:37.893 INFO [stdout]                                at src/libpanic_unwind/lib.rs:102
Dec 07 08:46:37.893 INFO [stdout]   18:     0x557533cbe6dc - <F as alloc::boxed::FnBox<A>>::call_box::h877dbe22cb3997f4
Dec 07 08:46:37.893 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289
Dec 07 08:46:37.893 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398
Dec 07 08:46:37.893 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476
Dec 07 08:46:37.893 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673
Dec 07 08:46:37.893 INFO [stdout]   19:     0x557533d369bd - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd
Dec 07 08:46:37.893 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683
Dec 07 08:46:37.893 INFO [stdout]                                at src/libstd/sys_common/thread.rs:24
Dec 07 08:46:37.893 INFO [stdout]                                at src/libstd/sys/unix/thread.rs:90
Dec 07 08:46:37.893 INFO [stdout]   20:     0x7fd5336646b9 - start_thread
Dec 07 08:46:37.893 INFO [stdout]   21:     0x7fd53318441c - clone
Dec 07 08:46:37.893 INFO [stdout]   22:                0x0 - <unknown>
Dec 07 08:46:37.893 INFO [stdout] 
Dec 07 08:46:37.893 INFO [stdout] 
Dec 07 08:46:37.893 INFO [stdout] failures:
Dec 07 08:46:37.893 INFO [stdout]     book_test
Dec 07 08:46:37.893 INFO [stdout] 
Dec 07 08:46:37.893 INFO [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 08:46:37.893 INFO [stdout] 
Dec 07 08:46:37.894 INFO [stderr] error: test failed, to rerun pass '--test skeptic'
Dec 07 08:46:37.895 INFO [stderr] su: No module specific data is present
Dec 07 08:46:38.201 INFO running `"docker" "inspect" "e2f370967d99b9b0d5f58753562d13c1cbf22dc5b4e8547aa69b658d52056902"`
Dec 07 08:46:38.389 INFO running `"docker" "rm" "-f" "e2f370967d99b9b0d5f58753562d13c1cbf22dc5b4e8547aa69b658d52056902"`
Dec 07 08:46:38.504 INFO [stdout] e2f370967d99b9b0d5f58753562d13c1cbf22dc5b4e8547aa69b658d52056902