[INFO] fetching crate holochain_tracing_macros 0.0.24...
[INFO] testing holochain_tracing_macros-0.0.24 against try#ce59db7a1b1b012fb2793c4641c1bdecad7a128b for pr-85530
[INFO] extracting crate holochain_tracing_macros 0.0.24 into /workspace/builds/worker-2/source
[INFO] validating manifest of crates.io crate holochain_tracing_macros 0.0.24 on toolchain ce59db7a1b1b012fb2793c4641c1bdecad7a128b
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate holochain_tracing_macros 0.0.24
[INFO] finished tweaking crates.io crate holochain_tracing_macros 0.0.24
[INFO] tweaked toml for crates.io crate holochain_tracing_macros 0.0.24 written to /workspace/builds/worker-2/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded crossbeam-channel v0.3.8
[INFO] [stderr]   Downloaded holochain_tracing v0.0.24
[INFO] [stderr]   Downloaded opentelemetry v0.2.0
[INFO] [stderr]   Downloaded tracing v0.1.13
[INFO] [stderr]   Downloaded tracing-subscriber v0.2.3
[INFO] [stderr]   Downloaded thrift_codec v0.1.1
[INFO] [stderr]   Downloaded shrinkwraprs v0.3.0
[INFO] [stderr]   Downloaded tracing-serde v0.1.1
[INFO] [stderr]   Downloaded newrelic v0.2.2
[INFO] [stderr]   Downloaded prometheus v0.7.0
[INFO] [stderr]   Downloaded rustracing_jaeger v0.2.1
[INFO] [stderr]   Downloaded tracing-core v0.1.10
[INFO] [stderr]   Downloaded newrelic-sys v0.2.0
[INFO] [stderr]   Downloaded rustracing v0.2.1
[INFO] [stderr]   Downloaded chrono v0.4.6
[INFO] [stderr]   Downloaded tracing-log v0.1.1
[INFO] [stderr]   Downloaded thrift v0.13.0
[INFO] [stderr]   Downloaded sharded-slab v0.0.8
[INFO] [stderr]   Downloaded opentelemetry-jaeger v0.1.0
[INFO] [stderr]   Downloaded integer-encoding v1.1.7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] d4ed6eae28d146e45768f71467f7f3467549e2c04ab4fbf6355c63299dec1b33
[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" "d4ed6eae28d146e45768f71467f7f3467549e2c04ab4fbf6355c63299dec1b33", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d4ed6eae28d146e45768f71467f7f3467549e2c04ab4fbf6355c63299dec1b33", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d4ed6eae28d146e45768f71467f7f3467549e2c04ab4fbf6355c63299dec1b33", kill_on_drop: false }`
[INFO] [stdout] d4ed6eae28d146e45768f71467f7f3467549e2c04ab4fbf6355c63299dec1b33
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f45cfdb35e4b88ce2b7318624de4a49b6742410318eb8f1986bdc18ebd84eaa8
[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" "f45cfdb35e4b88ce2b7318624de4a49b6742410318eb8f1986bdc18ebd84eaa8", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling proc-macro2 v1.0.27
[INFO] [stderr]    Compiling syn v1.0.72
[INFO] [stderr]    Compiling libc v0.2.95
[INFO] [stderr]    Compiling rand_core v0.4.2
[INFO] [stderr]    Compiling getrandom v0.1.16
[INFO] [stderr]    Compiling memchr v2.4.0
[INFO] [stderr]    Compiling cfg-if v0.1.10
[INFO] [stderr]    Compiling serde v1.0.104
[INFO] [stderr]    Compiling ppv-lite86 v0.2.10
[INFO] [stderr]    Compiling cc v1.0.68
[INFO] [stderr]    Compiling pin-project-internal v0.4.28
[INFO] [stderr]    Compiling protobuf v2.23.0
[INFO] [stderr]    Compiling prometheus v0.7.0
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling spin v0.5.2
[INFO] [stderr]    Compiling bitflags v1.2.1
[INFO] [stderr]    Compiling quick-error v1.2.3
[INFO] [stderr]    Compiling either v1.6.1
[INFO] [stderr]    Compiling integer-encoding v1.1.7
[INFO] [stderr]    Compiling smallvec v1.6.1
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling miniz_oxide v0.4.4
[INFO] [stderr]    Compiling num-integer v0.1.44
[INFO] [stderr]    Compiling tracing-core v0.1.10
[INFO] [stderr]    Compiling regex-automata v0.1.10
[INFO] [stderr]    Compiling sharded-slab v0.0.8
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling crossbeam-utils v0.6.6
[INFO] [stderr]    Compiling rand_core v0.3.1
[INFO] [stderr]    Compiling rand_pcg v0.1.2
[INFO] [stderr]    Compiling rand_jitter v0.1.4
[INFO] [stderr]    Compiling rand_xorshift v0.1.1
[INFO] [stderr]    Compiling rand_hc v0.1.0
[INFO] [stderr]    Compiling rand_chacha v0.1.1
[INFO] [stderr]    Compiling rand_isaac v0.1.1
[INFO] [stderr]    Compiling itertools v0.8.2
[INFO] [stderr]    Compiling tracing-log v0.1.1
[INFO] [stderr]    Compiling crossbeam-channel v0.3.8
[INFO] [stderr]    Compiling object v0.25.2
[INFO] [stderr]    Compiling aho-corasick v0.7.18
[INFO] [stderr]    Compiling backtrace v0.3.60
[INFO] [stderr]    Compiling matchers v0.0.1
[INFO] [stderr]    Compiling quote v1.0.3
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling time v0.1.44
[INFO] [stderr]    Compiling rand_os v0.1.3
[INFO] [stderr]    Compiling hostname v0.1.5
[INFO] [stderr]    Compiling ordered-float v1.1.1
[INFO] [stderr]    Compiling rand v0.6.5
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling threadpool v1.8.1
[INFO] [stderr]    Compiling thrift v0.13.0
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling chrono v0.4.6
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling serde_derive v1.0.104
[INFO] [stderr]    Compiling trackable_derive v1.0.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.15
[INFO] [stderr]    Compiling shrinkwraprs v0.3.0
[INFO] [stderr]    Compiling tracing v0.1.13
[INFO] [stderr]    Compiling trackable v1.2.0
[INFO] [stderr]    Compiling trackable v0.2.24
[INFO] [stderr]    Compiling thrift_codec v0.1.1
[INFO] [stderr]    Compiling rustracing v0.2.1
[INFO] [stderr]    Compiling rustracing_jaeger v0.2.1
[INFO] [stderr]    Compiling pin-project v0.4.28
[INFO] [stderr]    Compiling bincode v1.3.3
[INFO] [stderr]    Compiling serde_json v1.0.47
[INFO] [stderr]    Compiling tracing-serde v0.1.1
[INFO] [stderr]    Compiling opentelemetry v0.2.0
[INFO] [stderr]    Compiling tracing-subscriber v0.2.3
[INFO] [stderr]    Compiling opentelemetry-jaeger v0.1.0
[INFO] [stderr]    Compiling holochain_tracing v0.0.24
[INFO] [stderr]    Compiling holochain_tracing_macros v0.0.24 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 59.87s
[INFO] running `Command { std: "docker" "inspect" "f45cfdb35e4b88ce2b7318624de4a49b6742410318eb8f1986bdc18ebd84eaa8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f45cfdb35e4b88ce2b7318624de4a49b6742410318eb8f1986bdc18ebd84eaa8", kill_on_drop: false }`
[INFO] [stdout] f45cfdb35e4b88ce2b7318624de4a49b6742410318eb8f1986bdc18ebd84eaa8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 476f6eca5af89e8ecf56fc2f27985b8d6909ae5b9626ee78aa58d682fe335cac
[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" "476f6eca5af89e8ecf56fc2f27985b8d6909ae5b9626ee78aa58d682fe335cac", kill_on_drop: false }`
[INFO] [stderr]    Compiling holochain_tracing_macros v0.0.24 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.08s
[INFO] running `Command { std: "docker" "inspect" "476f6eca5af89e8ecf56fc2f27985b8d6909ae5b9626ee78aa58d682fe335cac", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "476f6eca5af89e8ecf56fc2f27985b8d6909ae5b9626ee78aa58d682fe335cac", kill_on_drop: false }`
[INFO] [stdout] 476f6eca5af89e8ecf56fc2f27985b8d6909ae5b9626ee78aa58d682fe335cac
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 24b59f0b2dbd789845765485700ed6e3a41bcba511ee7ec05f3c32a2535b17f1
[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" "24b59f0b2dbd789845765485700ed6e3a41bcba511ee7ec05f3c32a2535b17f1", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.07s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/holochain_tracing_macros-a8fd41c71839a8e2)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/macros.rs (/opt/rustwide/target/debug/deps/macros-745a413f8593fdb0)
[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] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test function_attr ... FAILED
[INFO] [stdout] test module_attr ... FAILED
[INFO] [stdout] test here_test ... FAILED
[INFO] [stdout] test method_attr ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- function_attr stdout ----
[INFO] [stdout] thread 'function_attr' panicked at 'assertion failed: `(left == right)`
[INFO] [stdout]   left: `["c in tests/macros.rs:20 (auto:fn)", "b in tests/macros.rs:16 (auto:fn)", "a in tests/macros.rs:12 (auto:fn)", "root"]`,
[INFO] [stdout]  right: `["c in crates/tracing_macros/tests/macros.rs:20 (auto:fn)", "b in crates/tracing_macros/tests/macros.rs:16 (auto:fn)", "a in crates/tracing_macros/tests/macros.rs:12 (auto:fn)", "root"]`', tests/macros.rs:122:5
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55d467a52ec0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x55d467a52ec0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::trace_unsynchronized::<std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55d467a52ec0 - std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55d467a52ec0 - <std[77c0456e0eb29f0c]::sys_common::backtrace::_print::DisplayBacktrace as core[ee1ca6415511a9c4]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x55d467a7577c - core[ee1ca6415511a9c4]::fmt::write
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/fmt/mod.rs:1110:17
[INFO] [stdout]    5:     0x55d467a4fd25 - <alloc[cda43b294bbfc5d0]::vec::Vec<u8> as std[77c0456e0eb29f0c]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/io/mod.rs:1584:15
[INFO] [stdout]    6:     0x55d467a5504b - std[77c0456e0eb29f0c]::sys_common::backtrace::_print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x55d467a5504b - std[77c0456e0eb29f0c]::sys_common::backtrace::print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x55d467a5504b - std[77c0456e0eb29f0c]::panicking::default_hook::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:208:50
[INFO] [stdout]    9:     0x55d467a54b5c - std[77c0456e0eb29f0c]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:222:9
[INFO] [stdout]   10:     0x55d467a556f1 - std[77c0456e0eb29f0c]::panicking::rust_panic_with_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:622:17
[INFO] [stdout]   11:     0x55d467a551f7 - std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:519:13
[INFO] [stdout]   12:     0x55d467a533bc - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_end_short_backtrace::<std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x55d467a55159 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:515:5
[INFO] [stdout]   14:     0x55d467979541 - core[ee1ca6415511a9c4]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:92:14
[INFO] [stdout]   15:     0x55d467a74098 - core[ee1ca6415511a9c4]::panicking::assert_failed_inner
[INFO] [stdout]   16:     0x55d467980e9e - core[ee1ca6415511a9c4]::panicking::assert_failed::<alloc[cda43b294bbfc5d0]::vec::Vec<alloc[cda43b294bbfc5d0]::string::String>, alloc[cda43b294bbfc5d0]::vec::Vec<&str>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:117:5
[INFO] [stdout]   17:     0x55d4679845ee - macros[258bf99b73cd0b9b]::function_attr
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/macros.rs:122:5
[INFO] [stdout]   18:     0x55d4679840da - macros[258bf99b73cd0b9b]::function_attr::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/macros.rs:106:1
[INFO] [stdout]   19:     0x55d46798668e - <macros[258bf99b73cd0b9b]::function_attr::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x55d4679afaa3 - <fn() as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   21:     0x55d4679afaa3 - test[eeb9024d9ac7bc83]::__rust_begin_short_backtrace::<fn()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:577:5
[INFO] [stdout]   22:     0x55d4679ae56c - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   23:     0x55d4679ae56c - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   24:     0x55d4679ae56c - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   25:     0x55d4679ae56c - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   26:     0x55d4679ae56c - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   27:     0x55d4679ae56c - test[eeb9024d9ac7bc83]::run_test_in_process
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:600:18
[INFO] [stdout]   28:     0x55d4679ae56c - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:492:39
[INFO] [stdout]   29:     0x55d46798e232 - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:519:37
[INFO] [stdout]   30:     0x55d46798e232 - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_begin_short_backtrace::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stdout]   31:     0x55d46798eb18 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:481:17
[INFO] [stdout]   32:     0x55d46798eb18 - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   33:     0x55d46798eb18 - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   34:     0x55d46798eb18 - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   35:     0x55d46798eb18 - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   36:     0x55d46798eb18 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:480:30
[INFO] [stdout]   37:     0x55d46798eb18 - <<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   38:     0x55d467a5a227 - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   39:     0x55d467a5a227 - <alloc[cda43b294bbfc5d0]::boxed::Box<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   40:     0x55d467a5a227 - <std[77c0456e0eb29f0c]::sys::unix::thread::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys/unix/thread.rs:71:17
[INFO] [stdout]   41:     0x7f26c0524609 - start_thread
[INFO] [stdout]   42:     0x7f26c02f6293 - clone
[INFO] [stdout]   43:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- module_attr stdout ----
[INFO] [stdout] thread 'module_attr' panicked at 'assertion failed: `(left == right)`
[INFO] [stdout]   left: `["f in tests/macros.rs:56 (auto:fn)", "e in tests/macros.rs:53 (auto:fn)", "d in tests/macros.rs:49 (auto:fn)", "root"]`,
[INFO] [stdout]  right: `["f in crates/tracing_macros/tests/macros.rs:56 (auto:fn)", "e in crates/tracing_macros/tests/macros.rs:53 (auto:fn)", "d in crates/tracing_macros/tests/macros.rs:49 (auto:fn)", "root"]`', tests/macros.rs:155:5
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55d467a52ec0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x55d467a52ec0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::trace_unsynchronized::<std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55d467a52ec0 - std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55d467a52ec0 - <std[77c0456e0eb29f0c]::sys_common::backtrace::_print::DisplayBacktrace as core[ee1ca6415511a9c4]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x55d467a7577c - core[ee1ca6415511a9c4]::fmt::write
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/fmt/mod.rs:1110:17
[INFO] [stdout]    5:     0x55d467a4fd25 - <alloc[cda43b294bbfc5d0]::vec::Vec<u8> as std[77c0456e0eb29f0c]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/io/mod.rs:1584:15
[INFO] [stdout]    6:     0x55d467a5504b - std[77c0456e0eb29f0c]::sys_common::backtrace::_print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x55d467a5504b - std[77c0456e0eb29f0c]::sys_common::backtrace::print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x55d467a5504b - std[77c0456e0eb29f0c]::panicking::default_hook::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:208:50
[INFO] [stdout]    9:     0x55d467a54b5c - std[77c0456e0eb29f0c]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:222:9
[INFO] [stdout]   10:     0x55d467a556f1 - std[77c0456e0eb29f0c]::panicking::rust_panic_with_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:622:17
[INFO] [stdout]   11:     0x55d467a551f7 - std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:519:13
[INFO] [stdout]   12:     0x55d467a533bc - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_end_short_backtrace::<std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x55d467a55159 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:515:5
[INFO] [stdout]   14:     0x55d467979541 - core[ee1ca6415511a9c4]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:92:14
[INFO] [stdout]   15:     0x55d467a74098 - core[ee1ca6415511a9c4]::panicking::assert_failed_inner
[INFO] [stdout]   16:     0x55d467980e9e - core[ee1ca6415511a9c4]::panicking::assert_failed::<alloc[cda43b294bbfc5d0]::vec::Vec<alloc[cda43b294bbfc5d0]::string::String>, alloc[cda43b294bbfc5d0]::vec::Vec<&str>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:117:5
[INFO] [stdout]   17:     0x55d467984d3e - macros[258bf99b73cd0b9b]::module_attr
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/macros.rs:155:5
[INFO] [stdout]   18:     0x55d46798482a - macros[258bf99b73cd0b9b]::module_attr::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/macros.rs:139:1
[INFO] [stdout]   19:     0x55d46798664e - <macros[258bf99b73cd0b9b]::module_attr::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x55d4679afaa3 - <fn() as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   21:     0x55d4679afaa3 - test[eeb9024d9ac7bc83]::__rust_begin_short_backtrace::<fn()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:577:5
[INFO] [stdout]   22:     0x55d4679ae56c - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   23:     0x55d4679ae56c - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   24:     0x55d4679ae56c - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   25:     0x55d4679ae56c - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   26:     0x55d4679ae56c - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   27:     0x55d4679ae56c - test[eeb9024d9ac7bc83]::run_test_in_process
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:600:18
[INFO] [stdout]   28:     0x55d4679ae56c - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:492:39
[INFO] [stdout]   29:     0x55d46798e232 - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:519:37
[INFO] [stdout]   30:     0x55d46798e232 - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_begin_short_backtrace::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stdout]   31:     0x55d46798eb18 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:481:17
[INFO] [stdout]   32:     0x55d46798eb18 - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   33:     0x55d46798eb18 - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   34:     0x55d46798eb18 - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   35:     0x55d46798eb18 - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   36:     0x55d46798eb18 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:480:30
[INFO] [stdout]   37:     0x55d46798eb18 - <<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   38:     0x55d467a5a227 - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   39:     0x55d467a5a227 - <alloc[cda43b294bbfc5d0]::boxed::Box<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   40:     0x55d467a5a227 - <std[77c0456e0eb29f0c]::sys::unix::thread::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys/unix/thread.rs:71:17
[INFO] [stdout]   41:     0x7f26c0524609 - start_thread
[INFO] [stdout]   42:     0x7f26c02f6293 - clone
[INFO] [stdout]   43:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- here_test stdout ----
[INFO] [stdout] thread 'here_test' panicked at 'assertion failed: `(left == right)`
[INFO] [stdout]   left: `"tests/macros.rs:41"`,
[INFO] [stdout]  right: `"crates/tracing_macros/tests/macros.rs:41"`', tests/macros.rs:135:5
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55d467a52ec0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x55d467a52ec0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::trace_unsynchronized::<std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55d467a52ec0 - std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55d467a52ec0 - <std[77c0456e0eb29f0c]::sys_common::backtrace::_print::DisplayBacktrace as core[ee1ca6415511a9c4]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x55d467a7577c - core[ee1ca6415511a9c4]::fmt::write
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/fmt/mod.rs:1110:17
[INFO] [stdout]    5:     0x55d467a4fd25 - <alloc[cda43b294bbfc5d0]::vec::Vec<u8> as std[77c0456e0eb29f0c]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/io/mod.rs:1584:15
[INFO] [stdout]    6:     0x55d467a5504b - std[77c0456e0eb29f0c]::sys_common::backtrace::_print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x55d467a5504b - std[77c0456e0eb29f0c]::sys_common::backtrace::print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x55d467a5504b - std[77c0456e0eb29f0c]::panicking::default_hook::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:208:50
[INFO] [stdout]    9:     0x55d467a54b5c - std[77c0456e0eb29f0c]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:222:9
[INFO] [stdout]   10:     0x55d467a556f1 - std[77c0456e0eb29f0c]::panicking::rust_panic_with_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:622:17
[INFO] [stdout]   11:     0x55d467a551f7 - std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:519:13
[INFO] [stdout]   12:     0x55d467a533bc - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_end_short_backtrace::<std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x55d467a55159 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:515:5
[INFO] [stdout]   14:     0x55d467979541 - core[ee1ca6415511a9c4]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:92:14
[INFO] [stdout]   15:     0x55d467a74098 - core[ee1ca6415511a9c4]::panicking::assert_failed_inner
[INFO] [stdout]   16:     0x55d467980efe - core[ee1ca6415511a9c4]::panicking::assert_failed::<alloc[cda43b294bbfc5d0]::string::String, &str>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:117:5
[INFO] [stdout]   17:     0x55d4679847fa - macros[258bf99b73cd0b9b]::here_test
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/macros.rs:135:5
[INFO] [stdout]   18:     0x55d46798472a - macros[258bf99b73cd0b9b]::here_test::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/macros.rs:134:1
[INFO] [stdout]   19:     0x55d4679866ce - <macros[258bf99b73cd0b9b]::here_test::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x55d4679afaa3 - <fn() as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   21:     0x55d4679afaa3 - test[eeb9024d9ac7bc83]::__rust_begin_short_backtrace::<fn()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:577:5
[INFO] [stdout]   22:     0x55d4679ae56c - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   23:     0x55d4679ae56c - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   24:     0x55d4679ae56c - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   25:     0x55d4679ae56c - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   26:     0x55d4679ae56c - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   27:     0x55d4679ae56c - test[eeb9024d9ac7bc83]::run_test_in_process
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:600:18
[INFO] [stdout]   28:     0x55d4679ae56c - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:492:39
[INFO] [stdout]   29:     0x55d46798e232 - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:519:37
[INFO] [stdout]   30:     0x55d46798e232 - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_begin_short_backtrace::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stdout]   31:     0x55d46798eb18 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:481:17
[INFO] [stdout]   32:     0x55d46798eb18 - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   33:     0x55d46798eb18 - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   34:     0x55d46798eb18 - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   35:     0x55d46798eb18 - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   36:     0x55d46798eb18 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:480:30
[INFO] [stdout]   37:     0x55d46798eb18 - <<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   38:     0x55d467a5a227 - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   39:     0x55d467a5a227 - <alloc[cda43b294bbfc5d0]::boxed::Box<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   40:     0x55d467a5a227 - <std[77c0456e0eb29f0c]::sys::unix::thread::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys/unix/thread.rs:71:17
[INFO] [stdout]   41:     0x7f26c0524609 - start_thread
[INFO] [stdout]   42:     0x7f26c02f6293 - clone
[INFO] [stdout]   43:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- method_attr stdout ----
[INFO] [stdout] thread 'method_attr' panicked at 'assertion failed: `(left == right)`
[INFO] [stdout]   left: `["i in tests/macros.rs:96 (auto:method)", "h in tests/macros.rs:92 (auto:fn)", "g in tests/macros.rs:87 (auto:method)", "root"]`,
[INFO] [stdout]  right: `["i in crates/tracing_macros/tests/macros.rs:96 (auto:method)", "h in crates/tracing_macros/tests/macros.rs:92 (auto:fn)", "g in crates/tracing_macros/tests/macros.rs:87 (auto:method)", "root"]`', tests/macros.rs:184:5
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55d467a52ec0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x55d467a52ec0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::trace_unsynchronized::<std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55d467a52ec0 - std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55d467a52ec0 - <std[77c0456e0eb29f0c]::sys_common::backtrace::_print::DisplayBacktrace as core[ee1ca6415511a9c4]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x55d467a7577c - core[ee1ca6415511a9c4]::fmt::write
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/fmt/mod.rs:1110:17
[INFO] [stdout]    5:     0x55d467a4fd25 - <alloc[cda43b294bbfc5d0]::vec::Vec<u8> as std[77c0456e0eb29f0c]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/io/mod.rs:1584:15
[INFO] [stdout]    6:     0x55d467a5504b - std[77c0456e0eb29f0c]::sys_common::backtrace::_print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x55d467a5504b - std[77c0456e0eb29f0c]::sys_common::backtrace::print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x55d467a5504b - std[77c0456e0eb29f0c]::panicking::default_hook::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:208:50
[INFO] [stdout]    9:     0x55d467a54b5c - std[77c0456e0eb29f0c]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:222:9
[INFO] [stdout]   10:     0x55d467a556f1 - std[77c0456e0eb29f0c]::panicking::rust_panic_with_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:622:17
[INFO] [stdout]   11:     0x55d467a551f7 - std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:519:13
[INFO] [stdout]   12:     0x55d467a533bc - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_end_short_backtrace::<std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x55d467a55159 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:515:5
[INFO] [stdout]   14:     0x55d467979541 - core[ee1ca6415511a9c4]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:92:14
[INFO] [stdout]   15:     0x55d467a74098 - core[ee1ca6415511a9c4]::panicking::assert_failed_inner
[INFO] [stdout]   16:     0x55d467980e9e - core[ee1ca6415511a9c4]::panicking::assert_failed::<alloc[cda43b294bbfc5d0]::vec::Vec<alloc[cda43b294bbfc5d0]::string::String>, alloc[cda43b294bbfc5d0]::vec::Vec<&str>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:117:5
[INFO] [stdout]   17:     0x55d46798539e - macros[258bf99b73cd0b9b]::method_attr
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/macros.rs:184:5
[INFO] [stdout]   18:     0x55d467984e7a - macros[258bf99b73cd0b9b]::method_attr::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/macros.rs:167:1
[INFO] [stdout]   19:     0x55d46798660e - <macros[258bf99b73cd0b9b]::method_attr::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x55d4679afaa3 - <fn() as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   21:     0x55d4679afaa3 - test[eeb9024d9ac7bc83]::__rust_begin_short_backtrace::<fn()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:577:5
[INFO] [stdout]   22:     0x55d4679ae56c - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   23:     0x55d4679ae56c - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   24:     0x55d4679ae56c - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   25:     0x55d4679ae56c - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   26:     0x55d4679ae56c - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   27:     0x55d4679ae56c - test[eeb9024d9ac7bc83]::run_test_in_process
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:600:18
[INFO] [stdout]   28:     0x55d4679ae56c - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:492:39
[INFO] [stdout]   29:     0x55d46798e232 - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:519:37
[INFO] [stdout]   30:     0x55d46798e232 - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_begin_short_backtrace::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stdout]   31:     0x55d46798eb18 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:481:17
[INFO] [stdout]   32:     0x55d46798eb18 - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   33:     0x55d46798eb18 - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   34:     0x55d46798eb18 - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   35:     0x55d46798eb18 - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   36:     0x55d46798eb18 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:480:30
[INFO] [stdout]   37:     0x55d46798eb18 - <<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   38:     0x55d467a5a227 - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   39:     0x55d467a5a227 - <alloc[cda43b294bbfc5d0]::boxed::Box<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   40:     0x55d467a5a227 - <std[77c0456e0eb29f0c]::sys::unix::thread::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys/unix/thread.rs:71:17
[INFO] [stdout]   41:     0x7f26c0524609 - start_thread
[INFO] [stdout]   42:     0x7f26c02f6293 - clone
[INFO] [stdout]   43:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     function_attr
[INFO] [stdout]     here_test
[INFO] [stdout]     method_attr
[INFO] [stdout]     module_attr
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 4 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass '--test macros'
[INFO] running `Command { std: "docker" "inspect" "24b59f0b2dbd789845765485700ed6e3a41bcba511ee7ec05f3c32a2535b17f1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "24b59f0b2dbd789845765485700ed6e3a41bcba511ee7ec05f3c32a2535b17f1", kill_on_drop: false }`
[INFO] [stdout] 24b59f0b2dbd789845765485700ed6e3a41bcba511ee7ec05f3c32a2535b17f1