[INFO] fetching crate log_err 1.1.1... [INFO] testing log_err-1.1.1 against master#1ddedbaa5919b7b3e70d984660e21e844c615c97 for pr-128400 [INFO] extracting crate log_err 1.1.1 into /workspace/builds/worker-2-tc1/source [INFO] validating manifest of crates.io crate log_err 1.1.1 on toolchain 1ddedbaa5919b7b3e70d984660e21e844c615c97 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate log_err 1.1.1 [INFO] finished tweaking crates.io crate log_err 1.1.1 [INFO] tweaked toml for crates.io crate log_err 1.1.1 written to /workspace/builds/worker-2-tc1/source/Cargo.toml [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Locking 39 packages to latest compatible versions [INFO] [stderr] Adding simplelog v0.10.2 (latest: v0.12.2) [INFO] [stderr] Adding termcolor v1.1.3 (latest: v1.4.1) [INFO] [stderr] Adding windows-core v0.52.0 (latest: v0.58.0) [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded simplelog v0.10.2 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] d78aa603b08acf35e4617a93f31a8a71eede71584540ef79ae509d3c306aa44a [INFO] running `Command { std: "docker" "start" "-a" "d78aa603b08acf35e4617a93f31a8a71eede71584540ef79ae509d3c306aa44a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "d78aa603b08acf35e4617a93f31a8a71eede71584540ef79ae509d3c306aa44a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "d78aa603b08acf35e4617a93f31a8a71eede71584540ef79ae509d3c306aa44a", kill_on_drop: false }` [INFO] [stdout] d78aa603b08acf35e4617a93f31a8a71eede71584540ef79ae509d3c306aa44a [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] a1e9439b1165514e03b749b25877b63e58c28f52923399aa48b036718f4741bc [INFO] running `Command { std: "docker" "start" "-a" "a1e9439b1165514e03b749b25877b63e58c28f52923399aa48b036718f4741bc", kill_on_drop: false }` [INFO] [stderr] Compiling log v0.4.22 [INFO] [stderr] Compiling log_err v1.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.21s [INFO] running `Command { std: "docker" "inspect" "a1e9439b1165514e03b749b25877b63e58c28f52923399aa48b036718f4741bc", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a1e9439b1165514e03b749b25877b63e58c28f52923399aa48b036718f4741bc", kill_on_drop: false }` [INFO] [stdout] a1e9439b1165514e03b749b25877b63e58c28f52923399aa48b036718f4741bc [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] f843b9ff315cf15d891fbb10594c444b650b0954d95448d6bdc03e362ff15906 [INFO] running `Command { std: "docker" "start" "-a" "f843b9ff315cf15d891fbb10594c444b650b0954d95448d6bdc03e362ff15906", kill_on_drop: false }` [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling iana-time-zone v0.1.60 [INFO] [stderr] Compiling chrono v0.4.38 [INFO] [stderr] Compiling simplelog v0.10.2 [INFO] [stderr] Compiling log_err v1.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 2.80s [INFO] running `Command { std: "docker" "inspect" "f843b9ff315cf15d891fbb10594c444b650b0954d95448d6bdc03e362ff15906", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f843b9ff315cf15d891fbb10594c444b650b0954d95448d6bdc03e362ff15906", kill_on_drop: false }` [INFO] [stdout] f843b9ff315cf15d891fbb10594c444b650b0954d95448d6bdc03e362ff15906 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 28428c27b6976510cfb29f1527a7de3e2e8294dabc9a0d47c8f1947b458b3d6d [INFO] running `Command { std: "docker" "start" "-a" "28428c27b6976510cfb29f1527a7de3e2e8294dabc9a0d47c8f1947b458b3d6d", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/log_err-2439db0f40046fd9) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stderr] 15:19:30 [ERROR] called `Result::unwrap()` on an `Err` value: "a wild error has appeared!" [INFO] [stderr] 15:19:30 [ERROR] called `Option::unwrap()` on a `None` value [INFO] [stdout] test test::test_option_log_expect - should panic ... FAILED [INFO] [stdout] test test::test_log_unwrap - should panic ... ok [INFO] [stdout] test test::test_option_log_unwrap - should panic ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- test::test_option_log_expect stdout ---- [INFO] [stdout] thread 'test::test_option_log_expect' panicked at src/lib.rs:105:89: [INFO] [stdout] called `Result::unwrap()` on an `Err` value: SetLoggerError(()) [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x55ecbd428f25 - std::backtrace_rs::backtrace::libunwind::trace::hdfc9607bf31dbc86 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5 [INFO] [stdout] 1: 0x55ecbd428f25 - std::backtrace_rs::backtrace::trace_unsynchronized::h835e0ca3083fcb54 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x55ecbd428f25 - std::sys::backtrace::_print_fmt::hf81d1bed8dde1f05 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x55ecbd428f25 - ::fmt::h0e21387e4dc195e8 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x55ecbd4500bb - core::fmt::rt::Argument::fmt::hf0a2360aea19729b [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/core/src/fmt/rt.rs:173:76 [INFO] [stdout] 5: 0x55ecbd4500bb - core::fmt::write::h76a391ed15942408 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/core/src/fmt/mod.rs:1178:21 [INFO] [stdout] 6: 0x55ecbd42608f - std::io::Write::write_fmt::h3a6701c05eae4e21 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/io/mod.rs:1823:15 [INFO] [stdout] 7: 0x55ecbd42a741 - std::sys::backtrace::BacktraceLock::print::hfbac027926ddf935 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x55ecbd42a741 - std::panicking::default_hook::{{closure}}::h901010a60b64ccc3 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/panicking.rs:266:22 [INFO] [stdout] 9: 0x55ecbd42a2e8 - std::panicking::default_hook::had7425277af071c7 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/panicking.rs:290:9 [INFO] [stdout] 10: 0x55ecbd3a4f0a - as core::ops::function::Fn>::call::h0e74b18ddebb72fa [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/alloc/src/boxed.rs:2162:9 [INFO] [stdout] 11: 0x55ecbd3a4f0a - test::test_main::{{closure}}::he27b357a2172d646 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/test/src/lib.rs:132:21 [INFO] [stdout] 12: 0x55ecbd42b04f - as core::ops::function::Fn>::call::ha2e26086c015e62d [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/alloc/src/boxed.rs:2162:9 [INFO] [stdout] 13: 0x55ecbd42b04f - std::panicking::rust_panic_with_hook::hac0e92610e1e4d1b [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/panicking.rs:805:13 [INFO] [stdout] 14: 0x55ecbd42ac77 - std::panicking::begin_panic_handler::{{closure}}::h1fb6563ca25c0091 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/panicking.rs:671:13 [INFO] [stdout] 15: 0x55ecbd4293e9 - std::sys::backtrace::__rust_end_short_backtrace::he90d714ee124ec57 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/sys/backtrace.rs:170:18 [INFO] [stdout] 16: 0x55ecbd42a904 - rust_begin_unwind [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/panicking.rs:662:5 [INFO] [stdout] 17: 0x55ecbd44e9f3 - core::panicking::panic_fmt::h2c076b2ed9eeb82c [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/core/src/panicking.rs:74:14 [INFO] [stdout] 18: 0x55ecbd44ef06 - core::result::unwrap_failed::h0be6dd1a77884bef [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/core/src/result.rs:1679:5 [INFO] [stdout] 19: 0x55ecbd36d6e1 - core::result::Result::unwrap::h62d3d4e594b6f781 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/core/src/result.rs:1102:23 [INFO] [stdout] 20: 0x55ecbd36d6e1 - log_err::test::setup_logger::h2b31ea356113c939 [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:105:9 [INFO] [stdout] 21: 0x55ecbd36d7cf - log_err::test::test_option_log_expect::h73ccf06542bfaebb [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:119:36 [INFO] [stdout] 22: 0x55ecbd36d7a7 - log_err::test::test_option_log_expect::{{closure}}::ha8bb2e7acc684677 [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:118:33 [INFO] [stdout] 23: 0x55ecbd36cdf6 - core::ops::function::FnOnce::call_once::hc0a0805ad1ad1178 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 24: 0x55ecbd3a99db - core::ops::function::FnOnce::call_once::hca6bde12b6a630f1 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 25: 0x55ecbd3a99db - test::__rust_begin_short_backtrace::h12810d14a702ebbc [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/test/src/lib.rs:620:18 [INFO] [stdout] 26: 0x55ecbd3a92a5 - test::run_test_in_process::{{closure}}::h59541574124f7772 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/test/src/lib.rs:643:60 [INFO] [stdout] 27: 0x55ecbd3a92a5 - as core::ops::function::FnOnce<()>>::call_once::h21b81f6278222813 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 28: 0x55ecbd3a92a5 - std::panicking::try::do_call::h95caa0508e76e60a [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/panicking.rs:554:40 [INFO] [stdout] 29: 0x55ecbd3a92a5 - std::panicking::try::ha936e1facd3a2c2c [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/panicking.rs:518:19 [INFO] [stdout] 30: 0x55ecbd3a92a5 - std::panic::catch_unwind::h5528768c35d92b58 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/panic.rs:345:14 [INFO] [stdout] 31: 0x55ecbd3a92a5 - test::run_test_in_process::h90d0fae4cc0656ab [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/test/src/lib.rs:643:27 [INFO] [stdout] 32: 0x55ecbd3a92a5 - test::run_test::{{closure}}::hd832ed1086168438 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/test/src/lib.rs:564:43 [INFO] [stdout] 33: 0x55ecbd36eb74 - test::run_test::{{closure}}::h9fadb9f2ff3418ff [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/test/src/lib.rs:594:41 [INFO] [stdout] 34: 0x55ecbd36eb74 - std::sys::backtrace::__rust_begin_short_backtrace::h83762f6f2409a243 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/sys/backtrace.rs:154:18 [INFO] [stdout] 35: 0x55ecbd372342 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h30150ce916fdd544 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/thread/mod.rs:524:17 [INFO] [stdout] 36: 0x55ecbd372342 - as core::ops::function::FnOnce<()>>::call_once::hc325bc97006a5368 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 37: 0x55ecbd372342 - std::panicking::try::do_call::h3c463856408c67a4 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/panicking.rs:554:40 [INFO] [stdout] 38: 0x55ecbd372342 - std::panicking::try::h692f72559df6d3bf [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/panicking.rs:518:19 [INFO] [stdout] 39: 0x55ecbd372342 - std::panic::catch_unwind::h1dcc0ad4c36d774e [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/panic.rs:345:14 [INFO] [stdout] 40: 0x55ecbd372342 - std::thread::Builder::spawn_unchecked_::{{closure}}::hc95846b45d8ce7ce [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/thread/mod.rs:523:30 [INFO] [stdout] 41: 0x55ecbd372342 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h802463e6db21440a [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 42: 0x55ecbd42f48b - as core::ops::function::FnOnce>::call_once::h186f3f12fe64acb3 [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/alloc/src/boxed.rs:2148:9 [INFO] [stdout] 43: 0x55ecbd42f48b - as core::ops::function::FnOnce>::call_once::h58b0e3febdb462cc [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/alloc/src/boxed.rs:2148:9 [INFO] [stdout] 44: 0x55ecbd42f48b - std::sys::pal::unix::thread::Thread::new::thread_start::h146ca4d6d16f256f [INFO] [stdout] at /rustc/1ddedbaa5919b7b3e70d984660e21e844c615c97/library/std/src/sys/pal/unix/thread.rs:105:17 [INFO] [stdout] 45: 0x7fea5b4c9ac3 - [INFO] [stdout] 46: 0x7fea5b55aa04 - clone [INFO] [stdout] 47: 0x0 - [INFO] [stdout] note: panic did not contain expected string [INFO] [stdout] panic message: `"called `Result::unwrap()` on an `Err` value: SetLoggerError(())"`, [INFO] [stdout] expected substring: `"A wild error SHOULD appear"` [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] test::test_option_log_expect [INFO] [stdout] [INFO] [stdout] test result: FAILED. 2 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] running `Command { std: "docker" "inspect" "28428c27b6976510cfb29f1527a7de3e2e8294dabc9a0d47c8f1947b458b3d6d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "28428c27b6976510cfb29f1527a7de3e2e8294dabc9a0d47c8f1947b458b3d6d", kill_on_drop: false }` [INFO] [stdout] 28428c27b6976510cfb29f1527a7de3e2e8294dabc9a0d47c8f1947b458b3d6d [INFO] testing log_err-1.1.1 against try#33f1d8bb92813a1bfc23c093c9f443ab09290307 for pr-128400 [INFO] extracting crate log_err 1.1.1 into /workspace/builds/worker-2-tc2/source [INFO] validating manifest of crates.io crate log_err 1.1.1 on toolchain 33f1d8bb92813a1bfc23c093c9f443ab09290307 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33f1d8bb92813a1bfc23c093c9f443ab09290307" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate log_err 1.1.1 [INFO] finished tweaking crates.io crate log_err 1.1.1 [INFO] tweaked toml for crates.io crate log_err 1.1.1 written to /workspace/builds/worker-2-tc2/source/Cargo.toml [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33f1d8bb92813a1bfc23c093c9f443ab09290307" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Locking 39 packages to latest compatible versions [INFO] [stderr] Adding simplelog v0.10.2 (latest: v0.12.2) [INFO] [stderr] Adding termcolor v1.1.3 (latest: v1.4.1) [INFO] [stderr] Adding windows-core v0.52.0 (latest: v0.58.0) [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33f1d8bb92813a1bfc23c093c9f443ab09290307" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+33f1d8bb92813a1bfc23c093c9f443ab09290307" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] df415f35aa0296d19c2205c6c1769a5ac1f638f0527cd9f6fd56edccb7606444 [INFO] running `Command { std: "docker" "start" "-a" "df415f35aa0296d19c2205c6c1769a5ac1f638f0527cd9f6fd56edccb7606444", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "df415f35aa0296d19c2205c6c1769a5ac1f638f0527cd9f6fd56edccb7606444", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "df415f35aa0296d19c2205c6c1769a5ac1f638f0527cd9f6fd56edccb7606444", kill_on_drop: false }` [INFO] [stdout] df415f35aa0296d19c2205c6c1769a5ac1f638f0527cd9f6fd56edccb7606444 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+33f1d8bb92813a1bfc23c093c9f443ab09290307" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 41bfbc5b10e70eef541f31e1102706905cdb0ba5374fbb9d83f3ce43166dbed3 [INFO] running `Command { std: "docker" "start" "-a" "41bfbc5b10e70eef541f31e1102706905cdb0ba5374fbb9d83f3ce43166dbed3", kill_on_drop: false }` [INFO] [stderr] Compiling log v0.4.22 [INFO] [stderr] Compiling log_err v1.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.19s [INFO] running `Command { std: "docker" "inspect" "41bfbc5b10e70eef541f31e1102706905cdb0ba5374fbb9d83f3ce43166dbed3", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "41bfbc5b10e70eef541f31e1102706905cdb0ba5374fbb9d83f3ce43166dbed3", kill_on_drop: false }` [INFO] [stdout] 41bfbc5b10e70eef541f31e1102706905cdb0ba5374fbb9d83f3ce43166dbed3 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+33f1d8bb92813a1bfc23c093c9f443ab09290307" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 36e0f6f98138263baf94c375524fc9ddb1ee0116b1ddd155ac4c6f7f7d5d8be9 [INFO] running `Command { std: "docker" "start" "-a" "36e0f6f98138263baf94c375524fc9ddb1ee0116b1ddd155ac4c6f7f7d5d8be9", kill_on_drop: false }` [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling iana-time-zone v0.1.60 [INFO] [stderr] Compiling chrono v0.4.38 [INFO] [stderr] Compiling simplelog v0.10.2 [INFO] [stderr] Compiling log_err v1.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 2.60s [INFO] running `Command { std: "docker" "inspect" "36e0f6f98138263baf94c375524fc9ddb1ee0116b1ddd155ac4c6f7f7d5d8be9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "36e0f6f98138263baf94c375524fc9ddb1ee0116b1ddd155ac4c6f7f7d5d8be9", kill_on_drop: false }` [INFO] [stdout] 36e0f6f98138263baf94c375524fc9ddb1ee0116b1ddd155ac4c6f7f7d5d8be9 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+33f1d8bb92813a1bfc23c093c9f443ab09290307" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 98e79486bd816c072269567beef9a6bf36590ede5f20608e4bf74c4e271d615d [INFO] running `Command { std: "docker" "start" "-a" "98e79486bd816c072269567beef9a6bf36590ede5f20608e4bf74c4e271d615d", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/log_err-2439db0f40046fd9) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stderr] 15:19:42 [ERROR] called `Result::unwrap()` on an `Err` value: "a wild error has appeared!" [INFO] [stderr] 15:19:42 [ERROR] A wild error SHOULD appear [INFO] [stderr] 15:19:42 [ERROR] called `Option::unwrap()` on a `None` value [INFO] [stdout] test test::test_log_unwrap - should panic ... ok [INFO] [stdout] test test::test_option_log_expect - should panic ... ok [INFO] [stdout] test test::test_option_log_unwrap - should panic ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Doc-tests log_err [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test src/lib.rs - (line 8) ... ok [INFO] [stdout] test src/lib.rs - (line 17) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.17s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "98e79486bd816c072269567beef9a6bf36590ede5f20608e4bf74c4e271d615d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "98e79486bd816c072269567beef9a6bf36590ede5f20608e4bf74c4e271d615d", kill_on_drop: false }` [INFO] [stdout] 98e79486bd816c072269567beef9a6bf36590ede5f20608e4bf74c4e271d615d