[INFO] fetching crate debug_tree 0.4.0...
[INFO] testing debug_tree-0.4.0 against master#cdb45c87e2cd43495379f7e867e3cc15dcee9f93 for pr-145838-1
[INFO] extracting crate debug_tree 0.4.0 into /workspace/builds/worker-5-tc1/source
[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-5-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate debug_tree 0.4.0 on toolchain cdb45c87e2cd43495379f7e867e3cc15dcee9f93
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate debug_tree 0.4.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 101296d9d0e36e0a2e8aafa0cab7d34561efc8126374c785526ef694f26abe7b
[INFO] running `Command { std: "docker" "start" "-a" "101296d9d0e36e0a2e8aafa0cab7d34561efc8126374c785526ef694f26abe7b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "101296d9d0e36e0a2e8aafa0cab7d34561efc8126374c785526ef694f26abe7b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "101296d9d0e36e0a2e8aafa0cab7d34561efc8126374c785526ef694f26abe7b", kill_on_drop: false }`
[INFO] [stdout] 101296d9d0e36e0a2e8aafa0cab7d34561efc8126374c785526ef694f26abe7b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 99d4b94a6c677f8a83f827696df5ed8bb137c9d1b7e484fbbc7e12fde4d07b72
[INFO] running `Command { std: "docker" "start" "-a" "99d4b94a6c677f8a83f827696df5ed8bb137c9d1b7e484fbbc7e12fde4d07b72", kill_on_drop: false }`
[INFO] [stderr]    Compiling once_cell v1.3.1
[INFO] [stderr]    Compiling debug_tree v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.76s
[INFO] running `Command { std: "docker" "inspect" "99d4b94a6c677f8a83f827696df5ed8bb137c9d1b7e484fbbc7e12fde4d07b72", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "99d4b94a6c677f8a83f827696df5ed8bb137c9d1b7e484fbbc7e12fde4d07b72", kill_on_drop: false }`
[INFO] [stdout] 99d4b94a6c677f8a83f827696df5ed8bb137c9d1b7e484fbbc7e12fde4d07b72
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2049a244d629d37fccfb30782b965e9cff5432fc187e77683f997ee66d2e291e
[INFO] running `Command { std: "docker" "start" "-a" "2049a244d629d37fccfb30782b965e9cff5432fc187e77683f997ee66d2e291e", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.9
[INFO] [stderr]    Compiling unicode-xid v0.2.0
[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-core v0.3.4
[INFO] [stderr]    Compiling futures-sink v0.3.4
[INFO] [stderr]    Compiling futures-task v0.3.4
[INFO] [stderr]    Compiling futures-io v0.3.4
[INFO] [stderr]    Compiling pin-utils v0.1.0-alpha.4
[INFO] [stderr]    Compiling slab v0.4.2
[INFO] [stderr]    Compiling bytes v0.5.4
[INFO] [stderr]    Compiling pin-project-lite v0.1.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` and `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)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 9.17s
[INFO] running `Command { std: "docker" "inspect" "2049a244d629d37fccfb30782b965e9cff5432fc187e77683f997ee66d2e291e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2049a244d629d37fccfb30782b965e9cff5432fc187e77683f997ee66d2e291e", kill_on_drop: false }`
[INFO] [stdout] 2049a244d629d37fccfb30782b965e9cff5432fc187e77683f997ee66d2e291e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] ac8fa2b2f9873bfe25758753f3518391552d7c2ea485d512bca11fb94fdaa430
[INFO] running `Command { std: "docker" "start" "-a" "ac8fa2b2f9873bfe25758753f3518391552d7c2ea485d512bca11fb94fdaa430", kill_on_drop: false }`
[INFO] [stderr] warning: unused imports: `max` and `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)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `debug_tree` (lib test) generated 1 warning (run `cargo fix --lib -p debug_tree --tests` to apply 1 suggestion)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/debug_tree-2ff60f3231efc179)
[INFO] [stdout] 
[INFO] [stdout] running 28 tests
[INFO] [stdout] test default::test::named_branch ... ok
[INFO] [stdout] test default::test::unnamed_branch ... ok
[INFO] [stdout] test default::test::leaf_with_value ... ok
[INFO] [stdout] test test::test::async_barrier ... ok
[INFO] [stdout] test test::test::depth ... ok
[INFO] [stdout] test test::test::disabled_output ... ok
[INFO] [stdout] test test::test::enabled_output ... ok
[INFO] [stdout] test test::test::format_output ... ok
[INFO] [stdout] test test::test::format_output_dashed ... ok
[INFO] [stdout] test test::test::format_output_rounded ... ok
[INFO] [stdout] test test::test::format_output_thick ... ok
[INFO] [stdout] test test::test::indent ... ok
[INFO] [stdout] test test::test::format_output_pipes ... ok
[INFO] [stdout] test test::test::leaf_with_value ... ok
[INFO] [stdout] test test::test::macros ... ok
[INFO] [stdout] test test::test::macros2 ... ok
[INFO] [stdout] test test::test::mid ... ok
[INFO] [stdout] test test::test::macros_with_fn ... ok
[INFO] [stdout] test test::test::recursive ... ok
[INFO] [stdout] test test::test::simple ... ok
[INFO] [stdout] test test::test::nested ... ok
[INFO] [stdout] test test::test::test_branch ... ok
[INFO] [stdout] test test::test::test_branch2 ... ok
[INFO] [stdout] test test::test::tree_by_name ... 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] 
[INFO] [stdout] thread 'test::test::defer_peek_write' (29) panicked at src/test.rs:359:59:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x62d2debccb72 - std::backtrace_rs::backtrace::libunwind::trace::h7cddb8376417e7cc
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x62d2debccb72 - std::backtrace_rs::backtrace::trace_unsynchronized::hb4e41acf4b349ff1
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x62d2debccb72 - std::sys::backtrace::_print_fmt::h1222b80910ba6eb5
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x62d2debccb72 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h5bb8a979ba5db788
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x62d2debdcebf - core::fmt::rt::Argument::fmt::h2ee2c138a50a7796
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/fmt/rt.rs:173:76
[INFO] [stdout]    5:     0x62d2debdcebf - core::fmt::write::h1e0dbf07fe3990bd
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/fmt/mod.rs:1468:25
[INFO] [stdout]    6:     0x62d2deb99e43 - std::io::default_write_fmt::h7d7ad5ed6a883d81
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x62d2deb99e43 - std::io::Write::write_fmt::hc477d9325b345ece
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/io/mod.rs:1954:13
[INFO] [stdout]    8:     0x62d2deba5fd2 - std::sys::backtrace::BacktraceLock::print::h788d486777205086
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    9:     0x62d2debaabbf - std::panicking::default_hook::{{closure}}::ha7bdfeb5949fc0fa
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:301:27
[INFO] [stdout]   10:     0x62d2debaaa51 - std::panicking::default_hook::h6dad75ec721846f4
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:325:9
[INFO] [stdout]   11:     0x62d2deb67a0e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h33799d04b0b96146
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/alloc/src/boxed.rs:1999:9
[INFO] [stdout]   12:     0x62d2deb67a0e - test::test_main_with_exit_callback::{{closure}}::h880e31c829a2eb5d
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x62d2debab25e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h5e1b8c652ea49180
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/alloc/src/boxed.rs:1999:9
[INFO] [stdout]   14:     0x62d2debab25e - std::panicking::panic_with_hook::hba00e869ada17676
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:842:13
[INFO] [stdout]   15:     0x62d2debab02a - std::panicking::panic_handler::{{closure}}::h3d21149c258e5ceb
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:707:13
[INFO] [stdout]   16:     0x62d2deba6109 - std::sys::backtrace::__rust_end_short_backtrace::h4f5d9b9dfb3e6ec1
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/backtrace.rs:174:18
[INFO] [stdout]   17:     0x62d2deb8d43d - __rustc[9a7a9f9af7564de1]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:698:5
[INFO] [stdout]   18:     0x62d2debe4960 - core::panicking::panic_fmt::h78e817a90331d98b
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/panicking.rs:75:14
[INFO] [stdout]   19:     0x62d2debe3f96 - core::result::unwrap_failed::h3ce108722ad88f1e
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/result.rs:1852:5
[INFO] [stdout]   20:     0x62d2deb18fd5 - core::result::Result<T,E>::unwrap::hc038e9f89bdc6f37
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/result.rs:1223:23
[INFO] [stdout]   21:     0x62d2deb18fd5 - debug_tree::test::test::defer_peek_write::h020a2e3cd554370c
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:359:59
[INFO] [stdout]   22:     0x62d2deb19807 - debug_tree::test::test::defer_peek_write::{{closure}}::hd6d934820dae43de
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:354:26
[INFO] [stdout]   23:     0x62d2deb2d6e6 - core::ops::function::FnOnce::call_once::h9becccbaf7db0c03
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/ops/function.rs:253:5
[INFO] [stdout]   24:     0x62d2deb6780b - core::ops::function::FnOnce::call_once::h7f4b4fba903e39d5
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/ops/function.rs:253:5
[INFO] [stdout]   25:     0x62d2deb6780b - test::__rust_begin_short_backtrace::h9277cb6a2ccfc000
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x62d2deb7d2b5 - test::run_test_in_process::{{closure}}::h9aea5ca90d1f4423
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x62d2deb7d2b5 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h364f5fe6cc8afa85
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x62d2deb7d2b5 - std::panicking::catch_unwind::do_call::h2b2bec3317fe53ec
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:590:40
[INFO] [stdout]   29:     0x62d2deb7d2b5 - std::panicking::catch_unwind::hc3763734156da4af
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:553:19
[INFO] [stdout]   30:     0x62d2deb7d2b5 - std::panic::catch_unwind::h28038391e867eabc
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x62d2deb7d2b5 - test::run_test_in_process::had0273166695a036
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x62d2deb7d2b5 - test::run_test::{{closure}}::h743d09d4bb476605
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x62d2deb53cd4 - test::run_test::{{closure}}::he950b8f9118d37e2
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x62d2deb53cd4 - std::sys::backtrace::__rust_begin_short_backtrace::hbfaffa6539f6abb7
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/backtrace.rs:158:18
[INFO] [stdout]   35:     0x62d2deb575ba - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hcce3c2c65b9c3b20
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/thread/mod.rs:559:17
[INFO] [stdout]   36:     0x62d2deb575ba - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb66b30b6d37985a5
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x62d2deb575ba - std::panicking::catch_unwind::do_call::h992bbe2c32dc1d79
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:590:40
[INFO] [stdout]   38:     0x62d2deb575ba - std::panicking::catch_unwind::h412991d5237de610
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:553:19
[INFO] [stdout]   39:     0x62d2deb575ba - std::panic::catch_unwind::ha82b139b3eb5840a
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x62d2deb575ba - std::thread::Builder::spawn_unchecked_::{{closure}}::ha823b36f5114938e
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/thread/mod.rs:557:30
[INFO] [stdout]   41:     0x62d2deb575ba - core::ops::function::FnOnce::call_once{{vtable.shim}}::hf120e7b1db22ac07
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/ops/function.rs:253:5
[INFO] [stdout]   42:     0x62d2deba009f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h3e049222c99298ac
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/alloc/src/boxed.rs:1985:9
[INFO] [stdout]   43:     0x62d2deba009f - std::sys::pal::unix::thread::Thread::new::thread_start::h942e336943ad5963
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/pal/unix/thread.rs:118:17
[INFO] [stdout]   44:     0x7baf88ce4aa4 - <unknown>
[INFO] [stdout]   45:     0x7baf88d71a34 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test::test::defer_write stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test::test::defer_write' (31) panicked at src/test.rs:340:54:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x62d2debccb72 - std::backtrace_rs::backtrace::libunwind::trace::h7cddb8376417e7cc
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x62d2debccb72 - std::backtrace_rs::backtrace::trace_unsynchronized::hb4e41acf4b349ff1
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x62d2debccb72 - std::sys::backtrace::_print_fmt::h1222b80910ba6eb5
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x62d2debccb72 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h5bb8a979ba5db788
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x62d2debdcebf - core::fmt::rt::Argument::fmt::h2ee2c138a50a7796
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/fmt/rt.rs:173:76
[INFO] [stdout]    5:     0x62d2debdcebf - core::fmt::write::h1e0dbf07fe3990bd
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/fmt/mod.rs:1468:25
[INFO] [stdout]    6:     0x62d2deb99e43 - std::io::default_write_fmt::h7d7ad5ed6a883d81
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x62d2deb99e43 - std::io::Write::write_fmt::hc477d9325b345ece
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/io/mod.rs:1954:13
[INFO] [stdout]    8:     0x62d2deba5fd2 - std::sys::backtrace::BacktraceLock::print::h788d486777205086
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    9:     0x62d2debaabbf - std::panicking::default_hook::{{closure}}::ha7bdfeb5949fc0fa
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:301:27
[INFO] [stdout]   10:     0x62d2debaaa51 - std::panicking::default_hook::h6dad75ec721846f4
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:325:9
[INFO] [stdout]   11:     0x62d2deb67a0e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h33799d04b0b96146
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/alloc/src/boxed.rs:1999:9
[INFO] [stdout]   12:     0x62d2deb67a0e - test::test_main_with_exit_callback::{{closure}}::h880e31c829a2eb5d
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x62d2debab25e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h5e1b8c652ea49180
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/alloc/src/boxed.rs:1999:9
[INFO] [stdout]   14:     0x62d2debab25e - std::panicking::panic_with_hook::hba00e869ada17676
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:842:13
[INFO] [stdout]   15:     0x62d2debab02a - std::panicking::panic_handler::{{closure}}::h3d21149c258e5ceb
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:707:13
[INFO] [stdout]   16:     0x62d2deba6109 - std::sys::backtrace::__rust_end_short_backtrace::h4f5d9b9dfb3e6ec1
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/backtrace.rs:174:18
[INFO] [stdout]   17:     0x62d2deb8d43d - __rustc[9a7a9f9af7564de1]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:698:5
[INFO] [stdout]   18:     0x62d2debe4960 - core::panicking::panic_fmt::h78e817a90331d98b
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/panicking.rs:75:14
[INFO] [stdout]   19:     0x62d2debe3f96 - core::result::unwrap_failed::h3ce108722ad88f1e
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/result.rs:1852:5
[INFO] [stdout]   20:     0x62d2deb13a95 - core::result::Result<T,E>::unwrap::hc038e9f89bdc6f37
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/result.rs:1223:23
[INFO] [stdout]   21:     0x62d2deb13a95 - debug_tree::test::test::defer_write::hb3480ffa143a40b9
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:340:54
[INFO] [stdout]   22:     0x62d2deb142c7 - debug_tree::test::test::defer_write::{{closure}}::he736ccd5a4906818
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:335:21
[INFO] [stdout]   23:     0x62d2deb2d326 - core::ops::function::FnOnce::call_once::h23fb90c0082a9345
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/ops/function.rs:253:5
[INFO] [stdout]   24:     0x62d2deb6780b - core::ops::function::FnOnce::call_once::h7f4b4fba903e39d5
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/ops/function.rs:253:5
[INFO] [stdout]   25:     0x62d2deb6780b - test::__rust_begin_short_backtrace::h9277cb6a2ccfc000
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x62d2deb7d2b5 - test::run_test_in_process::{{closure}}::h9aea5ca90d1f4423
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x62d2deb7d2b5 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h364f5fe6cc8afa85
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x62d2deb7d2b5 - std::panicking::catch_unwind::do_call::h2b2bec3317fe53ec
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:590:40
[INFO] [stdout]   29:     0x62d2deb7d2b5 - std::panicking::catch_unwind::hc3763734156da4af
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:553:19
[INFO] [stdout]   30:     0x62d2deb7d2b5 - std::panic::catch_unwind::h28038391e867eabc
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x62d2deb7d2b5 - test::run_test_in_process::had0273166695a036
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x62d2deb7d2b5 - test::run_test::{{closure}}::h743d09d4bb476605
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x62d2deb53cd4 - test::run_test::{{closure}}::he950b8f9118d37e2
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x62d2deb53cd4 - std::sys::backtrace::__rust_begin_short_backtrace::hbfaffa6539f6abb7
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/backtrace.rs:158:18
[INFO] [stdout]   35:     0x62d2deb575ba - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hcce3c2c65b9c3b20
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/thread/mod.rs:559:17
[INFO] [stdout]   36:     0x62d2deb575ba - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb66b30b6d37985a5
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x62d2deb575ba - std::panicking::catch_unwind::do_call::h992bbe2c32dc1d79
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:590:40
[INFO] [stdout]   38:     0x62d2deb575ba - std::panicking::catch_unwind::h412991d5237de610
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panicking.rs:553:19
[INFO] [stdout]   39:     0x62d2deb575ba - std::panic::catch_unwind::ha82b139b3eb5840a
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x62d2deb575ba - std::thread::Builder::spawn_unchecked_::{{closure}}::ha823b36f5114938e
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/thread/mod.rs:557:30
[INFO] [stdout]   41:     0x62d2deb575ba - core::ops::function::FnOnce::call_once{{vtable.shim}}::hf120e7b1db22ac07
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/core/src/ops/function.rs:253:5
[INFO] [stdout]   42:     0x62d2deba009f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h3e049222c99298ac
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/alloc/src/boxed.rs:1985:9
[INFO] [stdout]   43:     0x62d2deba009f - std::sys::pal::unix::thread::Thread::new::thread_start::h942e336943ad5963
[INFO] [stdout]                                at /rustc/cdb45c87e2cd43495379f7e867e3cc15dcee9f93/library/std/src/sys/pal/unix/thread.rs:118:17
[INFO] [stdout]   44:     0x7baf88ce4aa4 - <unknown>
[INFO] [stdout]   45:     0x7baf88d71a34 - clone
[INFO] [stdout]   46:                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.02s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "ac8fa2b2f9873bfe25758753f3518391552d7c2ea485d512bca11fb94fdaa430", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ac8fa2b2f9873bfe25758753f3518391552d7c2ea485d512bca11fb94fdaa430", kill_on_drop: false }`
[INFO] [stdout] ac8fa2b2f9873bfe25758753f3518391552d7c2ea485d512bca11fb94fdaa430