Oct 11 17:23:10.318 INFO testing loggy-0.1.7 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling Oct 11 17:23:10.318 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen Oct 11 17:23:10.318 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"` Oct 11 17:23:10.587 INFO blam! 40dfd746487c586b64d488949b2a90b9968f4c3cc761bd3af68eb3cdf4e2aca6 Oct 11 17:23:10.588 INFO running `"docker" "start" "-a" "40dfd746487c586b64d488949b2a90b9968f4c3cc761bd3af68eb3cdf4e2aca6"` Oct 11 17:23:11.096 INFO kablam! usermod: no changes Oct 11 17:23:11.137 INFO kablam! Compiling loggy v0.1.7 (/source) Oct 11 17:23:11.778 INFO kablam! warning: unused `#[macro_use]` import Oct 11 17:23:11.778 INFO kablam! --> src/lib.rs:12:1 Oct 11 17:23:11.778 INFO kablam! | Oct 11 17:23:11.778 INFO kablam! 12 | #[macro_use] Oct 11 17:23:11.778 INFO kablam! | ^^^^^^^^^^^^ Oct 11 17:23:11.778 INFO kablam! | Oct 11 17:23:11.778 INFO kablam! = note: #[warn(unused_imports)] on by default Oct 11 17:23:11.778 INFO kablam! Oct 11 17:23:12.240 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 1.13s Oct 11 17:23:12.243 INFO kablam! su: No module specific data is present Oct 11 17:23:12.531 INFO running `"docker" "rm" "-f" "40dfd746487c586b64d488949b2a90b9968f4c3cc761bd3af68eb3cdf4e2aca6"` Oct 11 17:23:12.620 INFO blam! 40dfd746487c586b64d488949b2a90b9968f4c3cc761bd3af68eb3cdf4e2aca6 Oct 11 17:23:12.621 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run Oct 11 17:23:12.621 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"` Oct 11 17:23:12.776 INFO blam! 0885f91e9d31b4f6c5f72fc64a95030d28b8932891f729c8fa9316d93f5d6f29 Oct 11 17:23:12.778 INFO running `"docker" "start" "-a" "0885f91e9d31b4f6c5f72fc64a95030d28b8932891f729c8fa9316d93f5d6f29"` Oct 11 17:23:13.239 INFO kablam! usermod: no changes Oct 11 17:23:13.277 INFO kablam! Compiling loggy v0.1.7 (/source) Oct 11 17:23:14.164 INFO kablam! warning: unused `#[macro_use]` import Oct 11 17:23:14.164 INFO kablam! --> src/lib.rs:12:1 Oct 11 17:23:14.164 INFO kablam! | Oct 11 17:23:14.164 INFO kablam! 12 | #[macro_use] Oct 11 17:23:14.164 INFO kablam! | ^^^^^^^^^^^^ Oct 11 17:23:14.164 INFO kablam! | Oct 11 17:23:14.164 INFO kablam! = note: #[warn(unused_imports)] on by default Oct 11 17:23:14.164 INFO kablam! Oct 11 17:23:15.066 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 1.81s Oct 11 17:23:15.067 INFO kablam! su: No module specific data is present Oct 11 17:23:15.374 INFO running `"docker" "rm" "-f" "0885f91e9d31b4f6c5f72fc64a95030d28b8932891f729c8fa9316d93f5d6f29"` Oct 11 17:23:15.468 INFO blam! 0885f91e9d31b4f6c5f72fc64a95030d28b8932891f729c8fa9316d93f5d6f29 Oct 11 17:23:15.476 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen Oct 11 17:23:15.476 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"` Oct 11 17:23:15.697 INFO blam! e04c55bc809a6af5e12d68fccf15ca52ed7eca060f52048a59b99c359a553779 Oct 11 17:23:15.698 INFO running `"docker" "start" "-a" "e04c55bc809a6af5e12d68fccf15ca52ed7eca060f52048a59b99c359a553779"` Oct 11 17:23:16.112 INFO kablam! usermod: no changes Oct 11 17:23:16.148 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 0.02s Oct 11 17:23:16.148 INFO kablam! Running /target/debug/deps/loggy-91efb4d9edb5b619 Oct 11 17:23:16.155 INFO kablam! Running /target/debug/deps/test_log-7fcf40d1c0ab7c6d Oct 11 17:23:16.155 INFO blam! Oct 11 17:23:16.155 INFO blam! running 0 tests Oct 11 17:23:16.155 INFO blam! Oct 11 17:23:16.155 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Oct 11 17:23:16.155 INFO blam! Oct 11 17:23:16.157 INFO blam! Oct 11 17:23:16.157 INFO blam! running 9 tests Oct 11 17:23:16.172 INFO blam! test multi_line_should_be_captured ... ok Oct 11 17:23:16.189 INFO blam! test error_should_be_captured ... FAILED Oct 11 17:23:16.189 INFO blam! test notice_should_be_controlled ... FAILED Oct 11 17:23:16.189 INFO blam! test notice_should_be_captured ... FAILED Oct 11 17:23:16.190 INFO blam! test errors_should_be_counted ... FAILED Oct 11 17:23:16.190 INFO blam! test worker_threads_should_be_reported ... FAILED Oct 11 17:23:16.191 INFO blam! test debug_should_not_be_captured ... FAILED Oct 11 17:23:16.192 INFO blam! test warning_should_be_captured ... FAILED Oct 11 17:23:16.192 INFO blam! test info_should_be_captured ... FAILED Oct 11 17:23:16.192 INFO blam! Oct 11 17:23:16.192 INFO blam! failures: Oct 11 17:23:16.194 INFO blam! Oct 11 17:23:16.194 INFO blam! ---- error_should_be_captured stdout ---- Oct 11 17:23:16.194 INFO blam! test[1]: [ERROR] test_log: error Oct 11 17:23:16.194 INFO blam! thread 'error_should_be_captured' panicked at 'asserting log when logging to stderr', src/lib.rs:259:13 Oct 11 17:23:16.194 INFO blam! stack backtrace: Oct 11 17:23:16.194 INFO blam! 0: 0x556148bc370e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 17:23:16.194 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 17:23:16.194 INFO blam! 1: 0x556148bcc5b6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 17:23:16.194 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 17:23:16.194 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 17:23:16.194 INFO blam! 2: 0x556148bc730d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 17:23:16.194 INFO blam! at libstd/panicking.rs:211 Oct 11 17:23:16.194 INFO blam! 3: 0x556148bc701b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 17:23:16.194 INFO blam! at libstd/panicking.rs:221 Oct 11 17:23:16.194 INFO blam! 4: 0x556148bc79bc - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 17:23:16.194 INFO blam! at libstd/panicking.rs:476 Oct 11 17:23:16.194 INFO blam! 5: 0x556148badebf - std::panicking::begin_panic::h115170853f476d93 Oct 11 17:23:16.194 INFO blam! at libstd/panicking.rs:410 Oct 11 17:23:16.194 INFO blam! 6: 0x556148b9486c - loggy::assert_log::h441b5f7a3b41c56c Oct 11 17:23:16.194 INFO blam! at src/lib.rs:259 Oct 11 17:23:16.194 INFO blam! 7: 0x556148b4afcb - test_log::error_should_be_captured::h61ee5c3570a05a3b Oct 11 17:23:16.194 INFO blam! at tests/test_log.rs:14 Oct 11 17:23:16.194 INFO blam! 8: 0x556148b4ae79 - test_log::error_should_be_captured::{{closure}}::h7323c253a17c779f Oct 11 17:23:16.194 INFO blam! at /source/<::loggy::test_loggy macros>:5 Oct 11 17:23:16.194 INFO blam! 9: 0x556148b4e40d - core::ops::function::FnOnce::call_once::h51e5caad2caba133 Oct 11 17:23:16.194 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.194 INFO blam! 10: 0x556148b54fae - >::call_box::h95b7cb918af67b5d Oct 11 17:23:16.194 INFO blam! at libtest/lib.rs:1468 Oct 11 17:23:16.194 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.194 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.194 INFO blam! 11: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.194 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.194 INFO blam! 12: 0x556148b75afd - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 17:23:16.194 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.195 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.195 INFO blam! at libtest/lib.rs:1423 Oct 11 17:23:16.195 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 17:23:16.195 INFO blam! 13: 0x556148b76704 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 17:23:16.195 INFO blam! at libstd/thread/mod.rs:409 Oct 11 17:23:16.195 INFO blam! at libstd/panic.rs:313 Oct 11 17:23:16.195 INFO blam! at libstd/panicking.rs:310 Oct 11 17:23:16.195 INFO blam! 14: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.195 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.195 INFO blam! 15: 0x556148b63cc6 - >::call_box::h96125cb29a9ba44b Oct 11 17:23:16.195 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.195 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.195 INFO blam! at libstd/thread/mod.rs:408 Oct 11 17:23:16.195 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.195 INFO blam! 16: 0x556148bc574a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 17:23:16.195 INFO blam! at liballoc/boxed.rs:682 Oct 11 17:23:16.195 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 17:23:16.195 INFO blam! 17: 0x556148bbadf5 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 17:23:16.195 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 17:23:16.195 INFO blam! 18: 0x7f62d11c56b9 - start_thread Oct 11 17:23:16.195 INFO blam! 19: 0x7f62d0ce541c - clone Oct 11 17:23:16.195 INFO blam! 20: 0x0 - Oct 11 17:23:16.195 INFO blam! Oct 11 17:23:16.195 INFO blam! ---- notice_should_be_controlled stdout ---- Oct 11 17:23:16.195 INFO blam! thread 'notice_should_be_controlled' panicked at 'called `Result::unwrap()` on an `Err` value: "PoisonError { inner: .. }"', libcore/result.rs:1009:5 Oct 11 17:23:16.195 INFO blam! stack backtrace: Oct 11 17:23:16.195 INFO blam! 0: 0x556148bc370e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 17:23:16.195 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 17:23:16.195 INFO blam! 1: 0x556148bcc5b6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 17:23:16.195 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 17:23:16.195 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 17:23:16.195 INFO blam! 2: 0x556148bc730d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 17:23:16.195 INFO blam! at libstd/panicking.rs:211 Oct 11 17:23:16.195 INFO blam! 3: 0x556148bc701b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 17:23:16.195 INFO blam! at libstd/panicking.rs:221 Oct 11 17:23:16.195 INFO blam! 4: 0x556148bc79bc - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 17:23:16.195 INFO blam! at libstd/panicking.rs:476 Oct 11 17:23:16.195 INFO blam! 5: 0x556148bc7579 - std::panicking::continue_panic_fmt::h6e11f50e47f94b00 Oct 11 17:23:16.195 INFO blam! at libstd/panicking.rs:390 Oct 11 17:23:16.195 INFO blam! 6: 0x556148bc7475 - rust_begin_unwind Oct 11 17:23:16.195 INFO blam! at libstd/panicking.rs:325 Oct 11 17:23:16.195 INFO blam! 7: 0x556148c07fcb - core::panicking::panic_fmt::hf99aac1e278ac2e5 Oct 11 17:23:16.195 INFO blam! at libcore/panicking.rs:77 Oct 11 17:23:16.195 INFO blam! 8: 0x556148b9a600 - core::result::unwrap_failed::h06bec0bd1864e1f7 Oct 11 17:23:16.195 INFO blam! at libcore/macros.rs:26 Oct 11 17:23:16.195 INFO blam! 9: 0x556148b9a1ce - >::unwrap::h5b691760c5f84305 Oct 11 17:23:16.195 INFO blam! at libcore/result.rs:808 Oct 11 17:23:16.195 INFO blam! 10: 0x556148b9434d - loggy::set_log_sink::hbb6f99d2f0e96e3b Oct 11 17:23:16.195 INFO blam! at src/lib.rs:232 Oct 11 17:23:16.195 INFO blam! 11: 0x556148b95481 - loggy::before_test::h5edbb82ecfeaab74 Oct 11 17:23:16.195 INFO blam! at src/lib.rs:395 Oct 11 17:23:16.195 INFO blam! 12: 0x556148b4b9b5 - test_log::notice_should_be_controlled::h8492626f7ae2f865 Oct 11 17:23:16.195 INFO blam! at /source/<::loggy::test_loggy macros>:6 Oct 11 17:23:16.195 INFO blam! 13: 0x556148b4b999 - test_log::notice_should_be_controlled::{{closure}}::h7077c166dae54a9c Oct 11 17:23:16.195 INFO blam! at /source/<::loggy::test_loggy macros>:5 Oct 11 17:23:16.195 INFO blam! 14: 0x556148b4e3cd - core::ops::function::FnOnce::call_once::h4d73f8da1249836a Oct 11 17:23:16.195 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.195 INFO blam! 15: 0x556148b54fae - >::call_box::h95b7cb918af67b5d Oct 11 17:23:16.195 INFO blam! at libtest/lib.rs:1468 Oct 11 17:23:16.195 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.195 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.195 INFO blam! 16: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.195 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.195 INFO blam! 17: 0x556148b75afd - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 17:23:16.195 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.195 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.195 INFO blam! at libtest/lib.rs:1423 Oct 11 17:23:16.195 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 17:23:16.195 INFO blam! 18: 0x556148b76704 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 17:23:16.195 INFO blam! at libstd/thread/mod.rs:409 Oct 11 17:23:16.195 INFO blam! at libstd/panic.rs:313 Oct 11 17:23:16.195 INFO blam! at libstd/panicking.rs:310 Oct 11 17:23:16.195 INFO blam! 19: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.195 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.195 INFO blam! 20: 0x556148b63cc6 - >::call_box::h96125cb29a9ba44b Oct 11 17:23:16.195 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.195 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.195 INFO blam! at libstd/thread/mod.rs:408 Oct 11 17:23:16.195 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.195 INFO blam! 21: 0x556148bc574a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 17:23:16.195 INFO blam! at liballoc/boxed.rs:682 Oct 11 17:23:16.195 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 17:23:16.195 INFO blam! 22: 0x556148bbadf5 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 17:23:16.195 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 17:23:16.195 INFO blam! 23: 0x7f62d11c56b9 - start_thread Oct 11 17:23:16.195 INFO blam! 24: 0x7f62d0ce541c - clone Oct 11 17:23:16.195 INFO blam! 25: 0x0 - Oct 11 17:23:16.195 INFO blam! Oct 11 17:23:16.195 INFO blam! ---- notice_should_be_captured stdout ---- Oct 11 17:23:16.195 INFO blam! thread 'notice_should_be_captured' panicked at 'called `Result::unwrap()` on an `Err` value: "PoisonError { inner: .. }"', libcore/result.rs:1009:5 Oct 11 17:23:16.195 INFO blam! stack backtrace: Oct 11 17:23:16.195 INFO blam! 0: 0x556148bc370e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 17:23:16.196 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 17:23:16.196 INFO blam! 1: 0x556148bcc5b6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 17:23:16.196 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 17:23:16.196 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 17:23:16.196 INFO blam! 2: 0x556148bc730d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 17:23:16.196 INFO blam! at libstd/panicking.rs:211 Oct 11 17:23:16.196 INFO blam! 3: 0x556148bc701b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 17:23:16.196 INFO blam! at libstd/panicking.rs:221 Oct 11 17:23:16.196 INFO blam! 4: 0x556148bc79bc - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 17:23:16.196 INFO blam! at libstd/panicking.rs:476 Oct 11 17:23:16.196 INFO blam! 5: 0x556148bc7579 - std::panicking::continue_panic_fmt::h6e11f50e47f94b00 Oct 11 17:23:16.196 INFO blam! at libstd/panicking.rs:390 Oct 11 17:23:16.196 INFO blam! 6: 0x556148bc7475 - rust_begin_unwind Oct 11 17:23:16.196 INFO blam! at libstd/panicking.rs:325 Oct 11 17:23:16.196 INFO blam! 7: 0x556148c07fcb - core::panicking::panic_fmt::hf99aac1e278ac2e5 Oct 11 17:23:16.196 INFO blam! at libcore/panicking.rs:77 Oct 11 17:23:16.196 INFO blam! 8: 0x556148b9ade0 - core::result::unwrap_failed::hfcde22ed5770881b Oct 11 17:23:16.196 INFO blam! at libcore/macros.rs:26 Oct 11 17:23:16.196 INFO blam! 9: 0x556148b9a0be - >::unwrap::h41255a0aa6719384 Oct 11 17:23:16.196 INFO blam! at libcore/result.rs:808 Oct 11 17:23:16.196 INFO blam! 10: 0x556148b952d3 - loggy::before_test::h5edbb82ecfeaab74 Oct 11 17:23:16.196 INFO blam! at src/lib.rs:383 Oct 11 17:23:16.196 INFO blam! 11: 0x556148b4b6fb - test_log::notice_should_be_captured::h51c85a6240708e6d Oct 11 17:23:16.196 INFO blam! at /source/<::loggy::test_loggy macros>:6 Oct 11 17:23:16.196 INFO blam! 12: 0x556148b4b6d9 - test_log::notice_should_be_captured::{{closure}}::hcce5f54d5ee1bb5a Oct 11 17:23:16.196 INFO blam! at /source/<::loggy::test_loggy macros>:5 Oct 11 17:23:16.196 INFO blam! 13: 0x556148b4e48d - core::ops::function::FnOnce::call_once::h7989747fb2813c19 Oct 11 17:23:16.196 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.196 INFO blam! 14: 0x556148b54fae - >::call_box::h95b7cb918af67b5d Oct 11 17:23:16.196 INFO blam! at libtest/lib.rs:1468 Oct 11 17:23:16.204 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.204 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.204 INFO blam! 15: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.204 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.204 INFO blam! 16: 0x556148b75afd - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 17:23:16.204 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.204 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.204 INFO blam! at libtest/lib.rs:1423 Oct 11 17:23:16.204 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 17:23:16.204 INFO blam! 17: 0x556148b76704 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 17:23:16.204 INFO blam! at libstd/thread/mod.rs:409 Oct 11 17:23:16.204 INFO blam! at libstd/panic.rs:313 Oct 11 17:23:16.204 INFO blam! at libstd/panicking.rs:310 Oct 11 17:23:16.204 INFO blam! 18: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.204 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.204 INFO blam! 19: 0x556148b63cc6 - >::call_box::h96125cb29a9ba44b Oct 11 17:23:16.204 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.204 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.204 INFO blam! at libstd/thread/mod.rs:408 Oct 11 17:23:16.204 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.204 INFO blam! 20: 0x556148bc574a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 17:23:16.204 INFO blam! at liballoc/boxed.rs:682 Oct 11 17:23:16.204 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 17:23:16.204 INFO blam! 21: 0x556148bbadf5 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 17:23:16.204 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 17:23:16.204 INFO blam! 22: 0x7f62d11c56b9 - start_thread Oct 11 17:23:16.204 INFO blam! 23: 0x7f62d0ce541c - clone Oct 11 17:23:16.204 INFO blam! 24: 0x0 - Oct 11 17:23:16.204 INFO blam! Oct 11 17:23:16.204 INFO blam! ---- errors_should_be_counted stdout ---- Oct 11 17:23:16.204 INFO blam! thread 'errors_should_be_counted' panicked at 'called `Result::unwrap()` on an `Err` value: "PoisonError { inner: .. }"', libcore/result.rs:1009:5 Oct 11 17:23:16.204 INFO blam! stack backtrace: Oct 11 17:23:16.204 INFO blam! 0: 0x556148bc370e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 17:23:16.204 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 17:23:16.204 INFO blam! 1: 0x556148bcc5b6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 17:23:16.204 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 17:23:16.204 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 17:23:16.204 INFO blam! 2: 0x556148bc730d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 17:23:16.204 INFO blam! at libstd/panicking.rs:211 Oct 11 17:23:16.204 INFO blam! 3: 0x556148bc701b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 17:23:16.204 INFO blam! at libstd/panicking.rs:221 Oct 11 17:23:16.204 INFO blam! 4: 0x556148bc79bc - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 17:23:16.204 INFO blam! at libstd/panicking.rs:476 Oct 11 17:23:16.204 INFO blam! 5: 0x556148bc7579 - std::panicking::continue_panic_fmt::h6e11f50e47f94b00 Oct 11 17:23:16.204 INFO blam! at libstd/panicking.rs:390 Oct 11 17:23:16.204 INFO blam! 6: 0x556148bc7475 - rust_begin_unwind Oct 11 17:23:16.204 INFO blam! at libstd/panicking.rs:325 Oct 11 17:23:16.204 INFO blam! 7: 0x556148c07fcb - core::panicking::panic_fmt::hf99aac1e278ac2e5 Oct 11 17:23:16.205 INFO blam! at libcore/panicking.rs:77 Oct 11 17:23:16.205 INFO blam! 8: 0x556148b9ade0 - core::result::unwrap_failed::hfcde22ed5770881b Oct 11 17:23:16.205 INFO blam! at libcore/macros.rs:26 Oct 11 17:23:16.205 INFO blam! 9: 0x556148b9a0be - >::unwrap::h41255a0aa6719384 Oct 11 17:23:16.205 INFO blam! at libcore/result.rs:808 Oct 11 17:23:16.205 INFO blam! 10: 0x556148b952d3 - loggy::before_test::h5edbb82ecfeaab74 Oct 11 17:23:16.205 INFO blam! at src/lib.rs:383 Oct 11 17:23:16.205 INFO blam! 11: 0x556148b4bf1c - test_log::errors_should_be_counted::h5f971d86e143e87c Oct 11 17:23:16.205 INFO blam! at /source/<::loggy::test_loggy macros>:6 Oct 11 17:23:16.205 INFO blam! 12: 0x556148b4bef9 - test_log::errors_should_be_counted::{{closure}}::h0500bd5802c5bedb Oct 11 17:23:16.205 INFO blam! at /source/<::loggy::test_loggy macros>:5 Oct 11 17:23:16.205 INFO blam! 13: 0x556148b4e5dd - core::ops::function::FnOnce::call_once::hf52453835c5cb86e Oct 11 17:23:16.205 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.205 INFO blam! 14: 0x556148b54fae - >::call_box::h95b7cb918af67b5d Oct 11 17:23:16.205 INFO blam! at libtest/lib.rs:1468 Oct 11 17:23:16.205 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.205 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.205 INFO blam! 15: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.205 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.205 INFO blam! 16: 0x556148b75afd - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 17:23:16.205 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.205 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.205 INFO blam! at libtest/lib.rs:1423 Oct 11 17:23:16.205 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 17:23:16.205 INFO blam! 17: 0x556148b76704 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 17:23:16.205 INFO blam! at libstd/thread/mod.rs:409 Oct 11 17:23:16.205 INFO blam! at libstd/panic.rs:313 Oct 11 17:23:16.205 INFO blam! at libstd/panicking.rs:310 Oct 11 17:23:16.205 INFO blam! 18: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.205 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.205 INFO blam! 19: 0x556148b63cc6 - >::call_box::h96125cb29a9ba44b Oct 11 17:23:16.205 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.205 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.205 INFO blam! at libstd/thread/mod.rs:408 Oct 11 17:23:16.205 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.205 INFO blam! 20: 0x556148bc574a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 17:23:16.205 INFO blam! at liballoc/boxed.rs:682 Oct 11 17:23:16.205 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 17:23:16.205 INFO blam! 21: 0x556148bbadf5 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 17:23:16.205 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 17:23:16.205 INFO blam! 22: 0x7f62d11c56b9 - start_thread Oct 11 17:23:16.205 INFO blam! 23: 0x7f62d0ce541c - clone Oct 11 17:23:16.205 INFO blam! 24: 0x0 - Oct 11 17:23:16.205 INFO blam! Oct 11 17:23:16.205 INFO blam! ---- worker_threads_should_be_reported stdout ---- Oct 11 17:23:16.205 INFO blam! thread 'worker_threads_should_be_reported' panicked at 'called `Result::unwrap()` on an `Err` value: "PoisonError { inner: .. }"', libcore/result.rs:1009:5 Oct 11 17:23:16.205 INFO blam! stack backtrace: Oct 11 17:23:16.205 INFO blam! 0: 0x556148bc370e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 17:23:16.205 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 17:23:16.205 INFO blam! 1: 0x556148bcc5b6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 17:23:16.205 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 17:23:16.205 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 17:23:16.205 INFO blam! 2: 0x556148bc730d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 17:23:16.205 INFO blam! at libstd/panicking.rs:211 Oct 11 17:23:16.205 INFO blam! 3: 0x556148bc701b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 17:23:16.205 INFO blam! at libstd/panicking.rs:221 Oct 11 17:23:16.205 INFO blam! 4: 0x556148bc79bc - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 17:23:16.205 INFO blam! at libstd/panicking.rs:476 Oct 11 17:23:16.205 INFO blam! 5: 0x556148bc7579 - std::panicking::continue_panic_fmt::h6e11f50e47f94b00 Oct 11 17:23:16.205 INFO blam! at libstd/panicking.rs:390 Oct 11 17:23:16.205 INFO blam! 6: 0x556148bc7475 - rust_begin_unwind Oct 11 17:23:16.205 INFO blam! at libstd/panicking.rs:325 Oct 11 17:23:16.205 INFO blam! 7: 0x556148c07fcb - core::panicking::panic_fmt::hf99aac1e278ac2e5 Oct 11 17:23:16.205 INFO blam! at libcore/panicking.rs:77 Oct 11 17:23:16.205 INFO blam! 8: 0x556148b9ade0 - core::result::unwrap_failed::hfcde22ed5770881b Oct 11 17:23:16.205 INFO blam! at libcore/macros.rs:26 Oct 11 17:23:16.205 INFO blam! 9: 0x556148b9a0be - >::unwrap::h41255a0aa6719384 Oct 11 17:23:16.205 INFO blam! at libcore/result.rs:808 Oct 11 17:23:16.205 INFO blam! 10: 0x556148b952d3 - loggy::before_test::h5edbb82ecfeaab74 Oct 11 17:23:16.205 INFO blam! at src/lib.rs:383 Oct 11 17:23:16.205 INFO blam! 11: 0x556148b4babb - test_log::worker_threads_should_be_reported::h8c6ba50c4cade5ff Oct 11 17:23:16.205 INFO blam! at /source/<::loggy::test_loggy macros>:6 Oct 11 17:23:16.205 INFO blam! 12: 0x556148b4ba99 - test_log::worker_threads_should_be_reported::{{closure}}::h86d65d9488cf6434 Oct 11 17:23:16.205 INFO blam! at /source/<::loggy::test_loggy macros>:5 Oct 11 17:23:16.205 INFO blam! 13: 0x556148b4e30d - core::ops::function::FnOnce::call_once::h15b4afd53432b06d Oct 11 17:23:16.205 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.205 INFO blam! 14: 0x556148b54fae - >::call_box::h95b7cb918af67b5d Oct 11 17:23:16.205 INFO blam! at libtest/lib.rs:1468 Oct 11 17:23:16.205 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.205 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.205 INFO blam! 15: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.205 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.205 INFO blam! 16: 0x556148b75afd - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 17:23:16.205 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.205 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.205 INFO blam! at libtest/lib.rs:1423 Oct 11 17:23:16.205 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 17:23:16.205 INFO blam! 17: 0x556148b76704 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 17:23:16.205 INFO blam! at libstd/thread/mod.rs:409 Oct 11 17:23:16.205 INFO blam! at libstd/panic.rs:313 Oct 11 17:23:16.206 INFO blam! at libstd/panicking.rs:310 Oct 11 17:23:16.206 INFO blam! 18: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.206 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.206 INFO blam! 19: 0x556148b63cc6 - >::call_box::h96125cb29a9ba44b Oct 11 17:23:16.206 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.206 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.206 INFO blam! at libstd/thread/mod.rs:408 Oct 11 17:23:16.206 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.206 INFO blam! 20: 0x556148bc574a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 17:23:16.206 INFO blam! at liballoc/boxed.rs:682 Oct 11 17:23:16.206 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 17:23:16.206 INFO blam! 21: 0x556148bbadf5 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 17:23:16.206 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 17:23:16.206 INFO blam! 22: 0x7f62d11c56b9 - start_thread Oct 11 17:23:16.206 INFO blam! 23: 0x7f62d0ce541c - clone Oct 11 17:23:16.206 INFO blam! 24: 0x0 - Oct 11 17:23:16.206 INFO blam! Oct 11 17:23:16.206 INFO blam! ---- debug_should_not_be_captured stdout ---- Oct 11 17:23:16.206 INFO blam! thread 'debug_should_not_be_captured' panicked at 'called `Result::unwrap()` on an `Err` value: "PoisonError { inner: .. }"', libcore/result.rs:1009:5 Oct 11 17:23:16.206 INFO blam! stack backtrace: Oct 11 17:23:16.206 INFO blam! 0: 0x556148bc370e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 17:23:16.206 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 17:23:16.206 INFO blam! 1: 0x556148bcc5b6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 17:23:16.206 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 17:23:16.206 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 17:23:16.206 INFO blam! 2: 0x556148bc730d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 17:23:16.206 INFO blam! at libstd/panicking.rs:211 Oct 11 17:23:16.206 INFO blam! 3: 0x556148bc701b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 17:23:16.206 INFO blam! at libstd/panicking.rs:221 Oct 11 17:23:16.206 INFO blam! 4: 0x556148bc79bc - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 17:23:16.206 INFO blam! at libstd/panicking.rs:476 Oct 11 17:23:16.206 INFO blam! 5: 0x556148bc7579 - std::panicking::continue_panic_fmt::h6e11f50e47f94b00 Oct 11 17:23:16.206 INFO blam! at libstd/panicking.rs:390 Oct 11 17:23:16.206 INFO blam! 6: 0x556148bc7475 - rust_begin_unwind Oct 11 17:23:16.206 INFO blam! at libstd/panicking.rs:325 Oct 11 17:23:16.206 INFO blam! 7: 0x556148c07fcb - core::panicking::panic_fmt::hf99aac1e278ac2e5 Oct 11 17:23:16.206 INFO blam! at libcore/panicking.rs:77 Oct 11 17:23:16.206 INFO blam! 8: 0x556148b9ade0 - core::result::unwrap_failed::hfcde22ed5770881b Oct 11 17:23:16.206 INFO blam! at libcore/macros.rs:26 Oct 11 17:23:16.206 INFO blam! 9: 0x556148b9a0be - >::unwrap::h41255a0aa6719384 Oct 11 17:23:16.206 INFO blam! at libcore/result.rs:808 Oct 11 17:23:16.206 INFO blam! 10: 0x556148b952d3 - loggy::before_test::h5edbb82ecfeaab74 Oct 11 17:23:16.206 INFO blam! at src/lib.rs:383 Oct 11 17:23:16.206 INFO blam! 11: 0x556148b4b45b - test_log::debug_should_not_be_captured::h68e759a878dd31d6 Oct 11 17:23:16.206 INFO blam! at /source/<::loggy::test_loggy macros>:6 Oct 11 17:23:16.206 INFO blam! 12: 0x556148b4b439 - test_log::debug_should_not_be_captured::{{closure}}::hd3dc8bef054385e8 Oct 11 17:23:16.206 INFO blam! at /source/<::loggy::test_loggy macros>:5 Oct 11 17:23:16.206 INFO blam! 13: 0x556148b4e51d - core::ops::function::FnOnce::call_once::haf75b6c5a27bd5d7 Oct 11 17:23:16.206 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.206 INFO blam! 14: 0x556148b54fae - >::call_box::h95b7cb918af67b5d Oct 11 17:23:16.206 INFO blam! at libtest/lib.rs:1468 Oct 11 17:23:16.206 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.206 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.206 INFO blam! 15: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.206 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.206 INFO blam! 16: 0x556148b75afd - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 17:23:16.206 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.206 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.206 INFO blam! at libtest/lib.rs:1423 Oct 11 17:23:16.206 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 17:23:16.206 INFO blam! 17: 0x556148b76704 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 17:23:16.206 INFO blam! at libstd/thread/mod.rs:409 Oct 11 17:23:16.206 INFO blam! at libstd/panic.rs:313 Oct 11 17:23:16.206 INFO blam! at libstd/panicking.rs:310 Oct 11 17:23:16.206 INFO blam! 18: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.206 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.206 INFO blam! 19: 0x556148b63cc6 - >::call_box::h96125cb29a9ba44b Oct 11 17:23:16.206 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.206 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.206 INFO blam! at libstd/thread/mod.rs:408 Oct 11 17:23:16.206 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.206 INFO blam! 20: 0x556148bc574a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 17:23:16.206 INFO blam! at liballoc/boxed.rs:682 Oct 11 17:23:16.206 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 17:23:16.206 INFO blam! 21: 0x556148bbadf5 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 17:23:16.206 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 17:23:16.206 INFO blam! 22: 0x7f62d11c56b9 - start_thread Oct 11 17:23:16.206 INFO blam! 23: 0x7f62d0ce541c - clone Oct 11 17:23:16.206 INFO blam! 24: 0x0 - Oct 11 17:23:16.206 INFO blam! Oct 11 17:23:16.206 INFO blam! ---- warning_should_be_captured stdout ---- Oct 11 17:23:16.206 INFO blam! thread 'warning_should_be_captured' panicked at 'called `Result::unwrap()` on an `Err` value: "PoisonError { inner: .. }"', libcore/result.rs:1009:5 Oct 11 17:23:16.206 INFO blam! stack backtrace: Oct 11 17:23:16.206 INFO blam! 0: 0x556148bc370e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 17:23:16.206 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 17:23:16.206 INFO blam! 1: 0x556148bcc5b6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 17:23:16.206 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 17:23:16.206 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 17:23:16.207 INFO blam! 2: 0x556148bc730d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 17:23:16.207 INFO blam! at libstd/panicking.rs:211 Oct 11 17:23:16.207 INFO blam! 3: 0x556148bc701b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 17:23:16.207 INFO blam! at libstd/panicking.rs:221 Oct 11 17:23:16.207 INFO blam! 4: 0x556148bc79bc - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 17:23:16.207 INFO blam! at libstd/panicking.rs:476 Oct 11 17:23:16.207 INFO blam! 5: 0x556148bc7579 - std::panicking::continue_panic_fmt::h6e11f50e47f94b00 Oct 11 17:23:16.207 INFO blam! at libstd/panicking.rs:390 Oct 11 17:23:16.207 INFO blam! 6: 0x556148bc7475 - rust_begin_unwind Oct 11 17:23:16.207 INFO blam! at libstd/panicking.rs:325 Oct 11 17:23:16.207 INFO blam! 7: 0x556148c07fcb - core::panicking::panic_fmt::hf99aac1e278ac2e5 Oct 11 17:23:16.207 INFO blam! at libcore/panicking.rs:77 Oct 11 17:23:16.207 INFO blam! 8: 0x556148b9ade0 - core::result::unwrap_failed::hfcde22ed5770881b Oct 11 17:23:16.207 INFO blam! at libcore/macros.rs:26 Oct 11 17:23:16.207 INFO blam! 9: 0x556148b9a0be - >::unwrap::h41255a0aa6719384 Oct 11 17:23:16.207 INFO blam! at libcore/result.rs:808 Oct 11 17:23:16.207 INFO blam! 10: 0x556148b952d3 - loggy::before_test::h5edbb82ecfeaab74 Oct 11 17:23:16.207 INFO blam! at src/lib.rs:383 Oct 11 17:23:16.207 INFO blam! 11: 0x556148b4b17b - test_log::warning_should_be_captured::hd2d01e88fde9bca1 Oct 11 17:23:16.207 INFO blam! at /source/<::loggy::test_loggy macros>:6 Oct 11 17:23:16.207 INFO blam! 12: 0x556148b4b159 - test_log::warning_should_be_captured::{{closure}}::h96a334bde7621c1c Oct 11 17:23:16.207 INFO blam! at /source/<::loggy::test_loggy macros>:5 Oct 11 17:23:16.207 INFO blam! 13: 0x556148b4e38d - core::ops::function::FnOnce::call_once::h3983cfc97a38b86f Oct 11 17:23:16.207 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.207 INFO blam! 14: 0x556148b54fae - >::call_box::h95b7cb918af67b5d Oct 11 17:23:16.207 INFO blam! at libtest/lib.rs:1468 Oct 11 17:23:16.207 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.207 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.207 INFO blam! 15: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.207 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.207 INFO blam! 16: 0x556148b75afd - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 17:23:16.207 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.207 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.207 INFO blam! at libtest/lib.rs:1423 Oct 11 17:23:16.207 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 17:23:16.207 INFO blam! 17: 0x556148b76704 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 17:23:16.207 INFO blam! at libstd/thread/mod.rs:409 Oct 11 17:23:16.207 INFO blam! at libstd/panic.rs:313 Oct 11 17:23:16.207 INFO blam! at libstd/panicking.rs:310 Oct 11 17:23:16.207 INFO blam! 18: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.207 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.207 INFO blam! 19: 0x556148b63cc6 - >::call_box::h96125cb29a9ba44b Oct 11 17:23:16.207 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.207 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.207 INFO blam! at libstd/thread/mod.rs:408 Oct 11 17:23:16.207 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.207 INFO blam! 20: 0x556148bc574a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 17:23:16.207 INFO blam! at liballoc/boxed.rs:682 Oct 11 17:23:16.207 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 17:23:16.207 INFO blam! 21: 0x556148bbadf5 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 17:23:16.207 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 17:23:16.207 INFO blam! 22: 0x7f62d11c56b9 - start_thread Oct 11 17:23:16.207 INFO blam! 23: 0x7f62d0ce541c - clone Oct 11 17:23:16.207 INFO blam! 24: 0x0 - Oct 11 17:23:16.207 INFO blam! Oct 11 17:23:16.207 INFO blam! ---- info_should_be_captured stdout ---- Oct 11 17:23:16.207 INFO blam! thread 'info_should_be_captured' panicked at 'called `Result::unwrap()` on an `Err` value: "PoisonError { inner: .. }"', libcore/result.rs:1009:5 Oct 11 17:23:16.207 INFO blam! stack backtrace: Oct 11 17:23:16.207 INFO blam! 0: 0x556148bc370e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 17:23:16.207 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 17:23:16.207 INFO blam! 1: 0x556148bcc5b6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 17:23:16.207 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 17:23:16.207 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 17:23:16.207 INFO blam! 2: 0x556148bc730d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 17:23:16.207 INFO blam! at libstd/panicking.rs:211 Oct 11 17:23:16.207 INFO blam! 3: 0x556148bc701b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 17:23:16.207 INFO blam! at libstd/panicking.rs:221 Oct 11 17:23:16.207 INFO blam! 4: 0x556148bc79bc - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 17:23:16.207 INFO blam! at libstd/panicking.rs:476 Oct 11 17:23:16.207 INFO blam! 5: 0x556148bc7579 - std::panicking::continue_panic_fmt::h6e11f50e47f94b00 Oct 11 17:23:16.207 INFO blam! at libstd/panicking.rs:390 Oct 11 17:23:16.207 INFO blam! 6: 0x556148bc7475 - rust_begin_unwind Oct 11 17:23:16.207 INFO blam! at libstd/panicking.rs:325 Oct 11 17:23:16.207 INFO blam! 7: 0x556148c07fcb - core::panicking::panic_fmt::hf99aac1e278ac2e5 Oct 11 17:23:16.207 INFO blam! at libcore/panicking.rs:77 Oct 11 17:23:16.207 INFO blam! 8: 0x556148b9ade0 - core::result::unwrap_failed::hfcde22ed5770881b Oct 11 17:23:16.207 INFO blam! at libcore/macros.rs:26 Oct 11 17:23:16.207 INFO blam! 9: 0x556148b9a0be - >::unwrap::h41255a0aa6719384 Oct 11 17:23:16.207 INFO blam! at libcore/result.rs:808 Oct 11 17:23:16.207 INFO blam! 10: 0x556148b952d3 - loggy::before_test::h5edbb82ecfeaab74 Oct 11 17:23:16.207 INFO blam! at src/lib.rs:383 Oct 11 17:23:16.207 INFO blam! 11: 0x556148b4b2eb - test_log::info_should_be_captured::ha3bd85e5b5ca12bd Oct 11 17:23:16.207 INFO blam! at /source/<::loggy::test_loggy macros>:6 Oct 11 17:23:16.207 INFO blam! 12: 0x556148b4b2c9 - test_log::info_should_be_captured::{{closure}}::h054575a1545ebe92 Oct 11 17:23:16.207 INFO blam! at /source/<::loggy::test_loggy macros>:5 Oct 11 17:23:16.207 INFO blam! 13: 0x556148b4e59d - core::ops::function::FnOnce::call_once::hf4d763697bfa7c22 Oct 11 17:23:16.208 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.208 INFO blam! 14: 0x556148b54fae - >::call_box::h95b7cb918af67b5d Oct 11 17:23:16.208 INFO blam! at libtest/lib.rs:1468 Oct 11 17:23:16.208 INFO blam! at libcore/ops/function.rs:238 Oct 11 17:23:16.208 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.208 INFO blam! 15: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.208 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.208 INFO blam! 16: 0x556148b75afd - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 17:23:16.208 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.208 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.208 INFO blam! at libtest/lib.rs:1423 Oct 11 17:23:16.208 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 17:23:16.208 INFO blam! 17: 0x556148b76704 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 17:23:16.208 INFO blam! at libstd/thread/mod.rs:409 Oct 11 17:23:16.208 INFO blam! at libstd/panic.rs:313 Oct 11 17:23:16.208 INFO blam! at libstd/panicking.rs:310 Oct 11 17:23:16.208 INFO blam! 18: 0x556148bd7789 - __rust_maybe_catch_panic Oct 11 17:23:16.208 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 17:23:16.208 INFO blam! 19: 0x556148b63cc6 - >::call_box::h96125cb29a9ba44b Oct 11 17:23:16.208 INFO blam! at libstd/panicking.rs:289 Oct 11 17:23:16.208 INFO blam! at libstd/panic.rs:392 Oct 11 17:23:16.208 INFO blam! at libstd/thread/mod.rs:408 Oct 11 17:23:16.208 INFO blam! at liballoc/boxed.rs:672 Oct 11 17:23:16.208 INFO blam! 20: 0x556148bc574a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 17:23:16.208 INFO blam! at liballoc/boxed.rs:682 Oct 11 17:23:16.208 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 17:23:16.208 INFO blam! 21: 0x556148bbadf5 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 17:23:16.208 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 17:23:16.208 INFO blam! 22: 0x7f62d11c56b9 - start_thread Oct 11 17:23:16.208 INFO blam! 23: 0x7f62d0ce541c - clone Oct 11 17:23:16.208 INFO blam! 24: 0x0 - Oct 11 17:23:16.212 INFO blam! Oct 11 17:23:16.212 INFO blam! Oct 11 17:23:16.212 INFO blam! failures: Oct 11 17:23:16.212 INFO blam! debug_should_not_be_captured Oct 11 17:23:16.212 INFO blam! error_should_be_captured Oct 11 17:23:16.212 INFO blam! errors_should_be_counted Oct 11 17:23:16.212 INFO blam! info_should_be_captured Oct 11 17:23:16.212 INFO blam! notice_should_be_captured Oct 11 17:23:16.212 INFO blam! notice_should_be_controlled Oct 11 17:23:16.212 INFO blam! warning_should_be_captured Oct 11 17:23:16.212 INFO blam! worker_threads_should_be_reported Oct 11 17:23:16.212 INFO blam! Oct 11 17:23:16.212 INFO blam! test result: FAILED. 1 passed; 8 failed; 0 ignored; 0 measured; 0 filtered out Oct 11 17:23:16.212 INFO blam! Oct 11 17:23:16.216 INFO kablam! error: test failed, to rerun pass '--test test_log' Oct 11 17:23:16.216 INFO kablam! su: No module specific data is present Oct 11 17:23:16.522 INFO running `"docker" "rm" "-f" "e04c55bc809a6af5e12d68fccf15ca52ed7eca060f52048a59b99c359a553779"` Oct 11 17:23:16.780 INFO blam! e04c55bc809a6af5e12d68fccf15ca52ed7eca060f52048a59b99c359a553779