[INFO] fetching crate debug_tree 0.4.0...
[INFO] testing debug_tree-0.4.0 against beta-2021-09-08 for beta-1.56-1
[INFO] extracting crate debug_tree 0.4.0 into /workspace/builds/worker-0/source
[INFO] validating manifest of crates.io crate debug_tree 0.4.0 on toolchain beta-2021-09-08
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate debug_tree 0.4.0
[INFO] finished tweaking crates.io crate debug_tree 0.4.0
[INFO] tweaked toml for crates.io crate debug_tree 0.4.0 written to /workspace/builds/worker-0/source/Cargo.toml
[INFO] crate crates.io crate debug_tree 0.4.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 020e424fcb7bcde54b504548de42bb1b248e984016ebf2fd0078778b7d1cab3d
[INFO] running `Command { std: "docker" "start" "-a" "020e424fcb7bcde54b504548de42bb1b248e984016ebf2fd0078778b7d1cab3d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "020e424fcb7bcde54b504548de42bb1b248e984016ebf2fd0078778b7d1cab3d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "020e424fcb7bcde54b504548de42bb1b248e984016ebf2fd0078778b7d1cab3d", kill_on_drop: false }`
[INFO] [stdout] 020e424fcb7bcde54b504548de42bb1b248e984016ebf2fd0078778b7d1cab3d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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=warn" "-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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] b5fc838c309c01b093e00eee6e2b8e80db38f91f6e650e2238654d06da8dd4e6
[INFO] running `Command { std: "docker" "start" "-a" "b5fc838c309c01b093e00eee6e2b8e80db38f91f6e650e2238654d06da8dd4e6", kill_on_drop: false }`
[INFO] [stderr]    Compiling debug_tree v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.37s
[INFO] running `Command { std: "docker" "inspect" "b5fc838c309c01b093e00eee6e2b8e80db38f91f6e650e2238654d06da8dd4e6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b5fc838c309c01b093e00eee6e2b8e80db38f91f6e650e2238654d06da8dd4e6", kill_on_drop: false }`
[INFO] [stdout] b5fc838c309c01b093e00eee6e2b8e80db38f91f6e650e2238654d06da8dd4e6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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=warn" "-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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ee532dab117a616eb55ba346ca4ffd45730d384b601e0927b6fe06c0a62df97e
[INFO] running `Command { std: "docker" "start" "-a" "ee532dab117a616eb55ba346ca4ffd45730d384b601e0927b6fe06c0a62df97e", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.9
[INFO] [stderr]    Compiling syn v1.0.16
[INFO] [stderr]    Compiling memchr v2.3.3
[INFO] [stderr]    Compiling proc-macro-nested v0.1.4
[INFO] [stderr]    Compiling futures-sink v0.3.4
[INFO] [stderr]    Compiling futures-core v0.3.4
[INFO] [stderr]    Compiling futures-io v0.3.4
[INFO] [stderr]    Compiling futures-task v0.3.4
[INFO] [stderr]    Compiling pin-utils v0.1.0-alpha.4
[INFO] [stderr]    Compiling pin-project-lite v0.1.4
[INFO] [stderr]    Compiling bytes v0.5.4
[INFO] [stderr]    Compiling futures-channel v0.3.4
[INFO] [stderr]    Compiling quote v1.0.3
[INFO] [stderr]    Compiling proc-macro-hack v0.5.12
[INFO] [stderr]    Compiling tokio-macros v0.2.5
[INFO] [stderr]    Compiling tokio v0.2.13
[INFO] [stderr]    Compiling futures-macro v0.3.4
[INFO] [stderr]    Compiling futures-util v0.3.4
[INFO] [stderr]    Compiling futures-executor v0.3.4
[INFO] [stderr]    Compiling futures v0.3.4
[INFO] [stderr]    Compiling debug_tree v0.4.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused imports: `max`, `min`
[INFO] [stdout]  --> src/test.rs:5:20
[INFO] [stdout]   |
[INFO] [stdout] 5 |     use std::cmp::{max, min};
[INFO] [stdout]   |                    ^^^  ^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 14.29s
[INFO] running `Command { std: "docker" "inspect" "ee532dab117a616eb55ba346ca4ffd45730d384b601e0927b6fe06c0a62df97e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ee532dab117a616eb55ba346ca4ffd45730d384b601e0927b6fe06c0a62df97e", kill_on_drop: false }`
[INFO] [stdout] ee532dab117a616eb55ba346ca4ffd45730d384b601e0927b6fe06c0a62df97e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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=warn" "-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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 4eb5bfa09629123a0f403ba0aa879271ec44bc8b088950c41cd333b26828acf9
[INFO] running `Command { std: "docker" "start" "-a" "4eb5bfa09629123a0f403ba0aa879271ec44bc8b088950c41cd333b26828acf9", kill_on_drop: false }`
[INFO] [stderr] warning: unused imports: `max`, `min`
[INFO] [stderr]  --> src/test.rs:5:20
[INFO] [stderr]   |
[INFO] [stderr] 5 |     use std::cmp::{max, min};
[INFO] [stderr]   |                    ^^^  ^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `debug_tree` (lib test) generated 1 warning
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/debug_tree-90483fdc36f05e47)
[INFO] [stdout] 
[INFO] [stdout] running 28 tests
[INFO] [stdout] test default::test::leaf_with_value ... ok
[INFO] [stdout] test default::test::named_branch ... ok
[INFO] [stdout] test default::test::unnamed_branch ... ok
[INFO] [stdout] test test::test::async_barrier ... ok
[INFO] [stdout] test test::test::depth ... ok
[INFO] [stdout] test test::test::enabled_output ... ok
[INFO] [stdout] test test::test::format_output_dashed ... ok
[INFO] [stdout] test test::test::disabled_output ... ok
[INFO] [stdout] test test::test::format_output_pipes ... ok
[INFO] [stdout] test test::test::format_output ... ok
[INFO] [stdout] test test::test::indent ... ok
[INFO] [stdout] test test::test::format_output_rounded ... ok
[INFO] [stdout] test test::test::leaf_with_value ... ok
[INFO] [stdout] test test::test::format_output_thick ... ok
[INFO] [stdout] test test::test::macros ... ok
[INFO] [stdout] test test::test::macros2 ... ok
[INFO] [stdout] test test::test::macros_with_fn ... ok
[INFO] [stdout] test test::test::mid ... ok
[INFO] [stdout] test test::test::nested ... ok
[INFO] [stdout] test test::test::simple ... ok
[INFO] [stdout] test test::test::test_branch ... ok
[INFO] [stdout] test test::test::recursive ... ok
[INFO] [stdout] test test::test::tree_by_name ... ok
[INFO] [stdout] test test::test::test_branch2 ... ok
[INFO] [stdout] test test::test::tree_by_name_disabled ... ok
[INFO] [stdout] test test::test::defer_peek_write_panic - should panic ... ok
[INFO] [stdout] test test::test::defer_peek_write ... FAILED
[INFO] [stdout] test test::test::defer_write ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test::test::defer_peek_write stdout ----
[INFO] [stdout] thread 'test::test::defer_peek_write' panicked at 'called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }', src/test.rs:359:59
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55edbee9848c - std::backtrace_rs::backtrace::libunwind::trace::h51faa62df48810e4
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x55edbee9848c - std::backtrace_rs::backtrace::trace_unsynchronized::h91de4d8e16d607e4
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55edbee9848c - std::sys_common::backtrace::_print_fmt::h71b0935f97e4322c
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55edbee9848c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h9a78218788c14e18
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x55edbeebbdbc - core::fmt::write::h3381b3176fe2b3d3
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/fmt/mod.rs:1150:17
[INFO] [stdout]    5:     0x55edbee94f55 - std::io::Write::write_fmt::hb6383f24fe197d3c
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/io/mod.rs:1667:15
[INFO] [stdout]    6:     0x55edbee9a190 - std::sys_common::backtrace::_print::h4b77abc4d907ed0e
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x55edbee9a190 - std::sys_common::backtrace::print::hb170c60b542377ad
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x55edbee9a190 - std::panicking::default_hook::{{closure}}::h12bbda9af8901ee3
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:210:50
[INFO] [stdout]    9:     0x55edbee99d82 - std::panicking::default_hook::h8c6c66d3f3ba6768
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:224:9
[INFO] [stdout]   10:     0x55edbee9a844 - std::panicking::rust_panic_with_hook::h36f2fa0bb09f4069
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:624:17
[INFO] [stdout]   11:     0x55edbee9a320 - std::panicking::begin_panic_handler::{{closure}}::h9c42b65a42d06a7a
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:521:13
[INFO] [stdout]   12:     0x55edbee98954 - std::sys_common::backtrace::__rust_end_short_backtrace::hc791bddfe31e532c
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x55edbee9a289 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:517:5
[INFO] [stdout]   14:     0x55edbede9661 - core::panicking::panic_fmt::hf9de31d4acbce4db
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/panicking.rs:101:14
[INFO] [stdout]   15:     0x55edbede9753 - core::result::unwrap_failed::ha0c84e81219e5878
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/result.rs:1617:5
[INFO] [stdout]   16:     0x55edbee0f60d - core::result::Result<T,E>::unwrap::h4a935c952bfb0d4e
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/result.rs:1299:23
[INFO] [stdout]   17:     0x55edbedf878f - debug_tree::test::test::defer_peek_write::h01b5c92ecdb9d067
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:359:13
[INFO] [stdout]   18:     0x55edbedf863a - debug_tree::test::test::defer_peek_write::{{closure}}::hf1c99a40c675ecf8
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:354:5
[INFO] [stdout]   19:     0x55edbee14b3e - core::ops::function::FnOnce::call_once::h2667aedd444891c1
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x55edbee6f963 - core::ops::function::FnOnce::call_once::h61555a204318cc58
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   21:     0x55edbee6f963 - test::__rust_begin_short_backtrace::h8331e7b1cc7a6e62
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/test/src/lib.rs:578:5
[INFO] [stdout]   22:     0x55edbee6e3e8 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h98582e597fa7f145
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/alloc/src/boxed.rs:1636:9
[INFO] [stdout]   23:     0x55edbee6e3e8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h38fa7a0826ecff45
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   24:     0x55edbee6e3e8 - std::panicking::try::do_call::h5b27d1cfffaa9f87
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:403:40
[INFO] [stdout]   25:     0x55edbee6e3e8 - std::panicking::try::h86f7124b3264bcbe
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:367:19
[INFO] [stdout]   26:     0x55edbee6e3e8 - std::panic::catch_unwind::h42dadf3598df7528
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panic.rs:129:14
[INFO] [stdout]   27:     0x55edbee6e3e8 - test::run_test_in_process::h9d4b7510f0910050
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/test/src/lib.rs:601:18
[INFO] [stdout]   28:     0x55edbee6e3e8 - test::run_test::run_test_inner::{{closure}}::h9b17f1fd181fe294
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/test/src/lib.rs:493:39
[INFO] [stdout]   29:     0x55edbee3bf3e - test::run_test::run_test_inner::{{closure}}::h476f9211dfec6075
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/test/src/lib.rs:520:37
[INFO] [stdout]   30:     0x55edbee3bf3e - std::sys_common::backtrace::__rust_begin_short_backtrace::h5c2db6945645950d
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stdout]   31:     0x55edbee407d8 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h791169ea9ba5492d
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/thread/mod.rs:481:17
[INFO] [stdout]   32:     0x55edbee407d8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::he930357ede3f4b4d
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   33:     0x55edbee407d8 - std::panicking::try::do_call::h0de4b1dd08a9aa80
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:403:40
[INFO] [stdout]   34:     0x55edbee407d8 - std::panicking::try::hf5b5c530df698d97
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:367:19
[INFO] [stdout]   35:     0x55edbee407d8 - std::panic::catch_unwind::hed97078f17dbf191
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panic.rs:129:14
[INFO] [stdout]   36:     0x55edbee407d8 - std::thread::Builder::spawn_unchecked::{{closure}}::h2e673950929cba93
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/thread/mod.rs:480:30
[INFO] [stdout]   37:     0x55edbee407d8 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h8e18ddd18a52f010
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   38:     0x55edbee9f993 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hbbbb32ef11ea0ad2
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/alloc/src/boxed.rs:1636:9
[INFO] [stdout]   39:     0x55edbee9f993 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h3b8ef23699fc5385
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/alloc/src/boxed.rs:1636:9
[INFO] [stdout]   40:     0x55edbee9f993 - std::sys::unix::thread::Thread::new::thread_start::ha57f5cba35f709b7
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/sys/unix/thread.rs:106:17
[INFO] [stdout]   41:     0x7ff7f78c8609 - start_thread
[INFO] [stdout]   42:     0x7ff7f769a293 - clone
[INFO] [stdout]   43:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test::test::defer_write stdout ----
[INFO] [stdout] thread 'test::test::defer_write' panicked at 'called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }', src/test.rs:340:54
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55edbee9848c - std::backtrace_rs::backtrace::libunwind::trace::h51faa62df48810e4
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x55edbee9848c - std::backtrace_rs::backtrace::trace_unsynchronized::h91de4d8e16d607e4
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55edbee9848c - std::sys_common::backtrace::_print_fmt::h71b0935f97e4322c
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55edbee9848c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h9a78218788c14e18
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x55edbeebbdbc - core::fmt::write::h3381b3176fe2b3d3
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/fmt/mod.rs:1150:17
[INFO] [stdout]    5:     0x55edbee94f55 - std::io::Write::write_fmt::hb6383f24fe197d3c
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/io/mod.rs:1667:15
[INFO] [stdout]    6:     0x55edbee9a190 - std::sys_common::backtrace::_print::h4b77abc4d907ed0e
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x55edbee9a190 - std::sys_common::backtrace::print::hb170c60b542377ad
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x55edbee9a190 - std::panicking::default_hook::{{closure}}::h12bbda9af8901ee3
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:210:50
[INFO] [stdout]    9:     0x55edbee99d82 - std::panicking::default_hook::h8c6c66d3f3ba6768
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:224:9
[INFO] [stdout]   10:     0x55edbee9a844 - std::panicking::rust_panic_with_hook::h36f2fa0bb09f4069
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:624:17
[INFO] [stdout]   11:     0x55edbee9a320 - std::panicking::begin_panic_handler::{{closure}}::h9c42b65a42d06a7a
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:521:13
[INFO] [stdout]   12:     0x55edbee98954 - std::sys_common::backtrace::__rust_end_short_backtrace::hc791bddfe31e532c
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x55edbee9a289 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:517:5
[INFO] [stdout]   14:     0x55edbede9661 - core::panicking::panic_fmt::hf9de31d4acbce4db
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/panicking.rs:101:14
[INFO] [stdout]   15:     0x55edbede9753 - core::result::unwrap_failed::ha0c84e81219e5878
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/result.rs:1617:5
[INFO] [stdout]   16:     0x55edbee0f60d - core::result::Result<T,E>::unwrap::h4a935c952bfb0d4e
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/result.rs:1299:23
[INFO] [stdout]   17:     0x55edbedf7e8f - debug_tree::test::test::defer_write::h7c2ff61e2073974e
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:340:13
[INFO] [stdout]   18:     0x55edbedf7d3a - debug_tree::test::test::defer_write::{{closure}}::hca93b9634b69a2d6
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:335:5
[INFO] [stdout]   19:     0x55edbee14abe - core::ops::function::FnOnce::call_once::h04ecf46beb4e161b
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x55edbee6f963 - core::ops::function::FnOnce::call_once::h61555a204318cc58
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   21:     0x55edbee6f963 - test::__rust_begin_short_backtrace::h8331e7b1cc7a6e62
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/test/src/lib.rs:578:5
[INFO] [stdout]   22:     0x55edbee6e3e8 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h98582e597fa7f145
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/alloc/src/boxed.rs:1636:9
[INFO] [stdout]   23:     0x55edbee6e3e8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h38fa7a0826ecff45
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   24:     0x55edbee6e3e8 - std::panicking::try::do_call::h5b27d1cfffaa9f87
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:403:40
[INFO] [stdout]   25:     0x55edbee6e3e8 - std::panicking::try::h86f7124b3264bcbe
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:367:19
[INFO] [stdout]   26:     0x55edbee6e3e8 - std::panic::catch_unwind::h42dadf3598df7528
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panic.rs:129:14
[INFO] [stdout]   27:     0x55edbee6e3e8 - test::run_test_in_process::h9d4b7510f0910050
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/test/src/lib.rs:601:18
[INFO] [stdout]   28:     0x55edbee6e3e8 - test::run_test::run_test_inner::{{closure}}::h9b17f1fd181fe294
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/test/src/lib.rs:493:39
[INFO] [stdout]   29:     0x55edbee3bf3e - test::run_test::run_test_inner::{{closure}}::h476f9211dfec6075
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/test/src/lib.rs:520:37
[INFO] [stdout]   30:     0x55edbee3bf3e - std::sys_common::backtrace::__rust_begin_short_backtrace::h5c2db6945645950d
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stdout]   31:     0x55edbee407d8 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h791169ea9ba5492d
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/thread/mod.rs:481:17
[INFO] [stdout]   32:     0x55edbee407d8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::he930357ede3f4b4d
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   33:     0x55edbee407d8 - std::panicking::try::do_call::h0de4b1dd08a9aa80
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:403:40
[INFO] [stdout]   34:     0x55edbee407d8 - std::panicking::try::hf5b5c530df698d97
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panicking.rs:367:19
[INFO] [stdout]   35:     0x55edbee407d8 - std::panic::catch_unwind::hed97078f17dbf191
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/panic.rs:129:14
[INFO] [stdout]   36:     0x55edbee407d8 - std::thread::Builder::spawn_unchecked::{{closure}}::h2e673950929cba93
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/thread/mod.rs:480:30
[INFO] [stdout]   37:     0x55edbee407d8 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h8e18ddd18a52f010
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   38:     0x55edbee9f993 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hbbbb32ef11ea0ad2
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/alloc/src/boxed.rs:1636:9
[INFO] [stdout]   39:     0x55edbee9f993 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h3b8ef23699fc5385
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/alloc/src/boxed.rs:1636:9
[INFO] [stdout]   40:     0x55edbee9f993 - std::sys::unix::thread::Thread::new::thread_start::ha57f5cba35f709b7
[INFO] [stdout]                                at /rustc/e784c962ea252f0874a4305168077e7048cb39e9/library/std/src/sys/unix/thread.rs:106:17
[INFO] [stdout]   41:     0x7ff7f78c8609 - start_thread
[INFO] [stdout]   42:     0x7ff7f769a293 - clone
[INFO] [stdout]   43:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test::test::defer_peek_write
[INFO] [stdout]     test::test::defer_write
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 26 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass '--lib'
[INFO] running `Command { std: "docker" "inspect" "4eb5bfa09629123a0f403ba0aa879271ec44bc8b088950c41cd333b26828acf9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4eb5bfa09629123a0f403ba0aa879271ec44bc8b088950c41cd333b26828acf9", kill_on_drop: false }`
[INFO] [stdout] 4eb5bfa09629123a0f403ba0aa879271ec44bc8b088950c41cd333b26828acf9