[INFO] fetching crate log4rs 1.0.0-alpha-2...
[INFO] testing log4rs-1.0.0-alpha-2 against beta-2020-10-09 for beta-1.48-1
[INFO] extracting crate log4rs 1.0.0-alpha-2 into /workspace/builds/worker-12/source
[INFO] validating manifest of crates.io crate log4rs 1.0.0-alpha-2 on toolchain beta-2020-10-09
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-10-09" "read-manifest" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] started tweaking crates.io crate log4rs 1.0.0-alpha-2
[INFO] removed 0 missing examples
[INFO] finished tweaking crates.io crate log4rs 1.0.0-alpha-2
[INFO] tweaked toml for crates.io crate log4rs 1.0.0-alpha-2 written to /workspace/builds/worker-12/source/Cargo.toml
[INFO] crate crates.io crate log4rs 1.0.0-alpha-2 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-10-09" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded ordered-float v2.0.0
[INFO] [stderr]   Downloaded humantime v2.0.1
[INFO] [stderr]   Downloaded streaming-stats v0.2.3
[INFO] [stderr]   Downloaded serde-value v0.7.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] cfd8cd5e5aaa81afb4a94e7d7a3b1664aa816cb3b80913dd9cf5c034fc74cd96
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "cfd8cd5e5aaa81afb4a94e7d7a3b1664aa816cb3b80913dd9cf5c034fc74cd96", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "cfd8cd5e5aaa81afb4a94e7d7a3b1664aa816cb3b80913dd9cf5c034fc74cd96", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cfd8cd5e5aaa81afb4a94e7d7a3b1664aa816cb3b80913dd9cf5c034fc74cd96", kill_on_drop: false }`
[INFO] [stdout] cfd8cd5e5aaa81afb4a94e7d7a3b1664aa816cb3b80913dd9cf5c034fc74cd96
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c195e14cbb7988f223a4d57e8204e451bbca54b91e6fe8a3c521aa7bb5b5f97f
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "c195e14cbb7988f223a4d57e8204e451bbca54b91e6fe8a3c521aa7bb5b5f97f", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.19
[INFO] [stderr]    Compiling syn v1.0.35
[INFO] [stderr]    Compiling autocfg v1.0.0
[INFO] [stderr]    Compiling serde_derive v1.0.114
[INFO] [stderr]    Compiling libc v0.2.73
[INFO] [stderr]    Compiling serde v1.0.114
[INFO] [stderr]    Compiling ryu v1.0.5
[INFO] [stderr]    Compiling serde_json v1.0.56
[INFO] [stderr]    Compiling anyhow v1.0.31
[INFO] [stderr]    Compiling instant v0.1.6
[INFO] [stderr]    Compiling traitobject v0.1.0
[INFO] [stderr]    Compiling linked-hash-map v0.5.3
[INFO] [stderr]    Compiling smallvec v1.4.1
[INFO] [stderr]    Compiling log v0.4.11
[INFO] [stderr]    Compiling itoa v0.4.6
[INFO] [stderr]    Compiling dtoa v0.4.6
[INFO] [stderr]    Compiling regex-syntax v0.6.18
[INFO] [stderr]    Compiling log-mdc v0.1.0
[INFO] [stderr]    Compiling humantime v2.0.1
[INFO] [stderr]    Compiling arc-swap v0.4.7
[INFO] [stderr]    Compiling lock_api v0.4.1
[INFO] [stderr]    Compiling unsafe-any v0.4.2
[INFO] [stderr]    Compiling yaml-rust v0.4.4
[INFO] [stderr]    Compiling typemap v0.3.3
[INFO] [stderr]    Compiling aho-corasick v0.7.13
[INFO] [stderr]    Compiling num-traits v0.2.12
[INFO] [stderr]    Compiling num-integer v0.1.43
[INFO] [stderr]    Compiling time v0.1.43
[INFO] [stderr]    Compiling parking_lot_core v0.8.0
[INFO] [stderr]    Compiling thread-id v3.3.0
[INFO] [stderr]    Compiling quote v1.0.7
[INFO] [stderr]    Compiling parking_lot v0.11.0
[INFO] [stderr]    Compiling ordered-float v2.0.0
[INFO] [stderr]    Compiling chrono v0.4.13
[INFO] [stderr]    Compiling regex v1.3.9
[INFO] [stderr]    Compiling thiserror-impl v1.0.20
[INFO] [stderr]    Compiling derivative v2.1.1
[INFO] [stderr]    Compiling thiserror v1.0.20
[INFO] [stderr]    Compiling serde-value v0.7.0
[INFO] [stderr]    Compiling serde_yaml v0.8.13
[INFO] [stderr]    Compiling log4rs v1.0.0-alpha-2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 05s
[INFO] running `Command { std: "docker" "inspect" "c195e14cbb7988f223a4d57e8204e451bbca54b91e6fe8a3c521aa7bb5b5f97f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c195e14cbb7988f223a4d57e8204e451bbca54b91e6fe8a3c521aa7bb5b5f97f", kill_on_drop: false }`
[INFO] [stdout] c195e14cbb7988f223a4d57e8204e451bbca54b91e6fe8a3c521aa7bb5b5f97f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] fa3833bbc3bed9260153c8151e67f48c27f52e34787f6aa7efe8565a9a56cd91
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "fa3833bbc3bed9260153c8151e67f48c27f52e34787f6aa7efe8565a9a56cd91", kill_on_drop: false }`
[INFO] [stderr]    Compiling ppv-lite86 v0.2.8
[INFO] [stderr]    Compiling remove_dir_all v0.5.3
[INFO] [stderr]    Compiling getrandom v0.1.14
[INFO] [stderr]    Compiling streaming-stats v0.2.3
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling tempfile v3.1.0
[INFO] [stderr]    Compiling log4rs v1.0.0-alpha-2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 10.17s
[INFO] running `Command { std: "docker" "inspect" "fa3833bbc3bed9260153c8151e67f48c27f52e34787f6aa7efe8565a9a56cd91", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fa3833bbc3bed9260153c8151e67f48c27f52e34787f6aa7efe8565a9a56cd91", kill_on_drop: false }`
[INFO] [stdout] fa3833bbc3bed9260153c8151e67f48c27f52e34787f6aa7efe8565a9a56cd91
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 09df5903926cf567103b2b409b9cb17a5c397d1322eedf99b8b2a357e23e7ad0
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "09df5903926cf567103b2b409b9cb17a5c397d1322eedf99b8b2a357e23e7ad0", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.60s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/log4rs-9a99b922d8da09b3
[INFO] [stdout] 
[INFO] [stdout] running 39 tests
[INFO] [stdout] test append::rolling_file::policy::compound::roll::fixed_window::test::create_archive_unvaried ... ok
[INFO] [stdout] test append::rolling_file::policy::compound::roll::fixed_window::test::create_archive_varied ... ok
[INFO] [stdout] test append::rolling_file::policy::compound::roll::fixed_window::test::supported_gzip ... ignored
[INFO] [stdout] test config::raw::test::empty ... ok
[INFO] [stdout] test config::runtime::test::check_logger_name ... ok
[INFO] [stdout] test append::rolling_file::policy::compound::roll::fixed_window::test::unsupported_gzip ... ok
[INFO] [stdout] test append::rolling_file::policy::compound::roll::fixed_window::test::rotation_no_trivial_base ... ok
[INFO] [stdout] test encode::pattern::tests::default_okay ... ok
[INFO] [stdout] test encode::pattern::tests::invalid_formatter ... ok
[INFO] [stdout] test append::rolling_file::policy::compound::roll::fixed_window::test::rotation ... ok
[INFO] [stdout] test encode::pattern::tests::custom_date_format ... ok
[INFO] [stdout] test encode::json::test::default ... ok
[INFO] [stdout] test encode::pattern::tests::escaped_chars ... ok
[INFO] [stdout] test encode::pattern::tests::mdc ... ok
[INFO] [stdout] test encode::pattern::tests::left_align_formatter ... ok
[INFO] [stdout] test encode::pattern::tests::mdc_missing_custom ... ok
[INFO] [stdout] test encode::pattern::tests::log ... ok
[INFO] [stdout] test encode::pattern::tests::process_id ... ok
[INFO] [stdout] test encode::pattern::tests::left_align ... ok
[INFO] [stdout] test encode::pattern::tests::right_align ... ok
[INFO] [stdout] test encode::pattern::tests::mdc_missing_default ... ok
[INFO] [stdout] test encode::pattern::tests::quote_braces_with_backslash ... ok
[INFO] [stdout] normal [0;31;44;1mstyled[0;32m styled2[0m normal
[INFO] [stdout] test encode::pattern::tests::right_align_formatter ... ok
[INFO] [stdout] test encode::pattern::tests::named_thread ... ok
[INFO] [stdout] test encode::pattern::tests::timezones ... ok
[INFO] [stdout] test encode::pattern::tests::unclosed_delimiter ... ok
[INFO] [stdout] test encode::writer::ansi::test::basic ... ok
[INFO] [stdout] test encode::pattern::tests::unescaped_parens ... ok
[INFO] [stdout] test encode::writer::console::test::basic ... ok
[INFO] [stdout] test test::enabled ... ok
[INFO] [stdout] test encode::pattern::tests::unnamed_thread ... ok
[INFO] [stdout] test encode::pattern::tests::thread_id_field ... ok
[INFO] [stdout] test append::file::test::create_directories ... ok
[INFO] [stdout] test append::file::test::append_false ... ok
[INFO] [stdout] test config::raw::test::full_deserialize ... ok
[INFO] [stderr] error: test failed, to rerun pass '--lib'
[INFO] [stdout] test append::test::expand_env_vars_tests ... FAILED
[INFO] [stdout] test append::rolling_file::test::append ... ok
[INFO] [stdout] test append::rolling_file::test::deserialize ... ok
[INFO] [stdout] test append::rolling_file::test::truncate ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- append::test::expand_env_vars_tests stdout ----
[INFO] [stdout] thread 'append::test::expand_env_vars_tests' panicked at 'called `Result::unwrap()` on an `Err` value: NotPresent', src/append/mod.rs:151:33
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55b26d39b320 - std::backtrace_rs::backtrace::libunwind::trace::h7cf3ca97bd83fbab
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/libunwind.rs:96
[INFO] [stdout]    1:     0x55b26d39b320 - std::backtrace_rs::backtrace::trace_unsynchronized::h5a69c674b2d9ea5c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/mod.rs:66
[INFO] [stdout]    2:     0x55b26d39b320 - std::sys_common::backtrace::_print_fmt::hdf72478dfcb50678
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:79
[INFO] [stdout]    3:     0x55b26d39b320 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h1e0bdbb35e83deca
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:58
[INFO] [stdout]    4:     0x55b26d3c131c - core::fmt::write::he67f9b17bcb7ee73
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/fmt/mod.rs:1080
[INFO] [stdout]    5:     0x55b26d2d7806 - std::io::Write::write_fmt::h68b2e5fe4c78e61a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/mod.rs:1516
[INFO] [stdout]    6:     0x55b26d394fbd - std::io::impls::<impl std::io::Write for alloc::boxed::Box<W>>::write_fmt::he9ebec865e28165c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/impls.rs:179
[INFO] [stdout]    7:     0x55b26d39dc9d - std::sys_common::backtrace::_print::haa20918e28a126c5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:61
[INFO] [stdout]    8:     0x55b26d39dc9d - std::sys_common::backtrace::print::h49e772a4873d9076
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:48
[INFO] [stdout]    9:     0x55b26d39dc9d - std::panicking::default_hook::{{closure}}::hb218b305d15e3f11
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:208
[INFO] [stdout]   10:     0x55b26d39d8f2 - std::panicking::default_hook::h63997b7b949e1ce0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:224
[INFO] [stdout]   11:     0x55b26d39e381 - std::panicking::rust_panic_with_hook::hb54f09ccadf64bd3
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:577
[INFO] [stdout]   12:     0x55b26d39df29 - std::panicking::begin_panic_handler::{{closure}}::h8b43445b254eeb30
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:484
[INFO] [stdout]   13:     0x55b26d39b7ac - std::sys_common::backtrace::__rust_end_short_backtrace::hacd691450edfeae0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:153
[INFO] [stdout]   14:     0x55b26d39dee9 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:483
[INFO] [stdout]   15:     0x55b26d3bfbf1 - core::panicking::panic_fmt::h5b17d4a0e853d0f5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/panicking.rs:85
[INFO] [stdout]   16:     0x55b26d3bfa13 - core::option::expect_none_failed::hd08bf36cae411fff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/option.rs:1234
[INFO] [stdout]   17:     0x55b26cf69440 - core::result::Result<T,E>::unwrap::ha2c51d811a6719aa
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/result.rs:973
[INFO] [stdout]   18:     0x55b26cfd7e35 - log4rs::append::test::expand_env_vars_tests::he9c82816d6b91982
[INFO] [stdout]                                at /opt/rustwide/workdir/src/append/mod.rs:151
[INFO] [stdout]   19:     0x55b26cfd73ca - log4rs::append::test::expand_env_vars_tests::{{closure}}::ha846bea841d74c2e
[INFO] [stdout]                                at /opt/rustwide/workdir/src/append/mod.rs:117
[INFO] [stdout]   20:     0x55b26cff112e - core::ops::function::FnOnce::call_once::h1062531ef1aff012
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   21:     0x55b26d2fe5f3 - core::ops::function::FnOnce::call_once::hcd3fa2f0696c1015
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   22:     0x55b26d2fe5f3 - test::__rust_begin_short_backtrace::h113f97c5e5ab7d4a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:516
[INFO] [stdout]   23:     0x55b26d2fcaf8 - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h01fd09163cae2442
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   24:     0x55b26d2fcaf8 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h0da6b685ae74a04a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   25:     0x55b26d2fcaf8 - std::panicking::try::do_call::h564a32f132f2c264
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   26:     0x55b26d2fcaf8 - std::panicking::try::h477cfd4b06a2e64a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   27:     0x55b26d2fcaf8 - std::panic::catch_unwind::hdb5abc6d008c399d
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   28:     0x55b26d2fcaf8 - test::run_test_in_process::he8ff7dec91b275be
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:543
[INFO] [stdout]   29:     0x55b26d2fcaf8 - test::run_test::run_test_inner::{{closure}}::hfd9f49e4a4ff9162
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:449
[INFO] [stdout]   30:     0x55b26d2d6b86 - std::sys_common::backtrace::__rust_begin_short_backtrace::hee6d60d5bb466aff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   31:     0x55b26d2dbcf5 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h988cecdf9ebbaf00
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]   32:     0x55b26d2dbcf5 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330cf727ec126982
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   33:     0x55b26d2dbcf5 - std::panicking::try::do_call::h6cd25078f4a5ea13
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   34:     0x55b26d2dbcf5 - std::panicking::try::h84b1d49961301705
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   35:     0x55b26d2dbcf5 - std::panic::catch_unwind::h6145324593b3654b
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   36:     0x55b26d2dbcf5 - std::thread::Builder::spawn_unchecked::{{closure}}::ha41e72e8024f9192
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]   37:     0x55b26d2dbcf5 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hfb5034cf1f1be223
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   38:     0x55b26d3a5f1a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::hd4d30e37db281e8f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   39:     0x55b26d3a5f1a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h019185a215ba16e4
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   40:     0x55b26d3a5f1a - std::sys::unix::thread::Thread::new::thread_start::h33c6d7cf25f9291f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   41:     0x7ff5e0f0f609 - start_thread
[INFO] [stdout]   42:     0x7ff5e119a103 - clone
[INFO] [stdout]   43:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     append::test::expand_env_vars_tests
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 37 passed; 1 failed; 1 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "09df5903926cf567103b2b409b9cb17a5c397d1322eedf99b8b2a357e23e7ad0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "09df5903926cf567103b2b409b9cb17a5c397d1322eedf99b8b2a357e23e7ad0", kill_on_drop: false }`
[INFO] [stdout] 09df5903926cf567103b2b409b9cb17a5c397d1322eedf99b8b2a357e23e7ad0
