[INFO] fetching crate test-span 0.3.0... [INFO] testing test-span-0.3.0 against 1.60.0 for beta-1.61-1 [INFO] extracting crate test-span 0.3.0 into /workspace/builds/worker-3/source [INFO] validating manifest of crates.io crate test-span 0.3.0 on toolchain 1.60.0 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate test-span 0.3.0 [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate test-span 0.3.0 [INFO] tweaked toml for crates.io crate test-span 0.3.0 written to /workspace/builds/worker-3/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded daggy v0.8.0 [INFO] [stderr] Downloaded test-span-macro v0.3.0 [INFO] [stderr] Downloaded insta v1.14.0 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:eaef2f80f755933c374d2ae5edccceec0c1312ceb8a4e0b6404e8ab76561e1e5" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] [stdout] 021f8b65480552c4d927efaf2805fbd7eb5f83018c9ff96d3bbb0bdeac49d572 [INFO] running `Command { std: "docker" "start" "-a" "021f8b65480552c4d927efaf2805fbd7eb5f83018c9ff96d3bbb0bdeac49d572", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "021f8b65480552c4d927efaf2805fbd7eb5f83018c9ff96d3bbb0bdeac49d572", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "021f8b65480552c4d927efaf2805fbd7eb5f83018c9ff96d3bbb0bdeac49d572", kill_on_drop: false }` [INFO] [stdout] 021f8b65480552c4d927efaf2805fbd7eb5f83018c9ff96d3bbb0bdeac49d572 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:eaef2f80f755933c374d2ae5edccceec0c1312ceb8a4e0b6404e8ab76561e1e5" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] [stdout] 3f0fd00bbce50907a67c285c30fd28e4af0cd289dc56fb01ed975ea0ab1bbd1e [INFO] running `Command { std: "docker" "start" "-a" "3f0fd00bbce50907a67c285c30fd28e4af0cd289dc56fb01ed975ea0ab1bbd1e", kill_on_drop: false }` [INFO] [stderr] Compiling test-span-macro v0.3.0 [INFO] [stderr] Compiling tokio v1.17.0 [INFO] [stderr] Compiling petgraph v0.6.0 [INFO] [stderr] Compiling serde_test v1.0.136 [INFO] [stderr] Compiling serde_json v1.0.79 [INFO] [stderr] Compiling tracing-futures v0.2.5 [INFO] [stderr] Compiling tracing-subscriber v0.3.11 [INFO] [stderr] Compiling linked-hash-map v0.5.4 [INFO] [stderr] Compiling daggy v0.8.0 [INFO] [stderr] Compiling test-span v0.3.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 21.74s [INFO] running `Command { std: "docker" "inspect" "3f0fd00bbce50907a67c285c30fd28e4af0cd289dc56fb01ed975ea0ab1bbd1e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3f0fd00bbce50907a67c285c30fd28e4af0cd289dc56fb01ed975ea0ab1bbd1e", kill_on_drop: false }` [INFO] [stdout] 3f0fd00bbce50907a67c285c30fd28e4af0cd289dc56fb01ed975ea0ab1bbd1e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:eaef2f80f755933c374d2ae5edccceec0c1312ceb8a4e0b6404e8ab76561e1e5" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] aaf06a5e9753769d7bc99fb94b56a4ba1cc5a337d9afecdcc6556c44559b7e4b [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" "aaf06a5e9753769d7bc99fb94b56a4ba1cc5a337d9afecdcc6556c44559b7e4b", kill_on_drop: false }` [INFO] [stderr] Compiling similar v2.1.0 [INFO] [stderr] Compiling terminal_size v0.1.17 [INFO] [stderr] Compiling yaml-rust v0.4.5 [INFO] [stderr] Compiling console v0.15.0 [INFO] [stderr] Compiling serde_yaml v0.8.23 [INFO] [stderr] Compiling insta v1.14.0 [INFO] [stderr] Compiling test-span v0.3.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 16.07s [INFO] running `Command { std: "docker" "inspect" "aaf06a5e9753769d7bc99fb94b56a4ba1cc5a337d9afecdcc6556c44559b7e4b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "aaf06a5e9753769d7bc99fb94b56a4ba1cc5a337d9afecdcc6556c44559b7e4b", kill_on_drop: false }` [INFO] [stdout] aaf06a5e9753769d7bc99fb94b56a4ba1cc5a337d9afecdcc6556c44559b7e4b [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:eaef2f80f755933c374d2ae5edccceec0c1312ceb8a4e0b6404e8ab76561e1e5" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen", kill_on_drop: false }` [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] [stdout] ebc1f10d72ba9e2c444b3b9d35dfe1f535726f0bf29cc9fbdfb4bbf45c094c7d [INFO] running `Command { std: "docker" "start" "-a" "ebc1f10d72ba9e2c444b3b9d35dfe1f535726f0bf29cc9fbdfb4bbf45c094c7d", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.12s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/test_span-9bf2bff0974d8768) [INFO] [stderr] Running tests/tests.rs (/opt/rustwide/target/debug/deps/tests-e4c537c17b24c068) [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] [stdout] [INFO] [stdout] running 6 tests [INFO] [stdout] test traced_span_tests::get_all_logs_to_have_thread_support ... ok [INFO] [stdout] test traced_span_tests::tracing_works ... ok [INFO] [stdout] test traced_span_tests::async_tracing_works ... ok [INFO] [stdout] test traced_span_tests::tracing_macro_works ... FAILED [INFO] [stdout] test traced_span_tests::async_tracing_macro_works_with_other_level ... FAILED [INFO] [stdout] test traced_span_tests::async_tracing_macro_works ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- traced_span_tests::tracing_macro_works stdout ---- [INFO] [stdout] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ Snapshot Differences ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ [INFO] [stdout] Snapshot file: tests/snapshots/tests__traced_span_tests__inner_test.snap [INFO] [stdout] Snapshot: inner_test [INFO] [stdout] Source: tests/tests.rs:24 [INFO] [stdout] +new results [INFO] [stdout] ──────────────────────────────────────────────────────────────────────────────── [INFO] [stdout] logs [INFO] [stdout] ────────────┬─────────────────────────────────────────────────────────────────── [INFO] [stdout] 0 │+[ [INFO] [stdout] 1 │+ [ [INFO] [stdout] 2 │+ "message", [INFO] [stdout] 3 │+ "here i am!" [INFO] [stdout] 4 │+ ], [INFO] [stdout] 5 │+ [ [INFO] [stdout] 6 │+ "number", [INFO] [stdout] 7 │+ 52 [INFO] [stdout] 8 │+ ], [INFO] [stdout] 9 │+ [ [INFO] [stdout] 10 │+ "number", [INFO] [stdout] 11 │+ 42 [INFO] [stdout] 12 │+ ], [INFO] [stdout] 13 │+ [ [INFO] [stdout] 14 │+ "message", [INFO] [stdout] 15 │+ "here i am again!" [INFO] [stdout] 16 │+ ], [INFO] [stdout] 17 │+ [ [INFO] [stdout] 18 │+ "message", [INFO] [stdout] 19 │+ "debug: here i am again!" [INFO] [stdout] 20 │+ ], [INFO] [stdout] 21 │+ [ [INFO] [stdout] 22 │+ "message", [INFO] [stdout] 23 │+ "here i am!" [INFO] [stdout] 24 │+ ], [INFO] [stdout] 25 │+ [ [INFO] [stdout] 26 │+ "number", [INFO] [stdout] 27 │+ 52 [INFO] [stdout] 28 │+ ], [INFO] [stdout] 29 │+ [ [INFO] [stdout] 30 │+ "number", [INFO] [stdout] 31 │+ 42 [INFO] [stdout] 32 │+ ], [INFO] [stdout] 33 │+ [ [INFO] [stdout] 34 │+ "message", [INFO] [stdout] 35 │+ "here i am again!" [INFO] [stdout] 36 │+ ], [INFO] [stdout] 37 │+ [ [INFO] [stdout] 38 │+ "message", [INFO] [stdout] 39 │+ "debug: here i am again!" [INFO] [stdout] 40 │+ ] [INFO] [stdout] 41 │+] [INFO] [stdout] ────────────┴─────────────────────────────────────────────────────────────────── [INFO] [stdout] thread 'traced_span_tests::tracing_macro_works' panicked at 'called `Result::unwrap()` on an `Err` value: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }', tests/tests.rs:24:9 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x55da6d87854d - std::backtrace_rs::backtrace::libunwind::trace::hee598835bc88d35b [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 [INFO] [stdout] 1: 0x55da6d87854d - std::backtrace_rs::backtrace::trace_unsynchronized::h9cdc730ba5cf5d72 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x55da6d87854d - std::sys_common::backtrace::_print_fmt::h75aeaf7ed30e43fa [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:66:5 [INFO] [stdout] 3: 0x55da6d87854d - ::fmt::h606862f787600875 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:45:22 [INFO] [stdout] 4: 0x55da6d8a042c - core::fmt::write::he803f0f418caf762 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/fmt/mod.rs:1190:17 [INFO] [stdout] 5: 0x55da6d873508 - std::io::Write::write_fmt::hbe7c1a63616291e2 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/io/mod.rs:1657:15 [INFO] [stdout] 6: 0x55da6d87a877 - std::sys_common::backtrace::_print::h64d038cf8ac3e13e [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:48:5 [INFO] [stdout] 7: 0x55da6d87a877 - std::sys_common::backtrace::print::h359300b4a7fccf65 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:35:9 [INFO] [stdout] 8: 0x55da6d87a877 - std::panicking::default_hook::{{closure}}::hf51be35e2f510149 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:295:22 [INFO] [stdout] 9: 0x55da6d87a5ac - std::panicking::default_hook::h03ca0f22e1d2d25e [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:311:9 [INFO] [stdout] 10: 0x55da6d87afc9 - std::panicking::rust_panic_with_hook::h3b7380e99b825b63 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:698:17 [INFO] [stdout] 11: 0x55da6d87acb7 - std::panicking::begin_panic_handler::{{closure}}::h8e849d0710154ce0 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:588:13 [INFO] [stdout] 12: 0x55da6d878a14 - std::sys_common::backtrace::__rust_end_short_backtrace::hedcdaddbd4c46cc5 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:138:18 [INFO] [stdout] 13: 0x55da6d87a9c9 - rust_begin_unwind [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:584:5 [INFO] [stdout] 14: 0x55da6d4b12b3 - core::panicking::panic_fmt::he1bbc7336d49a357 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panicking.rs:143:14 [INFO] [stdout] 15: 0x55da6d4b13a3 - core::result::unwrap_failed::h719f957ed74f93fd [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/result.rs:1749:5 [INFO] [stdout] 16: 0x55da6d4de608 - core::result::Result::unwrap::hc10a9de11299ebae [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/result.rs:1065:23 [INFO] [stdout] 17: 0x55da6d4b2886 - tests::traced_span_tests::tracing_macro_works::inner_test::h6c6bfbb34ba4b764 [INFO] [stdout] at /opt/rustwide/workdir/tests/tests.rs:24:9 [INFO] [stdout] 18: 0x55da6d4b2eb9 - tests::traced_span_tests::tracing_macro_works::{{closure}}::hf1afe55ec6205a28 [INFO] [stdout] at /opt/rustwide/workdir/tests/tests.rs:6:5 [INFO] [stdout] 19: 0x55da6d4bfcfd - tracing::span::Span::in_scope::h228c97b62cb57ac8 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tracing-0.1.33/src/span.rs:1096:9 [INFO] [stdout] 20: 0x55da6d4b214f - tests::traced_span_tests::tracing_macro_works::h2fb33cbea720644c [INFO] [stdout] at /opt/rustwide/workdir/tests/tests.rs:6:5 [INFO] [stdout] 21: 0x55da6d4b1c0a - tests::traced_span_tests::tracing_macro_works::{{closure}}::hebd1404f29f2e6f6 [INFO] [stdout] at /opt/rustwide/workdir/tests/tests.rs:6:5 [INFO] [stdout] 22: 0x55da6d4d649e - core::ops::function::FnOnce::call_once::h8db80d6c41103c01 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 23: 0x55da6d767d63 - core::ops::function::FnOnce::call_once::h2a47b4b927cb6ca5 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 24: 0x55da6d767d63 - test::__rust_begin_short_backtrace::h594ef8055a183b9b [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/test/src/lib.rs:575:5 [INFO] [stdout] 25: 0x55da6d766a44 - as core::ops::function::FnOnce>::call_once::hb40cbb8bc3e1be15 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/alloc/src/boxed.rs:1853:9 [INFO] [stdout] 26: 0x55da6d766a44 - as core::ops::function::FnOnce<()>>::call_once::ha4f2bd3b806745a0 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 27: 0x55da6d766a44 - std::panicking::try::do_call::h92af9f8bc77a5987 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40 [INFO] [stdout] 28: 0x55da6d766a44 - std::panicking::try::h9df49eeae42572b7 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19 [INFO] [stdout] 29: 0x55da6d766a44 - std::panic::catch_unwind::h101dbadc82bbe0fd [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14 [INFO] [stdout] 30: 0x55da6d766a44 - test::run_test_in_process::h2ad7bffb068e750a [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/test/src/lib.rs:598:18 [INFO] [stdout] 31: 0x55da6d766a44 - test::run_test::run_test_inner::{{closure}}::h384faf46554c5acb [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/test/src/lib.rs:492:39 [INFO] [stdout] 32: 0x55da6d770361 - test::run_test::run_test_inner::{{closure}}::h17cfe94835a46685 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/test/src/lib.rs:519:37 [INFO] [stdout] 33: 0x55da6d770361 - std::sys_common::backtrace::__rust_begin_short_backtrace::h82709e5086312627 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:122:18 [INFO] [stdout] 34: 0x55da6d73c9df - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hdfea66a201b39571 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/thread/mod.rs:498:17 [INFO] [stdout] 35: 0x55da6d73c9df - as core::ops::function::FnOnce<()>>::call_once::h4912df03598e67fa [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 36: 0x55da6d73c9df - std::panicking::try::do_call::h6d5dc1045d0eade8 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40 [INFO] [stdout] 37: 0x55da6d73c9df - std::panicking::try::hbc897fc717ec6571 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19 [INFO] [stdout] 38: 0x55da6d73c9df - std::panic::catch_unwind::h27f1e958c91391ad [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14 [INFO] [stdout] 39: 0x55da6d73c9df - std::thread::Builder::spawn_unchecked_::{{closure}}::h1b42e48537edc3c0 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/thread/mod.rs:497:30 [INFO] [stdout] 40: 0x55da6d73c9df - core::ops::function::FnOnce::call_once{{vtable.shim}}::h9137b3d6d2a88354 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 41: 0x55da6d880f43 - as core::ops::function::FnOnce>::call_once::hf70ac038171e3e1a [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/alloc/src/boxed.rs:1853:9 [INFO] [stdout] 42: 0x55da6d880f43 - as core::ops::function::FnOnce>::call_once::he6690128792365ad [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/alloc/src/boxed.rs:1853:9 [INFO] [stdout] 43: 0x55da6d880f43 - std::sys::unix::thread::Thread::new::thread_start::ha07928d93d5a5ec9 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys/unix/thread.rs:108:17 [INFO] [stdout] 44: 0x7f56068db609 - start_thread [INFO] [stdout] 45: 0x7f56066ab163 - clone [INFO] [stdout] 46: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- traced_span_tests::async_tracing_macro_works_with_other_level stdout ---- [INFO] [stdout] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ Snapshot Differences ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ [INFO] [stdout] Snapshot file: tests/snapshots/tests__traced_span_tests__inner_test-3.snap [INFO] [stdout] Snapshot: inner_test-3 [INFO] [stdout] Source: tests/tests.rs:63 [INFO] [stdout] +new results [INFO] [stdout] ──────────────────────────────────────────────────────────────────────────────── [INFO] [stdout] logs [INFO] [stdout] ────────────┬─────────────────────────────────────────────────────────────────── [INFO] [stdout] 0 │+[ [INFO] [stdout] 1 │+ [ [INFO] [stdout] 2 │+ "message", [INFO] [stdout] 3 │+ "here i am!" [INFO] [stdout] 4 │+ ], [INFO] [stdout] 5 │+ [ [INFO] [stdout] 6 │+ "message", [INFO] [stdout] 7 │+ "in a separate context!" [INFO] [stdout] 8 │+ ], [INFO] [stdout] 9 │+ [ [INFO] [stdout] 10 │+ "number", [INFO] [stdout] 11 │+ 52 [INFO] [stdout] 12 │+ ], [INFO] [stdout] 13 │+ [ [INFO] [stdout] 14 │+ "number", [INFO] [stdout] 15 │+ 42 [INFO] [stdout] 16 │+ ], [INFO] [stdout] 17 │+ [ [INFO] [stdout] 18 │+ "message", [INFO] [stdout] 19 │+ "here i am again!" [INFO] [stdout] 20 │+ ], [INFO] [stdout] 21 │+ [ [INFO] [stdout] 22 │+ "message", [INFO] [stdout] 23 │+ "here i am!" [INFO] [stdout] 24 │+ ], [INFO] [stdout] 25 │+ [ [INFO] [stdout] 26 │+ "message", [INFO] [stdout] 27 │+ "in a separate context!" [INFO] [stdout] 28 │+ ], [INFO] [stdout] 29 │+ [ [INFO] [stdout] 30 │+ "number", [INFO] [stdout] 31 │+ 52 [INFO] [stdout] 32 │+ ], [INFO] [stdout] 33 │+ [ [INFO] [stdout] 34 │+ "number", [INFO] [stdout] 35 │+ 42 [INFO] [stdout] 36 │+ ], [INFO] [stdout] 37 │+ [ [INFO] [stdout] 38 │+ "message", [INFO] [stdout] 39 │+ "here i am again!" [INFO] [stdout] 40 │+ ] [INFO] [stdout] 41 │+] [INFO] [stdout] ────────────┴─────────────────────────────────────────────────────────────────── [INFO] [stdout] thread 'traced_span_tests::async_tracing_macro_works_with_other_level' panicked at 'called `Result::unwrap()` on an `Err` value: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }', tests/tests.rs:63:9 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x55da6d87854d - std::backtrace_rs::backtrace::libunwind::trace::hee598835bc88d35b [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 [INFO] [stdout] 1: 0x55da6d87854d - std::backtrace_rs::backtrace::trace_unsynchronized::h9cdc730ba5cf5d72 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x55da6d87854d - std::sys_common::backtrace::_print_fmt::h75aeaf7ed30e43fa [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:66:5 [INFO] [stdout] 3: 0x55da6d87854d - ::fmt::h606862f787600875 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:45:22 [INFO] [stdout] 4: 0x55da6d8a042c - core::fmt::write::he803f0f418caf762 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/fmt/mod.rs:1190:17 [INFO] [stdout] 5: 0x55da6d873508 - std::io::Write::write_fmt::hbe7c1a63616291e2 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/io/mod.rs:1657:15 [INFO] [stdout] 6: 0x55da6d87a877 - std::sys_common::backtrace::_print::h64d038cf8ac3e13e [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:48:5 [INFO] [stdout] 7: 0x55da6d87a877 - std::sys_common::backtrace::print::h359300b4a7fccf65 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:35:9 [INFO] [stdout] 8: 0x55da6d87a877 - std::panicking::default_hook::{{closure}}::hf51be35e2f510149 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:295:22 [INFO] [stdout] 9: 0x55da6d87a5ac - std::panicking::default_hook::h03ca0f22e1d2d25e [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:311:9 [INFO] [stdout] 10: 0x55da6d87afc9 - std::panicking::rust_panic_with_hook::h3b7380e99b825b63 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:698:17 [INFO] [stdout] 11: 0x55da6d87acb7 - std::panicking::begin_panic_handler::{{closure}}::h8e849d0710154ce0 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:588:13 [INFO] [stdout] 12: 0x55da6d878a14 - std::sys_common::backtrace::__rust_end_short_backtrace::hedcdaddbd4c46cc5 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:138:18 [INFO] [stdout] 13: 0x55da6d87a9c9 - rust_begin_unwind [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:584:5 [INFO] [stdout] 14: 0x55da6d4b12b3 - core::panicking::panic_fmt::he1bbc7336d49a357 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panicking.rs:143:14 [INFO] [stdout] 15: 0x55da6d4b13a3 - core::result::unwrap_failed::h719f957ed74f93fd [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/result.rs:1749:5 [INFO] [stdout] 16: 0x55da6d4de608 - core::result::Result::unwrap::hc10a9de11299ebae [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/result.rs:1065:23 [INFO] [stdout] 17: 0x55da6d4b5fb8 - tests::traced_span_tests::async_tracing_macro_works_with_other_level::{{closure}}::inner_test::{{closure}}::hb55aed04797d704c [INFO] [stdout] at /opt/rustwide/workdir/tests/tests.rs:63:9 [INFO] [stdout] 18: 0x55da6d4dc51b - as core::future::future::Future>::poll::hd86dfad2434677b4 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/future/mod.rs:84:19 [INFO] [stdout] 19: 0x55da6d4e24c2 - as core::future::future::Future>::poll::h82477911625defaa [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tracing-0.1.33/src/instrument.rs:272:9 [INFO] [stdout] 20: 0x55da6d4b554b - tests::traced_span_tests::async_tracing_macro_works_with_other_level::{{closure}}::hcb1a3b93e3e455fd [INFO] [stdout] at /opt/rustwide/workdir/tests/tests.rs:50:5 [INFO] [stdout] 21: 0x55da6d4dc18b - as core::future::future::Future>::poll::h292289ea23de8e85 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/future/mod.rs:84:19 [INFO] [stdout] 22: 0x55da6d4e218a - as core::future::future::Future>::poll::h80d49bc3598b3f2a [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/future/future.rs:123:9 [INFO] [stdout] 23: 0x55da6d4d5520 - tokio::runtime::basic_scheduler::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::hf206862326a404d9 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:498:48 [INFO] [stdout] 24: 0x55da6d4e0b90 - tokio::coop::with_budget::{{closure}}::h0ec716018364b87d [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/coop.rs:102:9 [INFO] [stdout] 25: 0x55da6d4dfba8 - std::thread::local::LocalKey::try_with::h941549921cad9d51 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/thread/local.rs:413:16 [INFO] [stdout] 26: 0x55da6d4de9dd - std::thread::local::LocalKey::with::h22d0ca7749c73b96 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/thread/local.rs:389:9 [INFO] [stdout] 27: 0x55da6d4d51d5 - tokio::coop::with_budget::h8694460386366723 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/coop.rs:95:5 [INFO] [stdout] 28: 0x55da6d4d51d5 - tokio::coop::budget::h6f5bba35b2f2573f [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/coop.rs:72:5 [INFO] [stdout] 29: 0x55da6d4d51d5 - tokio::runtime::basic_scheduler::CoreGuard::block_on::{{closure}}::{{closure}}::h5e8e47c8db685681 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:498:25 [INFO] [stdout] 30: 0x55da6d4d2a41 - tokio::runtime::basic_scheduler::Context::enter::h54af87a7f67db690 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:356:19 [INFO] [stdout] 31: 0x55da6d4d453d - tokio::runtime::basic_scheduler::CoreGuard::block_on::{{closure}}::h8e6c580d2d075b7c [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:497:36 [INFO] [stdout] 32: 0x55da6d4d61db - tokio::runtime::basic_scheduler::CoreGuard::enter::{{closure}}::hb25576fbc03687b8 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:555:57 [INFO] [stdout] 33: 0x55da6d4d7a77 - tokio::macros::scoped_tls::ScopedKey::set::hb140dc0cfad274ac [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/macros/scoped_tls.rs:61:9 [INFO] [stdout] 34: 0x55da6d4d5810 - tokio::runtime::basic_scheduler::CoreGuard::enter::h246ffcba86238f80 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:555:27 [INFO] [stdout] 35: 0x55da6d4d3ae0 - tokio::runtime::basic_scheduler::CoreGuard::block_on::h2547a784e2b55383 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:488:9 [INFO] [stdout] 36: 0x55da6d4d19e5 - tokio::runtime::basic_scheduler::BasicScheduler::block_on::h94c32ac3df3aff6f [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:168:24 [INFO] [stdout] 37: 0x55da6d4d8c7d - tokio::runtime::Runtime::block_on::h848b7431da9c3fce [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/mod.rs:475:46 [INFO] [stdout] 38: 0x55da6d4b4d2c - tests::traced_span_tests::async_tracing_macro_works_with_other_level::hd5a30c08ed3221a0 [INFO] [stdout] at /opt/rustwide/workdir/tests/tests.rs:50:5 [INFO] [stdout] 39: 0x55da6d4b4bea - tests::traced_span_tests::async_tracing_macro_works_with_other_level::{{closure}}::h3215847bddcc3d03 [INFO] [stdout] at /opt/rustwide/workdir/tests/tests.rs:50:5 [INFO] [stdout] 40: 0x55da6d4d655e - core::ops::function::FnOnce::call_once::hfad0e7b91cbdb13b [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 41: 0x55da6d767d63 - core::ops::function::FnOnce::call_once::h2a47b4b927cb6ca5 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 42: 0x55da6d767d63 - test::__rust_begin_short_backtrace::h594ef8055a183b9b [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/test/src/lib.rs:575:5 [INFO] [stdout] 43: 0x55da6d766a44 - as core::ops::function::FnOnce>::call_once::hb40cbb8bc3e1be15 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/alloc/src/boxed.rs:1853:9 [INFO] [stdout] 44: 0x55da6d766a44 - as core::ops::function::FnOnce<()>>::call_once::ha4f2bd3b806745a0 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 45: 0x55da6d766a44 - std::panicking::try::do_call::h92af9f8bc77a5987 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40 [INFO] [stdout] 46: 0x55da6d766a44 - std::panicking::try::h9df49eeae42572b7 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19 [INFO] [stdout] 47: 0x55da6d766a44 - std::panic::catch_unwind::h101dbadc82bbe0fd [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14 [INFO] [stdout] 48: 0x55da6d766a44 - test::run_test_in_process::h2ad7bffb068e750a [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/test/src/lib.rs:598:18 [INFO] [stdout] 49: 0x55da6d766a44 - test::run_test::run_test_inner::{{closure}}::h384faf46554c5acb [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/test/src/lib.rs:492:39 [INFO] [stdout] 50: 0x55da6d770361 - test::run_test::run_test_inner::{{closure}}::h17cfe94835a46685 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/test/src/lib.rs:519:37 [INFO] [stdout] 51: 0x55da6d770361 - std::sys_common::backtrace::__rust_begin_short_backtrace::h82709e5086312627 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:122:18 [INFO] [stdout] 52: 0x55da6d73c9df - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hdfea66a201b39571 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/thread/mod.rs:498:17 [INFO] [stdout] 53: 0x55da6d73c9df - as core::ops::function::FnOnce<()>>::call_once::h4912df03598e67fa [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 54: 0x55da6d73c9df - std::panicking::try::do_call::h6d5dc1045d0eade8 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40 [INFO] [stdout] 55: 0x55da6d73c9df - std::panicking::try::hbc897fc717ec6571 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19 [INFO] [stdout] 56: 0x55da6d73c9df - std::panic::catch_unwind::h27f1e958c91391ad [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14 [INFO] [stdout] 57: 0x55da6d73c9df - std::thread::Builder::spawn_unchecked_::{{closure}}::h1b42e48537edc3c0 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/thread/mod.rs:497:30 [INFO] [stdout] 58: 0x55da6d73c9df - core::ops::function::FnOnce::call_once{{vtable.shim}}::h9137b3d6d2a88354 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 59: 0x55da6d880f43 - as core::ops::function::FnOnce>::call_once::hf70ac038171e3e1a [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/alloc/src/boxed.rs:1853:9 [INFO] [stdout] 60: 0x55da6d880f43 - as core::ops::function::FnOnce>::call_once::he6690128792365ad [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/alloc/src/boxed.rs:1853:9 [INFO] [stdout] 61: 0x55da6d880f43 - std::sys::unix::thread::Thread::new::thread_start::ha07928d93d5a5ec9 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys/unix/thread.rs:108:17 [INFO] [stdout] 62: 0x7f56068db609 - start_thread [INFO] [stdout] 63: 0x7f56066ab163 - clone [INFO] [stdout] 64: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- traced_span_tests::async_tracing_macro_works stdout ---- [INFO] [stdout] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ Snapshot Differences ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ [INFO] [stdout] Snapshot file: tests/snapshots/tests__traced_span_tests__inner_test-2.snap [INFO] [stdout] Snapshot: inner_test-2 [INFO] [stdout] Source: tests/tests.rs:43 [INFO] [stdout] +new results [INFO] [stdout] ──────────────────────────────────────────────────────────────────────────────── [INFO] [stdout] logs [INFO] [stdout] ────────────┬─────────────────────────────────────────────────────────────────── [INFO] [stdout] 0 │+[ [INFO] [stdout] 1 │+ [ [INFO] [stdout] 2 │+ "message", [INFO] [stdout] 3 │+ "here i am!" [INFO] [stdout] 4 │+ ], [INFO] [stdout] 5 │+ [ [INFO] [stdout] 6 │+ "message", [INFO] [stdout] 7 │+ "in a separate context!" [INFO] [stdout] 8 │+ ], [INFO] [stdout] 9 │+ [ [INFO] [stdout] 10 │+ "number", [INFO] [stdout] 11 │+ 52 [INFO] [stdout] 12 │+ ], [INFO] [stdout] 13 │+ [ [INFO] [stdout] 14 │+ "number", [INFO] [stdout] 15 │+ 42 [INFO] [stdout] 16 │+ ], [INFO] [stdout] 17 │+ [ [INFO] [stdout] 18 │+ "message", [INFO] [stdout] 19 │+ "here i am!" [INFO] [stdout] 20 │+ ], [INFO] [stdout] 21 │+ [ [INFO] [stdout] 22 │+ "message", [INFO] [stdout] 23 │+ "in a separate context!" [INFO] [stdout] 24 │+ ], [INFO] [stdout] 25 │+ [ [INFO] [stdout] 26 │+ "number", [INFO] [stdout] 27 │+ 52 [INFO] [stdout] 28 │+ ], [INFO] [stdout] 29 │+ [ [INFO] [stdout] 30 │+ "number", [INFO] [stdout] 31 │+ 42 [INFO] [stdout] 32 │+ ] [INFO] [stdout] 33 │+] [INFO] [stdout] ────────────┴─────────────────────────────────────────────────────────────────── [INFO] [stdout] thread 'traced_span_tests::async_tracing_macro_works' panicked at 'called `Result::unwrap()` on an `Err` value: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }', tests/tests.rs:43:9 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x55da6d87854d - std::backtrace_rs::backtrace::libunwind::trace::hee598835bc88d35b [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 [INFO] [stdout] 1: 0x55da6d87854d - std::backtrace_rs::backtrace::trace_unsynchronized::h9cdc730ba5cf5d72 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x55da6d87854d - std::sys_common::backtrace::_print_fmt::h75aeaf7ed30e43fa [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:66:5 [INFO] [stdout] 3: 0x55da6d87854d - ::fmt::h606862f787600875 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:45:22 [INFO] [stdout] 4: 0x55da6d8a042c - core::fmt::write::he803f0f418caf762 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/fmt/mod.rs:1190:17 [INFO] [stdout] 5: 0x55da6d873508 - std::io::Write::write_fmt::hbe7c1a63616291e2 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/io/mod.rs:1657:15 [INFO] [stdout] 6: 0x55da6d87a877 - std::sys_common::backtrace::_print::h64d038cf8ac3e13e [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:48:5 [INFO] [stdout] 7: 0x55da6d87a877 - std::sys_common::backtrace::print::h359300b4a7fccf65 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:35:9 [INFO] [stdout] 8: 0x55da6d87a877 - std::panicking::default_hook::{{closure}}::hf51be35e2f510149 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:295:22 [INFO] [stdout] 9: 0x55da6d87a5ac - std::panicking::default_hook::h03ca0f22e1d2d25e [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:311:9 [INFO] [stdout] 10: 0x55da6d87afc9 - std::panicking::rust_panic_with_hook::h3b7380e99b825b63 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:698:17 [INFO] [stdout] 11: 0x55da6d87acb7 - std::panicking::begin_panic_handler::{{closure}}::h8e849d0710154ce0 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:588:13 [INFO] [stdout] 12: 0x55da6d878a14 - std::sys_common::backtrace::__rust_end_short_backtrace::hedcdaddbd4c46cc5 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:138:18 [INFO] [stdout] 13: 0x55da6d87a9c9 - rust_begin_unwind [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:584:5 [INFO] [stdout] 14: 0x55da6d4b12b3 - core::panicking::panic_fmt::he1bbc7336d49a357 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panicking.rs:143:14 [INFO] [stdout] 15: 0x55da6d4b13a3 - core::result::unwrap_failed::h719f957ed74f93fd [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/result.rs:1749:5 [INFO] [stdout] 16: 0x55da6d4de608 - core::result::Result::unwrap::hc10a9de11299ebae [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/result.rs:1065:23 [INFO] [stdout] 17: 0x55da6d4b4338 - tests::traced_span_tests::async_tracing_macro_works::{{closure}}::inner_test::{{closure}}::h808c49ffb3a03cf0 [INFO] [stdout] at /opt/rustwide/workdir/tests/tests.rs:43:9 [INFO] [stdout] 18: 0x55da6d4dc5ab - as core::future::future::Future>::poll::he14e463f07047f2f [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/future/mod.rs:84:19 [INFO] [stdout] 19: 0x55da6d4e23d2 - as core::future::future::Future>::poll::h1f667f175988e523 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tracing-0.1.33/src/instrument.rs:272:9 [INFO] [stdout] 20: 0x55da6d4b38cb - tests::traced_span_tests::async_tracing_macro_works::{{closure}}::h5f9680c40389cf9d [INFO] [stdout] at /opt/rustwide/workdir/tests/tests.rs:31:5 [INFO] [stdout] 21: 0x55da6d4dc06b - as core::future::future::Future>::poll::h21ac5cdcf26e149b [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/future/mod.rs:84:19 [INFO] [stdout] 22: 0x55da6d4e224a - as core::future::future::Future>::poll::hb2430c4b67447e6a [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/future/future.rs:123:9 [INFO] [stdout] 23: 0x55da6d4d5460 - tokio::runtime::basic_scheduler::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::h0e99b9c184437b35 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:498:48 [INFO] [stdout] 24: 0x55da6d4e0a70 - tokio::coop::with_budget::{{closure}}::h09006759acf48f44 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/coop.rs:102:9 [INFO] [stdout] 25: 0x55da6d4df818 - std::thread::local::LocalKey::try_with::h6c682c40aaa9409e [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/thread/local.rs:413:16 [INFO] [stdout] 26: 0x55da6d4de96d - std::thread::local::LocalKey::with::h20b4daae42e9a64b [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/thread/local.rs:389:9 [INFO] [stdout] 27: 0x55da6d4d52d5 - tokio::coop::with_budget::h9a0ff4575ed0d961 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/coop.rs:95:5 [INFO] [stdout] 28: 0x55da6d4d52d5 - tokio::coop::budget::h463ba864b4ca4dea [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/coop.rs:72:5 [INFO] [stdout] 29: 0x55da6d4d52d5 - tokio::runtime::basic_scheduler::CoreGuard::block_on::{{closure}}::{{closure}}::hc160ba0df9b231c1 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:498:25 [INFO] [stdout] 30: 0x55da6d4d3311 - tokio::runtime::basic_scheduler::Context::enter::hb6a22664c5a02244 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:356:19 [INFO] [stdout] 31: 0x55da6d4d3e0d - tokio::runtime::basic_scheduler::CoreGuard::block_on::{{closure}}::h8a7313bbad1d8fae [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:497:36 [INFO] [stdout] 32: 0x55da6d4d621b - tokio::runtime::basic_scheduler::CoreGuard::enter::{{closure}}::hc6a38b9713421f2d [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:555:57 [INFO] [stdout] 33: 0x55da6d4d7b77 - tokio::macros::scoped_tls::ScopedKey::set::hcc4c54d587938be9 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/macros/scoped_tls.rs:61:9 [INFO] [stdout] 34: 0x55da6d4d5f50 - tokio::runtime::basic_scheduler::CoreGuard::enter::he783f55117bd6c18 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:555:27 [INFO] [stdout] 35: 0x55da6d4d3b30 - tokio::runtime::basic_scheduler::CoreGuard::block_on::hc65db4cda06acd5f [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:488:9 [INFO] [stdout] 36: 0x55da6d4d1585 - tokio::runtime::basic_scheduler::BasicScheduler::block_on::h8fb6cdf435264627 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/basic_scheduler.rs:168:24 [INFO] [stdout] 37: 0x55da6d4d8dfd - tokio::runtime::Runtime::block_on::hc0d5b5c2ba8d88f7 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.17.0/src/runtime/mod.rs:475:46 [INFO] [stdout] 38: 0x55da6d4b30ac - tests::traced_span_tests::async_tracing_macro_works::h0fc44ae2720cec35 [INFO] [stdout] at /opt/rustwide/workdir/tests/tests.rs:31:5 [INFO] [stdout] 39: 0x55da6d4b2f6a - tests::traced_span_tests::async_tracing_macro_works::{{closure}}::hf6ac93a386002228 [INFO] [stdout] at /opt/rustwide/workdir/tests/tests.rs:31:5 [INFO] [stdout] 40: 0x55da6d4d627e - core::ops::function::FnOnce::call_once::h02e67dbfdd1e8279 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 41: 0x55da6d767d63 - core::ops::function::FnOnce::call_once::h2a47b4b927cb6ca5 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 42: 0x55da6d767d63 - test::__rust_begin_short_backtrace::h594ef8055a183b9b [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/test/src/lib.rs:575:5 [INFO] [stdout] 43: 0x55da6d766a44 - as core::ops::function::FnOnce>::call_once::hb40cbb8bc3e1be15 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/alloc/src/boxed.rs:1853:9 [INFO] [stdout] 44: 0x55da6d766a44 - as core::ops::function::FnOnce<()>>::call_once::ha4f2bd3b806745a0 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 45: 0x55da6d766a44 - std::panicking::try::do_call::h92af9f8bc77a5987 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40 [INFO] [stdout] 46: 0x55da6d766a44 - std::panicking::try::h9df49eeae42572b7 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19 [INFO] [stdout] 47: 0x55da6d766a44 - std::panic::catch_unwind::h101dbadc82bbe0fd [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14 [INFO] [stdout] 48: 0x55da6d766a44 - test::run_test_in_process::h2ad7bffb068e750a [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/test/src/lib.rs:598:18 [INFO] [stdout] 49: 0x55da6d766a44 - test::run_test::run_test_inner::{{closure}}::h384faf46554c5acb [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/test/src/lib.rs:492:39 [INFO] [stdout] 50: 0x55da6d770361 - test::run_test::run_test_inner::{{closure}}::h17cfe94835a46685 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/test/src/lib.rs:519:37 [INFO] [stdout] 51: 0x55da6d770361 - std::sys_common::backtrace::__rust_begin_short_backtrace::h82709e5086312627 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:122:18 [INFO] [stdout] 52: 0x55da6d73c9df - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hdfea66a201b39571 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/thread/mod.rs:498:17 [INFO] [stdout] 53: 0x55da6d73c9df - as core::ops::function::FnOnce<()>>::call_once::h4912df03598e67fa [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 54: 0x55da6d73c9df - std::panicking::try::do_call::h6d5dc1045d0eade8 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40 [INFO] [stdout] 55: 0x55da6d73c9df - std::panicking::try::hbc897fc717ec6571 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19 [INFO] [stdout] 56: 0x55da6d73c9df - std::panic::catch_unwind::h27f1e958c91391ad [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14 [INFO] [stdout] 57: 0x55da6d73c9df - std::thread::Builder::spawn_unchecked_::{{closure}}::h1b42e48537edc3c0 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/thread/mod.rs:497:30 [INFO] [stdout] 58: 0x55da6d73c9df - core::ops::function::FnOnce::call_once{{vtable.shim}}::h9137b3d6d2a88354 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 59: 0x55da6d880f43 - as core::ops::function::FnOnce>::call_once::hf70ac038171e3e1a [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/alloc/src/boxed.rs:1853:9 [INFO] [stdout] 60: 0x55da6d880f43 - as core::ops::function::FnOnce>::call_once::he6690128792365ad [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/alloc/src/boxed.rs:1853:9 [INFO] [stdout] 61: 0x55da6d880f43 - std::sys::unix::thread::Thread::new::thread_start::ha07928d93d5a5ec9 [INFO] [stdout] at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys/unix/thread.rs:108:17 [INFO] [stdout] 62: 0x7f56068db609 - start_thread [INFO] [stdout] 63: 0x7f56066ab163 - clone [INFO] [stdout] 64: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] traced_span_tests::async_tracing_macro_works [INFO] [stdout] traced_span_tests::async_tracing_macro_works_with_other_level [INFO] [stdout] traced_span_tests::tracing_macro_works [INFO] [stdout] [INFO] [stdout] test result: FAILED. 3 passed; 3 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.45s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass '--test tests' [INFO] running `Command { std: "docker" "inspect" "ebc1f10d72ba9e2c444b3b9d35dfe1f535726f0bf29cc9fbdfb4bbf45c094c7d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "ebc1f10d72ba9e2c444b3b9d35dfe1f535726f0bf29cc9fbdfb4bbf45c094c7d", kill_on_drop: false }` [INFO] [stdout] ebc1f10d72ba9e2c444b3b9d35dfe1f535726f0bf29cc9fbdfb4bbf45c094c7d