[INFO] fetching crate tracing-bunyan-formatter 0.3.1...
[INFO] testing tracing-bunyan-formatter-0.3.1 against beta-2021-11-30 for beta-1.58-1
[INFO] extracting crate tracing-bunyan-formatter 0.3.1 into /workspace/builds/worker-4/source
[INFO] validating manifest of crates.io crate tracing-bunyan-formatter 0.3.1 on toolchain beta-2021-11-30
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-11-30" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate tracing-bunyan-formatter 0.3.1
[INFO] finished tweaking crates.io crate tracing-bunyan-formatter 0.3.1
[INFO] tweaked toml for crates.io crate tracing-bunyan-formatter 0.3.1 written to /workspace/builds/worker-4/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-11-30" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-11-30" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-11-30" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] c8c77f748c7be5ffd5700396dd4c52b6298f4849923e86267a183fd813ebc5ed
[INFO] running `Command { std: "docker" "start" "-a" "c8c77f748c7be5ffd5700396dd4c52b6298f4849923e86267a183fd813ebc5ed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c8c77f748c7be5ffd5700396dd4c52b6298f4849923e86267a183fd813ebc5ed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c8c77f748c7be5ffd5700396dd4c52b6298f4849923e86267a183fd813ebc5ed", kill_on_drop: false }`
[INFO] [stdout] c8c77f748c7be5ffd5700396dd4c52b6298f4849923e86267a183fd813ebc5ed
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-11-30" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 78de7aa5f6bf838a6c0d9b2298994c2cdb01708b951aaf516a9262a23bcdf442
[INFO] running `Command { std: "docker" "start" "-a" "78de7aa5f6bf838a6c0d9b2298994c2cdb01708b951aaf516a9262a23bcdf442", kill_on_drop: false }`
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling syn v1.0.82
[INFO] [stderr]    Compiling libc v0.2.109
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling serde v1.0.130
[INFO] [stderr]    Compiling ryu v1.0.6
[INFO] [stderr]    Compiling once_cell v1.8.0
[INFO] [stderr]    Compiling itoa v0.4.8
[INFO] [stderr]    Compiling serde_json v1.0.72
[INFO] [stderr]    Compiling pin-project-lite v0.2.7
[INFO] [stderr]    Compiling tracing-core v0.1.21
[INFO] [stderr]    Compiling sharded-slab v0.1.4
[INFO] [stderr]    Compiling thread_local v1.1.3
[INFO] [stderr]    Compiling tracing-subscriber v0.3.3
[INFO] [stderr]    Compiling tracing-log v0.1.2
[INFO] [stderr]    Compiling time v0.3.5
[INFO] [stderr]    Compiling gethostname v0.2.1
[INFO] [stderr]    Compiling tracing-attributes v0.1.18
[INFO] [stderr]    Compiling tracing v0.1.29
[INFO] [stderr]    Compiling tracing-bunyan-formatter v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 23.58s
[INFO] running `Command { std: "docker" "inspect" "78de7aa5f6bf838a6c0d9b2298994c2cdb01708b951aaf516a9262a23bcdf442", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "78de7aa5f6bf838a6c0d9b2298994c2cdb01708b951aaf516a9262a23bcdf442", kill_on_drop: false }`
[INFO] [stdout] 78de7aa5f6bf838a6c0d9b2298994c2cdb01708b951aaf516a9262a23bcdf442
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-11-30" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6badf66d1df12aded60e6c33952ce58d6b5550a77a3cbe61b990866af7933b83
[INFO] running `Command { std: "docker" "start" "-a" "6badf66d1df12aded60e6c33952ce58d6b5550a77a3cbe61b990866af7933b83", kill_on_drop: false }`
[INFO] [stderr]    Compiling tracing-bunyan-formatter v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.71s
[INFO] running `Command { std: "docker" "inspect" "6badf66d1df12aded60e6c33952ce58d6b5550a77a3cbe61b990866af7933b83", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6badf66d1df12aded60e6c33952ce58d6b5550a77a3cbe61b990866af7933b83", kill_on_drop: false }`
[INFO] [stdout] 6badf66d1df12aded60e6c33952ce58d6b5550a77a3cbe61b990866af7933b83
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-11-30" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 6bcfdb1413431c13954a9d6ba4fefeaca7ddbc9a402c8d9aa3eb945d639a9176
[INFO] running `Command { std: "docker" "start" "-a" "6bcfdb1413431c13954a9d6ba4fefeaca7ddbc9a402c8d9aa3eb945d639a9176", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/tracing_bunyan_formatter-2041d7250139a016)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/e2e.rs (/opt/rustwide/target/debug/deps/e2e-2c3ef2097b1b1c5e)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test each_line_is_valid_json ... ok
[INFO] [stdout] test each_line_has_the_mandatory_bunyan_fields ... ok
[INFO] [stdout] test elapsed_milliseconds_are_present_on_exit_span ... ok
[INFO] [stdout] test time_is_formatted_according_to_rfc_3339 ... ok
[INFO] [stdout] test parent_properties_are_propagated ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- parent_properties_are_propagated stdout ----
[INFO] [stdout] {"v":0,"name":"test","msg":"[SHAVING_YAKS - EVENT] pre-shaving yaks","level":30,"hostname":"6bcfdb141343","pid":10,"time":"2021-12-08T19:30:14.311677479Z","target":"e2e","line":53,"file":"tests/e2e.rs","a":2}
[INFO] [stdout] {"v":0,"name":"test","msg":"[CHILD_SPAN - START]","level":20,"hostname":"6bcfdb141343","pid":10,"time":"2021-12-08T19:30:14.311705899Z","target":"e2e","line":105,"file":"tests/e2e.rs","parent_property":2}
[INFO] [stdout] {"v":0,"name":"test","msg":"[INNER SHAVING - EVENT] shaving yaks","level":30,"hostname":"6bcfdb141343","pid":10,"time":"2021-12-08T19:30:14.311712719Z","target":"e2e","line":58,"file":"tests/e2e.rs","b":3,"a":2}
[INFO] [stdout] {"v":0,"name":"test","msg":"[CHILD_SPAN - EVENT] shaving yaks","level":30,"hostname":"6bcfdb141343","pid":10,"time":"2021-12-08T19:30:14.311769889Z","target":"e2e","line":108,"file":"tests/e2e.rs","parent_property":2}
[INFO] [stdout] {"v":0,"name":"test","msg":"[INNER SHAVING - START]","level":20,"hostname":"6bcfdb141343","pid":10,"time":"2021-12-08T19:30:14.311786249Z","target":"e2e","line":55,"file":"tests/e2e.rs","a":2,"b":3}
[INFO] [stdout] {"v":0,"name":"test","msg":"[INNER SHAVING - END]","level":20,"hostname":"6bcfdb141343","pid":10,"time":"2021-12-08T19:30:14.311794049Z","target":"e2e","line":55,"file":"tests/e2e.rs","b":3,"elapsed_milliseconds":0,"a":2}
[INFO] [stdout] {"v":0,"name":"test","msg":"[CHILD_SPAN - END]","level":20,"hostname":"6bcfdb141343","pid":10,"time":"2021-12-08T19:30:14.311826059Z","target":"e2e","line":105,"file":"tests/e2e.rs","elapsed_milliseconds":0,"parent_property":2}
[INFO] [stdout] {"v":0,"name":"test","msg":"[PARENT_SPAN - END]","level":20,"hostname":"6bcfdb141343","pid":10,"time":"2021-12-08T19:30:14.311881909Z","target":"e2e","line":102,"file":"tests/e2e.rs","elapsed_milliseconds":0,"parent_property":2}
[INFO] [stdout] {"v":0,"name":"test","msg":"[SHAVING_YAKS - END]","level":20,"hostname":"6bcfdb141343","pid":10,"time":"2021-12-08T19:30:14.311880929Z","target":"e2e","line":50,"file":"tests/e2e.rs","elapsed_milliseconds":0,"a":2}
[INFO] [stdout] {"v":0,"name":"test","msg":"[INNER SHAVING - EVENT] shaving yaks","level":30,"hostname":"6bcfdb141343","pid":10,"time":"2021-12-08T19:30:14.311886879Z","target":"e2e","line":58,"file":"tests/e2e.rs","a":2,"b":3}
[INFO] [stdout] thread 'parent_properties_are_propagated' panicked at 'assertion failed: record.get(\"parent_property\").is_some()', tests/e2e.rs:113:9
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55ece6b37c5c - std::backtrace_rs::backtrace::libunwind::trace::hc534939746d0ae42
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
[INFO] [stdout]    1:     0x55ece6b37c5c - std::backtrace_rs::backtrace::trace_unsynchronized::h6b8f882146644430
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55ece6b37c5c - std::sys_common::backtrace::_print_fmt::h178c3a343658778c
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55ece6b37c5c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h5321e7c94e7f76d6
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x55ece6b5b06c - core::fmt::write::h4177df205e3207df
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/core/src/fmt/mod.rs:1149:17
[INFO] [stdout]    5:     0x55ece6b33b55 - std::io::Write::write_fmt::h0f55d8f487d17094
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/io/mod.rs:1697:15
[INFO] [stdout]    6:     0x55ece6b39700 - std::sys_common::backtrace::_print::he542ad00850be793
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x55ece6b39700 - std::sys_common::backtrace::print::h8eef2bd9b56f47f2
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x55ece6b39700 - std::panicking::default_hook::{{closure}}::h8fb907b12ce9712e
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/panicking.rs:211:50
[INFO] [stdout]    9:     0x55ece6b392e6 - std::panicking::default_hook::ha5602a345e8a4e41
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/panicking.rs:225:9
[INFO] [stdout]   10:     0x55ece6b39db4 - std::panicking::rust_panic_with_hook::hf32fdbf39ade091f
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/panicking.rs:606:17
[INFO] [stdout]   11:     0x55ece6b39862 - std::panicking::begin_panic_handler::{{closure}}::h8b40c093e364b9b7
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/panicking.rs:500:13
[INFO] [stdout]   12:     0x55ece6b38104 - std::sys_common::backtrace::__rust_end_short_backtrace::h3ff630d901329a35
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/sys_common/backtrace.rs:139:18
[INFO] [stdout]   13:     0x55ece6b397f9 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/panicking.rs:498:5
[INFO] [stdout]   14:     0x55ece6a1d8f1 - core::panicking::panic_fmt::h74f9fec01e0efc2d
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/core/src/panicking.rs:107:14
[INFO] [stdout]   15:     0x55ece6a1d83d - core::panicking::panic::h14b34556179bc029
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/core/src/panicking.rs:48:5
[INFO] [stdout]   16:     0x55ece6a37115 - e2e::parent_properties_are_propagated::hbeb2e65568cdc495
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/e2e.rs:113:9
[INFO] [stdout]   17:     0x55ece6a36f7a - e2e::parent_properties_are_propagated::{{closure}}::h83cd7d522bdd3cfa
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/e2e.rs:100:1
[INFO] [stdout]   18:     0x55ece6a3c06e - core::ops::function::FnOnce::call_once::h8ba1681709edbf1b
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   19:     0x55ece6a7f453 - core::ops::function::FnOnce::call_once::h1efdf8831cbe553f
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x55ece6a7f453 - test::__rust_begin_short_backtrace::h0b35e710c36cd9a0
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/test/src/lib.rs:585:5
[INFO] [stdout]   21:     0x55ece6a7e067 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::he15cbd6a049610ef
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   22:     0x55ece6a7e067 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46f4118d12807366
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   23:     0x55ece6a7e067 - std::panicking::try::do_call::he72099bfb52eb35b
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/panicking.rs:406:40
[INFO] [stdout]   24:     0x55ece6a7e067 - std::panicking::try::h941266232d2749ab
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/panicking.rs:370:19
[INFO] [stdout]   25:     0x55ece6a7e067 - std::panic::catch_unwind::he5606b2d8a805991
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/panic.rs:133:14
[INFO] [stdout]   26:     0x55ece6a7e067 - test::run_test_in_process::h8c906b4487d1b96d
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/test/src/lib.rs:608:18
[INFO] [stdout]   27:     0x55ece6a7e067 - test::run_test::run_test_inner::{{closure}}::h37ad38432d9d5cfc
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/test/src/lib.rs:500:39
[INFO] [stdout]   28:     0x55ece6a4b52e - test::run_test::run_test_inner::{{closure}}::h75c29073a41e7ab8
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/test/src/lib.rs:527:37
[INFO] [stdout]   29:     0x55ece6a4b52e - std::sys_common::backtrace::__rust_begin_short_backtrace::hafbfa87e07910bba
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/sys_common/backtrace.rs:123:18
[INFO] [stdout]   30:     0x55ece6a50268 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h6a40b1642f9329e8
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/thread/mod.rs:484:17
[INFO] [stdout]   31:     0x55ece6a50268 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h570e68232d947237
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   32:     0x55ece6a50268 - std::panicking::try::do_call::hdaece62c2ee09687
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/panicking.rs:406:40
[INFO] [stdout]   33:     0x55ece6a50268 - std::panicking::try::h7d3a7a09dc9de3fa
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/panicking.rs:370:19
[INFO] [stdout]   34:     0x55ece6a50268 - std::panic::catch_unwind::h02b55809c8e4572f
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/panic.rs:133:14
[INFO] [stdout]   35:     0x55ece6a50268 - std::thread::Builder::spawn_unchecked::{{closure}}::h8a3286a479dd422d
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/thread/mod.rs:483:30
[INFO] [stdout]   36:     0x55ece6a50268 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h2636c127e92e3a74
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   37:     0x55ece6b3e843 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h992aa775811728ca
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   38:     0x55ece6b3e843 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h15f4030f59f40e4c
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/alloc/src/boxed.rs:1694:9
[INFO] [stdout]   39:     0x55ece6b3e843 - std::sys::unix::thread::Thread::new::thread_start::hd83e13d4fcd38086
[INFO] [stdout]                                at /rustc/426b94d7df183ac00ed4492541d92855181e9c4e/library/std/src/sys/unix/thread.rs:106:17
[INFO] [stdout]   40:     0x7ff6e7145609 - start_thread
[INFO] [stdout]   41:     0x7ff6e6f17293 - clone
[INFO] [stdout]   42:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     parent_properties_are_propagated
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 4 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass '--test e2e'
[INFO] running `Command { std: "docker" "inspect" "6bcfdb1413431c13954a9d6ba4fefeaca7ddbc9a402c8d9aa3eb945d639a9176", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6bcfdb1413431c13954a9d6ba4fefeaca7ddbc9a402c8d9aa3eb945d639a9176", kill_on_drop: false }`
[INFO] [stdout] 6bcfdb1413431c13954a9d6ba4fefeaca7ddbc9a402c8d9aa3eb945d639a9176