[INFO] crate loggy 0.3.2 is already in cache [INFO] extracting crate loggy 0.3.2 into work/ex/beta-1.38-1/sources/1.37.0/reg/loggy/0.3.2 [INFO] extracting crate loggy 0.3.2 into work/ex/beta-1.38-1/sources/beta-2019-08-13/reg/loggy/0.3.2 [INFO] validating manifest of loggy-0.3.2 on toolchain 1.37.0 [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "read-manifest" "--manifest-path" "Cargo.toml"` [INFO] validating manifest of loggy-0.3.2 on toolchain beta-2019-08-13 [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "read-manifest" "--manifest-path" "Cargo.toml"` [INFO] started frobbing loggy-0.3.2 [INFO] finished frobbing loggy-0.3.2 [INFO] frobbed toml for loggy-0.3.2 written to work/ex/beta-1.38-1/sources/1.37.0/reg/loggy/0.3.2/Cargo.toml [INFO] started frobbing loggy-0.3.2 [INFO] finished frobbing loggy-0.3.2 [INFO] frobbed toml for loggy-0.3.2 written to work/ex/beta-1.38-1/sources/beta-2019-08-13/reg/loggy/0.3.2/Cargo.toml [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"` [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"` [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"` [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "fetch" "--locked" "--manifest-path" "Cargo.toml"` [INFO] testing loggy-0.3.2 against 1.37.0 for beta-1.38-1 [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-4/1.37.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/1.37.0/reg/loggy/0.3.2:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.37.0" "build" "--frozen"` [INFO] [stdout] adcf3408ac0f7a0f88fc5ffa358a1592baad6b81a50fa2bac488f9652d16340d [INFO] running `"docker" "start" "-a" "adcf3408ac0f7a0f88fc5ffa358a1592baad6b81a50fa2bac488f9652d16340d"` [INFO] [stderr] Compiling loggy v0.3.2 (/opt/crater/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.86s [INFO] running `"docker" "inspect" "adcf3408ac0f7a0f88fc5ffa358a1592baad6b81a50fa2bac488f9652d16340d"` [INFO] running `"docker" "rm" "-f" "adcf3408ac0f7a0f88fc5ffa358a1592baad6b81a50fa2bac488f9652d16340d"` [INFO] [stdout] adcf3408ac0f7a0f88fc5ffa358a1592baad6b81a50fa2bac488f9652d16340d [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-4/1.37.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/1.37.0/reg/loggy/0.3.2:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.37.0" "test" "--frozen" "--no-run"` [INFO] [stdout] a8370bde24daa8a3cdce2eb58c93c93363a943f1d2320f687e64f1d94fb0165d [INFO] running `"docker" "start" "-a" "a8370bde24daa8a3cdce2eb58c93c93363a943f1d2320f687e64f1d94fb0165d"` [INFO] [stderr] Compiling loggy v0.3.2 (/opt/crater/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.81s [INFO] running `"docker" "inspect" "a8370bde24daa8a3cdce2eb58c93c93363a943f1d2320f687e64f1d94fb0165d"` [INFO] running `"docker" "rm" "-f" "a8370bde24daa8a3cdce2eb58c93c93363a943f1d2320f687e64f1d94fb0165d"` [INFO] [stdout] a8370bde24daa8a3cdce2eb58c93c93363a943f1d2320f687e64f1d94fb0165d [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-4/1.37.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/1.37.0/reg/loggy/0.3.2:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.37.0" "test" "--frozen"` [INFO] [stdout] 845ae12cdbf1074229e72011b93262d4abafe8225777e24c7e932a812781e46b [INFO] running `"docker" "start" "-a" "845ae12cdbf1074229e72011b93262d4abafe8225777e24c7e932a812781e46b"` [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.03s [INFO] [stderr] Running /opt/crater/target/debug/deps/loggy-1b4db80b6cfb6751 [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stderr] Running /opt/crater/target/debug/deps/test_log-3b9a3c55534f915c [INFO] [stdout] [INFO] [stdout] running 9 tests [INFO] [stdout] test debug_should_not_be_captured ... ok [INFO] [stdout] test error_should_be_captured ... ok [INFO] [stdout] test info_should_be_captured ... FAILED [INFO] [stdout] test errors_should_be_counted ... FAILED [INFO] [stdout] test multi_line_should_be_captured ... FAILED [INFO] [stdout] test notice_should_be_controlled ... FAILED [INFO] [stdout] test warning_should_be_captured ... FAILED [INFO] [stdout] test notice_should_be_captured ... FAILED [INFO] [stdout] test worker_threads_should_be_reported ... FAILED [INFO] [stderr] error: test failed, to rerun pass '--test test_log' [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- info_should_be_captured stdout ---- [INFO] [stdout] ACTUAL LOG: [INFO] [stdout] test: [INFO] test_log: information [INFO] [stdout] test[1]: [ERROR] test_log: inner [INFO] [stdout] [INFO] [stdout] IS DIFFERENT FROM EXPECTED LOG: [INFO] [stdout] test: [INFO] test_log: information [INFO] [stdout] [INFO] [stdout] thread 'info_should_be_captured' panicked at 'assertion failed: `(left == right)` [INFO] [stdout] left: `"ACTUAL LOG"`, [INFO] [stdout] right: `"EXPECTED LOG"`', src/lib.rs:277:17 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x559761b4d05b - backtrace::backtrace::libunwind::trace::hfe5db90796807973 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.29/src/backtrace/libunwind.rs:88 [INFO] [stdout] 1: 0x559761b4d05b - backtrace::backtrace::trace_unsynchronized::h34b865a835594335 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.29/src/backtrace/mod.rs:66 [INFO] [stdout] 2: 0x559761b4d05b - std::sys_common::backtrace::_print::h527254ae44989167 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:47 [INFO] [stdout] 3: 0x559761b4d05b - std::sys_common::backtrace::print::he85dd5ddddf46503 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:36 [INFO] [stdout] 4: 0x559761b4d05b - std::panicking::default_hook::{{closure}}::h847a2eb38b396f14 [INFO] [stdout] at src/libstd/panicking.rs:200 [INFO] [stdout] 5: 0x559761b4ccca - std::panicking::default_hook::h2ca0f9a30a0e206b [INFO] [stdout] at src/libstd/panicking.rs:211 [INFO] [stdout] 6: 0x559761b4d7d0 - std::panicking::rust_panic_with_hook::hffcefc09751839d1 [INFO] [stdout] at src/libstd/panicking.rs:477 [INFO] [stdout] 7: 0x559761b4d352 - std::panicking::continue_panic_fmt::hc0f142c930c846fc [INFO] [stdout] at src/libstd/panicking.rs:384 [INFO] [stdout] 8: 0x559761b4d29f - std::panicking::begin_panic_fmt::ha6acf0ffd6d7f80d [INFO] [stdout] at src/libstd/panicking.rs:339 [INFO] [stdout] 9: 0x559761b1998d - loggy::assert_log::ha7a2ebd0c0a9a1e9 [INFO] [stdout] at src/lib.rs:277 [INFO] [stdout] 10: 0x559761ad2883 - test_log::info_should_be_captured::h60cce08f48690c51 [INFO] [stdout] at tests/test_log.rs:43 [INFO] [stdout] 11: 0x559761ad278a - test_log::info_should_be_captured::{{closure}}::h215636a2fee76603 [INFO] [stdout] at /opt/crater/workdir/<::loggy::test_loggy macros>:5 [INFO] [stdout] 12: 0x559761ad673e - core::ops::function::FnOnce::call_once::h86becb213aa04c9d [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/ops/function.rs:231 [INFO] [stdout] 13: 0x559761ae6bdf - as core::ops::function::FnOnce>::call_once::h4a13ee3f0d7b4201 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 14: 0x559761b4fe0a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:82 [INFO] [stdout] 15: 0x559761b011d8 - std::panicking::try::h5a93466ab2078586 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:275 [INFO] [stdout] 16: 0x559761b011d8 - std::panic::catch_unwind::h752cbeae6ac7bdea [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:394 [INFO] [stdout] 17: 0x559761b011d8 - test::run_test::run_test_inner::{{closure}}::h206c9c16936edaca [INFO] [stdout] at src/libtest/lib.rs:1466 [INFO] [stdout] 18: 0x559761adc055 - std::sys_common::backtrace::__rust_begin_short_backtrace::hc7edbac42990d270 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/sys_common/backtrace.rs:77 [INFO] [stdout] 19: 0x559761ae0115 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::he53c58e7adee87af [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/thread/mod.rs:470 [INFO] [stdout] 20: 0x559761ae0115 - as core::ops::function::FnOnce<()>>::call_once::h1aff7c42b6bb3726 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:315 [INFO] [stdout] 21: 0x559761ae0115 - std::panicking::try::do_call::h41f8559f88100f6c [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:296 [INFO] [stdout] 22: 0x559761b4fe0a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:82 [INFO] [stdout] 23: 0x559761ae0812 - std::panicking::try::hb54ba808181fe352 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:275 [INFO] [stdout] 24: 0x559761ae0812 - std::panic::catch_unwind::h555ccf4e835e93f4 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:394 [INFO] [stdout] 25: 0x559761ae0812 - std::thread::Builder::spawn_unchecked::{{closure}}::hd4dae6e19e80fc1a [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/thread/mod.rs:469 [INFO] [stdout] 26: 0x559761ae0812 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hc35d54c07710e1a1 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/ops/function.rs:231 [INFO] [stdout] 27: 0x559761b42d1f - as core::ops::function::FnOnce>::call_once::h42806b83647d4c79 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 28: 0x559761b4f4d0 - as core::ops::function::FnOnce>::call_once::h83c921c8e826dd1d [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 29: 0x559761b4f4d0 - std::sys_common::thread::start_thread::h2613204ce513782e [INFO] [stdout] at src/libstd/sys_common/thread.rs:13 [INFO] [stdout] 30: 0x559761b4f4d0 - std::sys::unix::thread::Thread::new::thread_start::h4570080769500bcd [INFO] [stdout] at src/libstd/sys/unix/thread.rs:79 [INFO] [stdout] 31: 0x7f63091f84a4 - start_thread [INFO] [stdout] 32: 0x7f6308d23d0f - __clone [INFO] [stdout] 33: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- errors_should_be_counted stdout ---- [INFO] [stdout] thread 'errors_should_be_counted' panicked at 'assertion failed: `(left == right)` [INFO] [stdout] left: `1`, [INFO] [stdout] right: `2`', tests/test_log.rs:123:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x559761b4d05b - backtrace::backtrace::libunwind::trace::hfe5db90796807973 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.29/src/backtrace/libunwind.rs:88 [INFO] [stdout] 1: 0x559761b4d05b - backtrace::backtrace::trace_unsynchronized::h34b865a835594335 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.29/src/backtrace/mod.rs:66 [INFO] [stdout] 2: 0x559761b4d05b - std::sys_common::backtrace::_print::h527254ae44989167 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:47 [INFO] [stdout] 3: 0x559761b4d05b - std::sys_common::backtrace::print::he85dd5ddddf46503 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:36 [INFO] [stdout] 4: 0x559761b4d05b - std::panicking::default_hook::{{closure}}::h847a2eb38b396f14 [INFO] [stdout] at src/libstd/panicking.rs:200 [INFO] [stdout] 5: 0x559761b4ccca - std::panicking::default_hook::h2ca0f9a30a0e206b [INFO] [stdout] at src/libstd/panicking.rs:211 [INFO] [stdout] 6: 0x559761b4d7d0 - std::panicking::rust_panic_with_hook::hffcefc09751839d1 [INFO] [stdout] at src/libstd/panicking.rs:477 [INFO] [stdout] 7: 0x559761b4d352 - std::panicking::continue_panic_fmt::hc0f142c930c846fc [INFO] [stdout] at src/libstd/panicking.rs:384 [INFO] [stdout] 8: 0x559761b4d29f - std::panicking::begin_panic_fmt::ha6acf0ffd6d7f80d [INFO] [stdout] at src/libstd/panicking.rs:339 [INFO] [stdout] 9: 0x559761ad3bb4 - test_log::errors_should_be_counted::h1e8161cd61810265 [INFO] [stdout] at tests/test_log.rs:123 [INFO] [stdout] 10: 0x559761ad30fa - test_log::errors_should_be_counted::{{closure}}::hc96bb83dd3e4ca30 [INFO] [stdout] at /opt/crater/workdir/<::loggy::test_loggy macros>:5 [INFO] [stdout] 11: 0x559761ad65fe - core::ops::function::FnOnce::call_once::h242bcfbdb752eb38 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/ops/function.rs:231 [INFO] [stdout] 12: 0x559761ae6bdf - as core::ops::function::FnOnce>::call_once::h4a13ee3f0d7b4201 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 13: 0x559761b4fe0a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:82 [INFO] [stdout] 14: 0x559761b011d8 - std::panicking::try::h5a93466ab2078586 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:275 [INFO] [stdout] 15: 0x559761b011d8 - std::panic::catch_unwind::h752cbeae6ac7bdea [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:394 [INFO] [stdout] 16: 0x559761b011d8 - test::run_test::run_test_inner::{{closure}}::h206c9c16936edaca [INFO] [stdout] at src/libtest/lib.rs:1466 [INFO] [stdout] 17: 0x559761adc055 - std::sys_common::backtrace::__rust_begin_short_backtrace::hc7edbac42990d270 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/sys_common/backtrace.rs:77 [INFO] [stdout] 18: 0x559761ae0115 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::he53c58e7adee87af [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/thread/mod.rs:470 [INFO] [stdout] 19: 0x559761ae0115 - as core::ops::function::FnOnce<()>>::call_once::h1aff7c42b6bb3726 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:315 [INFO] [stdout] 20: 0x559761ae0115 - std::panicking::try::do_call::h41f8559f88100f6c [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:296 [INFO] [stdout] 21: 0x559761b4fe0a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:82 [INFO] [stdout] 22: 0x559761ae0812 - std::panicking::try::hb54ba808181fe352 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:275 [INFO] [stdout] 23: 0x559761ae0812 - std::panic::catch_unwind::h555ccf4e835e93f4 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:394 [INFO] [stdout] 24: 0x559761ae0812 - std::thread::Builder::spawn_unchecked::{{closure}}::hd4dae6e19e80fc1a [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/thread/mod.rs:469 [INFO] [stdout] 25: 0x559761ae0812 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hc35d54c07710e1a1 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/ops/function.rs:231 [INFO] [stdout] 26: 0x559761b42d1f - as core::ops::function::FnOnce>::call_once::h42806b83647d4c79 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 27: 0x559761b4f4d0 - as core::ops::function::FnOnce>::call_once::h83c921c8e826dd1d [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 28: 0x559761b4f4d0 - std::sys_common::thread::start_thread::h2613204ce513782e [INFO] [stdout] at src/libstd/sys_common/thread.rs:13 [INFO] [stdout] 29: 0x559761b4f4d0 - std::sys::unix::thread::Thread::new::thread_start::h4570080769500bcd [INFO] [stdout] at src/libstd/sys/unix/thread.rs:79 [INFO] [stdout] 30: 0x7f63091f84a4 - start_thread [INFO] [stdout] 31: 0x7f6308d23d0f - __clone [INFO] [stdout] 32: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- multi_line_should_be_captured stdout ---- [INFO] [stdout] thread 'multi_line_should_be_captured' panicked at 'called `Result::unwrap()` on an `Err` value: "PoisonError { inner: .. }"', src/libcore/result.rs:999:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x559761b4d05b - backtrace::backtrace::libunwind::trace::hfe5db90796807973 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.29/src/backtrace/libunwind.rs:88 [INFO] [stdout] 1: 0x559761b4d05b - backtrace::backtrace::trace_unsynchronized::h34b865a835594335 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.29/src/backtrace/mod.rs:66 [INFO] [stdout] 2: 0x559761b4d05b - std::sys_common::backtrace::_print::h527254ae44989167 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:47 [INFO] [stdout] 3: 0x559761b4d05b - std::sys_common::backtrace::print::he85dd5ddddf46503 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:36 [INFO] [stdout] 4: 0x559761b4d05b - std::panicking::default_hook::{{closure}}::h847a2eb38b396f14 [INFO] [stdout] at src/libstd/panicking.rs:200 [INFO] [stdout] 5: 0x559761b4ccca - std::panicking::default_hook::h2ca0f9a30a0e206b [INFO] [stdout] at src/libstd/panicking.rs:211 [INFO] [stdout] 6: 0x559761b4d7d0 - std::panicking::rust_panic_with_hook::hffcefc09751839d1 [INFO] [stdout] at src/libstd/panicking.rs:477 [INFO] [stdout] 7: 0x559761b4d352 - std::panicking::continue_panic_fmt::hc0f142c930c846fc [INFO] [stdout] at src/libstd/panicking.rs:384 [INFO] [stdout] 8: 0x559761b4d236 - rust_begin_unwind [INFO] [stdout] at src/libstd/panicking.rs:311 [INFO] [stdout] 9: 0x559761b63a8d - core::panicking::panic_fmt::h2daf88b2616ca2b2 [INFO] [stdout] at src/libcore/panicking.rs:85 [INFO] [stdout] 10: 0x559761b1fefd - core::result::unwrap_failed::h0b5e0a096c0d7e3c [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/macros.rs:18 [INFO] [stdout] 11: 0x559761b21162 - core::result::Result::unwrap::h09feb76502c5bb5c [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/result.rs:800 [INFO] [stdout] 12: 0x559761b19130 - loggy::set_log_sink::he4df2ee29fafecde [INFO] [stdout] at src/lib.rs:241 [INFO] [stdout] 13: 0x559761b1a21b - loggy::before_test::hcf539c5ec4708994 [INFO] [stdout] at src/lib.rs:393 [INFO] [stdout] 14: 0x559761ad258a - test_log::multi_line_should_be_captured::h90076bd667b40139 [INFO] [stdout] at /opt/crater/workdir/<::loggy::test_loggy macros>:6 [INFO] [stdout] 15: 0x559761ad256a - test_log::multi_line_should_be_captured::{{closure}}::h39971d6a971f6118 [INFO] [stdout] at /opt/crater/workdir/<::loggy::test_loggy macros>:5 [INFO] [stdout] 16: 0x559761ad667e - core::ops::function::FnOnce::call_once::h325e4ce56ad6e129 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/ops/function.rs:231 [INFO] [stdout] 17: 0x559761ae6bdf - as core::ops::function::FnOnce>::call_once::h4a13ee3f0d7b4201 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 18: 0x559761b4fe0a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:82 [INFO] [stdout] 19: 0x559761b011d8 - std::panicking::try::h5a93466ab2078586 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:275 [INFO] [stdout] 20: 0x559761b011d8 - std::panic::catch_unwind::h752cbeae6ac7bdea [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:394 [INFO] [stdout] 21: 0x559761b011d8 - test::run_test::run_test_inner::{{closure}}::h206c9c16936edaca [INFO] [stdout] at src/libtest/lib.rs:1466 [INFO] [stdout] 22: 0x559761adc055 - std::sys_common::backtrace::__rust_begin_short_backtrace::hc7edbac42990d270 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/sys_common/backtrace.rs:77 [INFO] [stdout] 23: 0x559761ae0115 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::he53c58e7adee87af [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/thread/mod.rs:470 [INFO] [stdout] 24: 0x559761ae0115 - as core::ops::function::FnOnce<()>>::call_once::h1aff7c42b6bb3726 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:315 [INFO] [stdout] 25: 0x559761ae0115 - std::panicking::try::do_call::h41f8559f88100f6c [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:296 [INFO] [stdout] 26: 0x559761b4fe0a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:82 [INFO] [stdout] 27: 0x559761ae0812 - std::panicking::try::hb54ba808181fe352 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:275 [INFO] [stdout] 28: 0x559761ae0812 - std::panic::catch_unwind::h555ccf4e835e93f4 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:394 [INFO] [stdout] 29: 0x559761ae0812 - std::thread::Builder::spawn_unchecked::{{closure}}::hd4dae6e19e80fc1a [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/thread/mod.rs:469 [INFO] [stdout] 30: 0x559761ae0812 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hc35d54c07710e1a1 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/ops/function.rs:231 [INFO] [stdout] 31: 0x559761b42d1f - as core::ops::function::FnOnce>::call_once::h42806b83647d4c79 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 32: 0x559761b4f4d0 - as core::ops::function::FnOnce>::call_once::h83c921c8e826dd1d [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 33: 0x559761b4f4d0 - std::sys_common::thread::start_thread::h2613204ce513782e [INFO] [stdout] at src/libstd/sys_common/thread.rs:13 [INFO] [stdout] 34: 0x559761b4f4d0 - std::sys::unix::thread::Thread::new::thread_start::h4570080769500bcd [INFO] [stdout] at src/libstd/sys/unix/thread.rs:79 [INFO] [stdout] 35: 0x7f63091f84a4 - start_thread [INFO] [stdout] 36: 0x7f6308d23d0f - __clone [INFO] [stdout] 37: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- notice_should_be_controlled stdout ---- [INFO] [stdout] thread 'notice_should_be_controlled' panicked at 'called `Result::unwrap()` on an `Err` value: "PoisonError { inner: .. }"', src/libcore/result.rs:999:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x559761b4d05b - backtrace::backtrace::libunwind::trace::hfe5db90796807973 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.29/src/backtrace/libunwind.rs:88 [INFO] [stdout] 1: 0x559761b4d05b - backtrace::backtrace::trace_unsynchronized::h34b865a835594335 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.29/src/backtrace/mod.rs:66 [INFO] [stdout] 2: 0x559761b4d05b - std::sys_common::backtrace::_print::h527254ae44989167 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:47 [INFO] [stdout] 3: 0x559761b4d05b - std::sys_common::backtrace::print::he85dd5ddddf46503 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:36 [INFO] [stdout] 4: 0x559761b4d05b - std::panicking::default_hook::{{closure}}::h847a2eb38b396f14 [INFO] [stdout] at src/libstd/panicking.rs:200 [INFO] [stdout] 5: 0x559761b4ccca - std::panicking::default_hook::h2ca0f9a30a0e206b [INFO] [stdout] at src/libstd/panicking.rs:211 [INFO] [stdout] 6: 0x559761b4d7d0 - std::panicking::rust_panic_with_hook::hffcefc09751839d1 [INFO] [stdout] at src/libstd/panicking.rs:477 [INFO] [stdout] 7: 0x559761b4d352 - std::panicking::continue_panic_fmt::hc0f142c930c846fc [INFO] [stdout] at src/libstd/panicking.rs:384 [INFO] [stdout] 8: 0x559761b4d236 - rust_begin_unwind [INFO] [stdout] at src/libstd/panicking.rs:311 [INFO] [stdout] 9: 0x559761b63a8d - core::panicking::panic_fmt::h2daf88b2616ca2b2 [INFO] [stdout] at src/libcore/panicking.rs:85 [INFO] [stdout] 10: 0x559761b2019d - core::result::unwrap_failed::h188a046decb1bccc [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/macros.rs:18 [INFO] [stdout] 11: 0x559761b21282 - core::result::Result::unwrap::h17e244e114a2cd66 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/result.rs:800 [INFO] [stdout] 12: 0x559761b1a03b - loggy::before_test::hcf539c5ec4708994 [INFO] [stdout] at src/lib.rs:379 [INFO] [stdout] 13: 0x559761ad2cb7 - test_log::notice_should_be_controlled::h816c4b2dbba20d20 [INFO] [stdout] at /opt/crater/workdir/<::loggy::test_loggy macros>:6 [INFO] [stdout] 14: 0x559761ad2c9a - test_log::notice_should_be_controlled::{{closure}}::hb20870e674bc86e1 [INFO] [stdout] at /opt/crater/workdir/<::loggy::test_loggy macros>:5 [INFO] [stdout] 15: 0x559761ad66fe - core::ops::function::FnOnce::call_once::h64f8c3ffb8636c80 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/ops/function.rs:231 [INFO] [stdout] 16: 0x559761ae6bdf - as core::ops::function::FnOnce>::call_once::h4a13ee3f0d7b4201 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 17: 0x559761b4fe0a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:82 [INFO] [stdout] 18: 0x559761b011d8 - std::panicking::try::h5a93466ab2078586 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:275 [INFO] [stdout] 19: 0x559761b011d8 - std::panic::catch_unwind::h752cbeae6ac7bdea [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:394 [INFO] [stdout] 20: 0x559761b011d8 - test::run_test::run_test_inner::{{closure}}::h206c9c16936edaca [INFO] [stdout] at src/libtest/lib.rs:1466 [INFO] [stdout] 21: 0x559761adc055 - std::sys_common::backtrace::__rust_begin_short_backtrace::hc7edbac42990d270 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/sys_common/backtrace.rs:77 [INFO] [stdout] 22: 0x559761ae0115 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::he53c58e7adee87af [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/thread/mod.rs:470 [INFO] [stdout] 23: 0x559761ae0115 - as core::ops::function::FnOnce<()>>::call_once::h1aff7c42b6bb3726 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:315 [INFO] [stdout] 24: 0x559761ae0115 - std::panicking::try::do_call::h41f8559f88100f6c [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:296 [INFO] [stdout] 25: 0x559761b4fe0a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:82 [INFO] [stdout] 26: 0x559761ae0812 - std::panicking::try::hb54ba808181fe352 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:275 [INFO] [stdout] 27: 0x559761ae0812 - std::panic::catch_unwind::h555ccf4e835e93f4 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:394 [INFO] [stdout] 28: 0x559761ae0812 - std::thread::Builder::spawn_unchecked::{{closure}}::hd4dae6e19e80fc1a [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/thread/mod.rs:469 [INFO] [stdout] 29: 0x559761ae0812 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hc35d54c07710e1a1 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/ops/function.rs:231 [INFO] [stdout] 30: 0x559761b42d1f - as core::ops::function::FnOnce>::call_once::h42806b83647d4c79 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 31: 0x559761b4f4d0 - as core::ops::function::FnOnce>::call_once::h83c921c8e826dd1d [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 32: 0x559761b4f4d0 - std::sys_common::thread::start_thread::h2613204ce513782e [INFO] [stdout] at src/libstd/sys_common/thread.rs:13 [INFO] [stdout] 33: 0x559761b4f4d0 - std::sys::unix::thread::Thread::new::thread_start::h4570080769500bcd [INFO] [stdout] at src/libstd/sys/unix/thread.rs:79 [INFO] [stdout] 34: 0x7f63091f84a4 - start_thread [INFO] [stdout] 35: 0x7f6308d23d0f - __clone [INFO] [stdout] 36: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- warning_should_be_captured stdout ---- [INFO] [stdout] thread 'warning_should_be_captured' panicked at 'called `Result::unwrap()` on an `Err` value: "PoisonError { inner: .. }"', src/libcore/result.rs:999:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x559761b4d05b - backtrace::backtrace::libunwind::trace::hfe5db90796807973 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.29/src/backtrace/libunwind.rs:88 [INFO] [stdout] 1: 0x559761b4d05b - backtrace::backtrace::trace_unsynchronized::h34b865a835594335 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.29/src/backtrace/mod.rs:66 [INFO] [stdout] 2: 0x559761b4d05b - std::sys_common::backtrace::_print::h527254ae44989167 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:47 [INFO] [stdout] 3: 0x559761b4d05b - std::sys_common::backtrace::print::he85dd5ddddf46503 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:36 [INFO] [stdout] 4: 0x559761b4d05b - std::panicking::default_hook::{{closure}}::h847a2eb38b396f14 [INFO] [stdout] at src/libstd/panicking.rs:200 [INFO] [stdout] 5: 0x559761b4ccca - std::panicking::default_hook::h2ca0f9a30a0e206b [INFO] [stdout] at src/libstd/panicking.rs:211 [INFO] [stdout] 6: 0x559761b4d7d0 - std::panicking::rust_panic_with_hook::hffcefc09751839d1 [INFO] [stdout] at src/libstd/panicking.rs:477 [INFO] [stdout] 7: 0x559761b4d352 - std::panicking::continue_panic_fmt::hc0f142c930c846fc [INFO] [stdout] at src/libstd/panicking.rs:384 [INFO] [stdout] 8: 0x559761b4d236 - rust_begin_unwind [INFO] [stdout] at src/libstd/panicking.rs:311 [INFO] [stdout] 9: 0x559761b63a8d - core::panicking::panic_fmt::h2daf88b2616ca2b2 [INFO] [stdout] at src/libcore/panicking.rs:85 [INFO] [stdout] 10: 0x559761b2019d - core::result::unwrap_failed::h188a046decb1bccc [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/macros.rs:18 [INFO] [stdout] 11: 0x559761b21282 - core::result::Result::unwrap::h17e244e114a2cd66 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/result.rs:800 [INFO] [stdout] 12: 0x559761b1a03b - loggy::before_test::hcf539c5ec4708994 [INFO] [stdout] at src/lib.rs:379 [INFO] [stdout] 13: 0x559761ad269a - test_log::warning_should_be_captured::h835082b0a8a80d55 [INFO] [stdout] at /opt/crater/workdir/<::loggy::test_loggy macros>:6 [INFO] [stdout] 14: 0x559761ad267a - test_log::warning_should_be_captured::{{closure}}::h49fd287369a520bc [INFO] [stdout] at /opt/crater/workdir/<::loggy::test_loggy macros>:5 [INFO] [stdout] 15: 0x559761ad66be - core::ops::function::FnOnce::call_once::h3995b6a4bcba8cfb [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/ops/function.rs:231 [INFO] [stdout] 16: 0x559761ae6bdf - as core::ops::function::FnOnce>::call_once::h4a13ee3f0d7b4201 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 17: 0x559761b4fe0a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:82 [INFO] [stdout] 18: 0x559761b011d8 - std::panicking::try::h5a93466ab2078586 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:275 [INFO] [stdout] 19: 0x559761b011d8 - std::panic::catch_unwind::h752cbeae6ac7bdea [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:394 [INFO] [stdout] 20: 0x559761b011d8 - test::run_test::run_test_inner::{{closure}}::h206c9c16936edaca [INFO] [stdout] at src/libtest/lib.rs:1466 [INFO] [stdout] 21: 0x559761adc055 - std::sys_common::backtrace::__rust_begin_short_backtrace::hc7edbac42990d270 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/sys_common/backtrace.rs:77 [INFO] [stdout] 22: 0x559761ae0115 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::he53c58e7adee87af [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/thread/mod.rs:470 [INFO] [stdout] 23: 0x559761ae0115 - as core::ops::function::FnOnce<()>>::call_once::h1aff7c42b6bb3726 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:315 [INFO] [stdout] 24: 0x559761ae0115 - std::panicking::try::do_call::h41f8559f88100f6c [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:296 [INFO] [stdout] 25: 0x559761b4fe0a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:82 [INFO] [stdout] 26: 0x559761ae0812 - std::panicking::try::hb54ba808181fe352 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:275 [INFO] [stdout] 27: 0x559761ae0812 - std::panic::catch_unwind::h555ccf4e835e93f4 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:394 [INFO] [stdout] 28: 0x559761ae0812 - std::thread::Builder::spawn_unchecked::{{closure}}::hd4dae6e19e80fc1a [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/thread/mod.rs:469 [INFO] [stdout] 29: 0x559761ae0812 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hc35d54c07710e1a1 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/ops/function.rs:231 [INFO] [stdout] 30: 0x559761b42d1f - as core::ops::function::FnOnce>::call_once::h42806b83647d4c79 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 31: 0x559761b4f4d0 - as core::ops::function::FnOnce>::call_once::h83c921c8e826dd1d [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 32: 0x559761b4f4d0 - std::sys_common::thread::start_thread::h2613204ce513782e [INFO] [stdout] at src/libstd/sys_common/thread.rs:13 [INFO] [stdout] 33: 0x559761b4f4d0 - std::sys::unix::thread::Thread::new::thread_start::h4570080769500bcd [INFO] [stdout] at src/libstd/sys/unix/thread.rs:79 [INFO] [stdout] 34: 0x7f63091f84a4 - start_thread [INFO] [stdout] 35: 0x7f6308d23d0f - __clone [INFO] [stdout] 36: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- notice_should_be_captured stdout ---- [INFO] [stdout] thread 'notice_should_be_captured' panicked at 'called `Result::unwrap()` on an `Err` value: "PoisonError { inner: .. }"', src/libcore/result.rs:999:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x559761b4d05b - backtrace::backtrace::libunwind::trace::hfe5db90796807973 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.29/src/backtrace/libunwind.rs:88 [INFO] [stdout] 1: 0x559761b4d05b - backtrace::backtrace::trace_unsynchronized::h34b865a835594335 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.29/src/backtrace/mod.rs:66 [INFO] [stdout] 2: 0x559761b4d05b - std::sys_common::backtrace::_print::h527254ae44989167 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:47 [INFO] [stdout] 3: 0x559761b4d05b - std::sys_common::backtrace::print::he85dd5ddddf46503 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:36 [INFO] [stdout] 4: 0x559761b4d05b - std::panicking::default_hook::{{closure}}::h847a2eb38b396f14 [INFO] [stdout] at src/libstd/panicking.rs:200 [INFO] [stdout] 5: 0x559761b4ccca - std::panicking::default_hook::h2ca0f9a30a0e206b [INFO] [stdout] at src/libstd/panicking.rs:211 [INFO] [stdout] 6: 0x559761b4d7d0 - std::panicking::rust_panic_with_hook::hffcefc09751839d1 [INFO] [stdout] at src/libstd/panicking.rs:477 [INFO] [stdout] 7: 0x559761b4d352 - std::panicking::continue_panic_fmt::hc0f142c930c846fc [INFO] [stdout] at src/libstd/panicking.rs:384 [INFO] [stdout] 8: 0x559761b4d236 - rust_begin_unwind [INFO] [stdout] at src/libstd/panicking.rs:311 [INFO] [stdout] 9: 0x559761b63a8d - core::panicking::panic_fmt::h2daf88b2616ca2b2 [INFO] [stdout] at src/libcore/panicking.rs:85 [INFO] [stdout] 10: 0x559761b2019d - core::result::unwrap_failed::h188a046decb1bccc [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/macros.rs:18 [INFO] [stdout] 11: 0x559761b21282 - core::result::Result::unwrap::h17e244e114a2cd66 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/result.rs:800 [INFO] [stdout] 12: 0x559761b1a03b - loggy::before_test::hcf539c5ec4708994 [INFO] [stdout] at src/lib.rs:379 [INFO] [stdout] 13: 0x559761ad2a9d - test_log::notice_should_be_captured::hf07e8285ca03b499 [INFO] [stdout] at /opt/crater/workdir/<::loggy::test_loggy macros>:6 [INFO] [stdout] 14: 0x559761ad2a7a - test_log::notice_should_be_captured::{{closure}}::h367450731a82a188 [INFO] [stdout] at /opt/crater/workdir/<::loggy::test_loggy macros>:5 [INFO] [stdout] 15: 0x559761ad663e - core::ops::function::FnOnce::call_once::h2c1f21295a291e7e [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/ops/function.rs:231 [INFO] [stdout] 16: 0x559761ae6bdf - as core::ops::function::FnOnce>::call_once::h4a13ee3f0d7b4201 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 17: 0x559761b4fe0a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:82 [INFO] [stdout] 18: 0x559761b011d8 - std::panicking::try::h5a93466ab2078586 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:275 [INFO] [stdout] 19: 0x559761b011d8 - std::panic::catch_unwind::h752cbeae6ac7bdea [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:394 [INFO] [stdout] 20: 0x559761b011d8 - test::run_test::run_test_inner::{{closure}}::h206c9c16936edaca [INFO] [stdout] at src/libtest/lib.rs:1466 [INFO] [stdout] 21: 0x559761adc055 - std::sys_common::backtrace::__rust_begin_short_backtrace::hc7edbac42990d270 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/sys_common/backtrace.rs:77 [INFO] [stdout] 22: 0x559761ae0115 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::he53c58e7adee87af [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/thread/mod.rs:470 [INFO] [stdout] 23: 0x559761ae0115 - as core::ops::function::FnOnce<()>>::call_once::h1aff7c42b6bb3726 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:315 [INFO] [stdout] 24: 0x559761ae0115 - std::panicking::try::do_call::h41f8559f88100f6c [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:296 [INFO] [stdout] 25: 0x559761b4fe0a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:82 [INFO] [stdout] 26: 0x559761ae0812 - std::panicking::try::hb54ba808181fe352 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:275 [INFO] [stdout] 27: 0x559761ae0812 - std::panic::catch_unwind::h555ccf4e835e93f4 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:394 [INFO] [stdout] 28: 0x559761ae0812 - std::thread::Builder::spawn_unchecked::{{closure}}::hd4dae6e19e80fc1a [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/thread/mod.rs:469 [INFO] [stdout] 29: 0x559761ae0812 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hc35d54c07710e1a1 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/ops/function.rs:231 [INFO] [stdout] 30: 0x559761b42d1f - as core::ops::function::FnOnce>::call_once::h42806b83647d4c79 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 31: 0x559761b4f4d0 - as core::ops::function::FnOnce>::call_once::h83c921c8e826dd1d [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 32: 0x559761b4f4d0 - std::sys_common::thread::start_thread::h2613204ce513782e [INFO] [stdout] at src/libstd/sys_common/thread.rs:13 [INFO] [stdout] 33: 0x559761b4f4d0 - std::sys::unix::thread::Thread::new::thread_start::h4570080769500bcd [INFO] [stdout] at src/libstd/sys/unix/thread.rs:79 [INFO] [stdout] 34: 0x7f63091f84a4 - start_thread [INFO] [stdout] 35: 0x7f6308d23d0f - __clone [INFO] [stdout] 36: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- worker_threads_should_be_reported stdout ---- [INFO] [stdout] thread 'worker_threads_should_be_reported' panicked at 'called `Result::unwrap()` on an `Err` value: "PoisonError { inner: .. }"', src/libcore/result.rs:999:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x559761b4d05b - backtrace::backtrace::libunwind::trace::hfe5db90796807973 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.29/src/backtrace/libunwind.rs:88 [INFO] [stdout] 1: 0x559761b4d05b - backtrace::backtrace::trace_unsynchronized::h34b865a835594335 [INFO] [stdout] at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.29/src/backtrace/mod.rs:66 [INFO] [stdout] 2: 0x559761b4d05b - std::sys_common::backtrace::_print::h527254ae44989167 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:47 [INFO] [stdout] 3: 0x559761b4d05b - std::sys_common::backtrace::print::he85dd5ddddf46503 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:36 [INFO] [stdout] 4: 0x559761b4d05b - std::panicking::default_hook::{{closure}}::h847a2eb38b396f14 [INFO] [stdout] at src/libstd/panicking.rs:200 [INFO] [stdout] 5: 0x559761b4ccca - std::panicking::default_hook::h2ca0f9a30a0e206b [INFO] [stdout] at src/libstd/panicking.rs:211 [INFO] [stdout] 6: 0x559761b4d7d0 - std::panicking::rust_panic_with_hook::hffcefc09751839d1 [INFO] [stdout] at src/libstd/panicking.rs:477 [INFO] [stdout] 7: 0x559761b4d352 - std::panicking::continue_panic_fmt::hc0f142c930c846fc [INFO] [stdout] at src/libstd/panicking.rs:384 [INFO] [stdout] 8: 0x559761b4d236 - rust_begin_unwind [INFO] [stdout] at src/libstd/panicking.rs:311 [INFO] [stdout] 9: 0x559761b63a8d - core::panicking::panic_fmt::h2daf88b2616ca2b2 [INFO] [stdout] at src/libcore/panicking.rs:85 [INFO] [stdout] 10: 0x559761b2019d - core::result::unwrap_failed::h188a046decb1bccc [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/macros.rs:18 [INFO] [stdout] 11: 0x559761b21282 - core::result::Result::unwrap::h17e244e114a2cd66 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/result.rs:800 [INFO] [stdout] 12: 0x559761b1a03b - loggy::before_test::hcf539c5ec4708994 [INFO] [stdout] at src/lib.rs:379 [INFO] [stdout] 13: 0x559761ad2dcd - test_log::worker_threads_should_be_reported::h42111def7a9527f2 [INFO] [stdout] at /opt/crater/workdir/<::loggy::test_loggy macros>:6 [INFO] [stdout] 14: 0x559761ad2daa - test_log::worker_threads_should_be_reported::{{closure}}::ha52e85f5a90feaf7 [INFO] [stdout] at /opt/crater/workdir/<::loggy::test_loggy macros>:5 [INFO] [stdout] 15: 0x559761ad681e - core::ops::function::FnOnce::call_once::hd887b6a0aa0c35aa [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/ops/function.rs:231 [INFO] [stdout] 16: 0x559761ae6bdf - as core::ops::function::FnOnce>::call_once::h4a13ee3f0d7b4201 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 17: 0x559761b4fe0a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:82 [INFO] [stdout] 18: 0x559761b011d8 - std::panicking::try::h5a93466ab2078586 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:275 [INFO] [stdout] 19: 0x559761b011d8 - std::panic::catch_unwind::h752cbeae6ac7bdea [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:394 [INFO] [stdout] 20: 0x559761b011d8 - test::run_test::run_test_inner::{{closure}}::h206c9c16936edaca [INFO] [stdout] at src/libtest/lib.rs:1466 [INFO] [stdout] 21: 0x559761adc055 - std::sys_common::backtrace::__rust_begin_short_backtrace::hc7edbac42990d270 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/sys_common/backtrace.rs:77 [INFO] [stdout] 22: 0x559761ae0115 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::he53c58e7adee87af [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/thread/mod.rs:470 [INFO] [stdout] 23: 0x559761ae0115 - as core::ops::function::FnOnce<()>>::call_once::h1aff7c42b6bb3726 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:315 [INFO] [stdout] 24: 0x559761ae0115 - std::panicking::try::do_call::h41f8559f88100f6c [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:296 [INFO] [stdout] 25: 0x559761b4fe0a - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:82 [INFO] [stdout] 26: 0x559761ae0812 - std::panicking::try::hb54ba808181fe352 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panicking.rs:275 [INFO] [stdout] 27: 0x559761ae0812 - std::panic::catch_unwind::h555ccf4e835e93f4 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/panic.rs:394 [INFO] [stdout] 28: 0x559761ae0812 - std::thread::Builder::spawn_unchecked::{{closure}}::hd4dae6e19e80fc1a [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libstd/thread/mod.rs:469 [INFO] [stdout] 29: 0x559761ae0812 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hc35d54c07710e1a1 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/libcore/ops/function.rs:231 [INFO] [stdout] 30: 0x559761b42d1f - as core::ops::function::FnOnce>::call_once::h42806b83647d4c79 [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 31: 0x559761b4f4d0 - as core::ops::function::FnOnce>::call_once::h83c921c8e826dd1d [INFO] [stdout] at /rustc/eae3437dfe991621e8afdc82734f4a172d7ddf9b/src/liballoc/boxed.rs:746 [INFO] [stdout] 32: 0x559761b4f4d0 - std::sys_common::thread::start_thread::h2613204ce513782e [INFO] [stdout] at src/libstd/sys_common/thread.rs:13 [INFO] [stdout] 33: 0x559761b4f4d0 - std::sys::unix::thread::Thread::new::thread_start::h4570080769500bcd [INFO] [stdout] at src/libstd/sys/unix/thread.rs:79 [INFO] [stdout] 34: 0x7f63091f84a4 - start_thread [INFO] [stdout] 35: 0x7f6308d23d0f - __clone [INFO] [stdout] 36: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] errors_should_be_counted [INFO] [stdout] info_should_be_captured [INFO] [stdout] multi_line_should_be_captured [INFO] [stdout] notice_should_be_captured [INFO] [stdout] notice_should_be_controlled [INFO] [stdout] warning_should_be_captured [INFO] [stdout] worker_threads_should_be_reported [INFO] [stdout] [INFO] [stdout] test result: FAILED. 2 passed; 7 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] running `"docker" "inspect" "845ae12cdbf1074229e72011b93262d4abafe8225777e24c7e932a812781e46b"` [INFO] running `"docker" "rm" "-f" "845ae12cdbf1074229e72011b93262d4abafe8225777e24c7e932a812781e46b"` [INFO] [stdout] 845ae12cdbf1074229e72011b93262d4abafe8225777e24c7e932a812781e46b