[INFO] fetching crate tracing 0.1.29... [INFO] testing tracing-0.1.29 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031 [INFO] extracting crate tracing 0.1.29 into /workspace/builds/worker-119/source [INFO] validating manifest of crates.io crate tracing 0.1.29 on toolchain 722e1797249a965b6335aebd65d777f917e498f1 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate tracing 0.1.29 [INFO] finished tweaking crates.io crate tracing 0.1.29 [INFO] tweaked toml for crates.io crate tracing 0.1.29 written to /workspace/builds/worker-119/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] df487d34b4dcb2559f378af1497ae728503b1eb41229674f05dbd31f72f2ace1 [INFO] running `Command { std: "docker" "start" "-a" "df487d34b4dcb2559f378af1497ae728503b1eb41229674f05dbd31f72f2ace1", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "df487d34b4dcb2559f378af1497ae728503b1eb41229674f05dbd31f72f2ace1", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "df487d34b4dcb2559f378af1497ae728503b1eb41229674f05dbd31f72f2ace1", kill_on_drop: false }` [INFO] [stdout] df487d34b4dcb2559f378af1497ae728503b1eb41229674f05dbd31f72f2ace1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 1bd6af420fa7a1822139b793387cf9148b1cc3cfb7752654354de8972cdc1598 [INFO] running `Command { std: "docker" "start" "-a" "1bd6af420fa7a1822139b793387cf9148b1cc3cfb7752654354de8972cdc1598", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling proc-macro2 v1.0.32 [INFO] [stderr] Compiling syn v1.0.81 [INFO] [stderr] Compiling pin-project-lite v0.2.7 [INFO] [stderr] Compiling tracing-core v0.1.21 [INFO] [stderr] Compiling quote v1.0.10 [INFO] [stderr] Compiling tracing-attributes v0.1.18 [INFO] [stderr] Compiling tracing v0.1.29 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 22.11s [INFO] running `Command { std: "docker" "inspect" "1bd6af420fa7a1822139b793387cf9148b1cc3cfb7752654354de8972cdc1598", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "1bd6af420fa7a1822139b793387cf9148b1cc3cfb7752654354de8972cdc1598", kill_on_drop: false }` [INFO] [stdout] 1bd6af420fa7a1822139b793387cf9148b1cc3cfb7752654354de8972cdc1598 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 1fd8347f10ba788a59339044d9e43e128dca939fe7017b1ce54b36aca7fc2c78 [INFO] running `Command { std: "docker" "start" "-a" "1fd8347f10ba788a59339044d9e43e128dca939fe7017b1ce54b36aca7fc2c78", kill_on_drop: false }` [INFO] [stderr] Compiling crossbeam-utils v0.8.5 [INFO] [stderr] Compiling semver v1.0.4 [INFO] [stderr] Compiling libc v0.2.108 [INFO] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling crossbeam-epoch v0.9.5 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling rayon-core v1.9.1 [INFO] [stderr] Compiling serde_json v1.0.71 [INFO] [stderr] Compiling either v1.6.1 [INFO] [stderr] Compiling itoa v0.4.8 [INFO] [stderr] Compiling plotters-backend v0.3.2 [INFO] [stderr] Compiling unicode-width v0.1.9 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling half v1.8.2 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling oorandom v11.1.3 [INFO] [stderr] Compiling pin-project-lite v0.1.12 [INFO] [stderr] Compiling bytes v0.5.6 [INFO] [stderr] Compiling slab v0.4.5 [INFO] [stderr] Compiling futures v0.1.31 [INFO] [stderr] Compiling memoffset v0.6.4 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling rayon v1.5.1 [INFO] [stderr] Compiling serde_derive v1.0.130 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling itertools v0.10.1 [INFO] [stderr] Compiling serde_cbor v0.11.2 [INFO] [stderr] Compiling plotters-svg v0.3.1 [INFO] [stderr] Compiling clap v2.33.3 [INFO] [stderr] Compiling tokio v0.2.25 [INFO] [stderr] Compiling crossbeam-channel v0.5.1 [INFO] [stderr] Compiling rustc_version v0.4.0 [INFO] [stderr] Compiling bstr v0.2.17 [INFO] [stderr] Compiling csv-core v0.1.10 [INFO] [stderr] Compiling crossbeam-deque v0.8.1 [INFO] [stderr] Compiling cast v0.2.7 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling csv v1.1.6 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling plotters v0.3.1 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling criterion-plot v0.4.4 [INFO] [stderr] Compiling criterion v0.3.5 [INFO] [stderr] Compiling tracing v0.1.29 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 16.10s [INFO] running `Command { std: "docker" "inspect" "1fd8347f10ba788a59339044d9e43e128dca939fe7017b1ce54b36aca7fc2c78", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "1fd8347f10ba788a59339044d9e43e128dca939fe7017b1ce54b36aca7fc2c78", kill_on_drop: false }` [INFO] [stdout] 1fd8347f10ba788a59339044d9e43e128dca939fe7017b1ce54b36aca7fc2c78 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] c5f97cf875006030e1d990310bf71b138d6c010e685b90bfbd8b02e6eab6ab2d [INFO] running `Command { std: "docker" "start" "-a" "c5f97cf875006030e1d990310bf71b138d6c010e685b90bfbd8b02e6eab6ab2d", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.49s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/tracing-4837f17c6a9dc630) [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/event.rs (/opt/rustwide/target/debug/deps/event-e322892313666a0e) [INFO] [stdout] [INFO] [stdout] running 19 tests [INFO] [stdout] test borrowed_field ... ok [INFO] [stdout] test both_shorthands ... ok [INFO] [stdout] test debug_shorthand ... ok [INFO] [stdout] test dotted_field_name ... ok [INFO] [stdout] test event_without_message ... ok [INFO] [stdout] test event_with_message ... ok [INFO] [stdout] test display_shorthand ... ok [INFO] [stdout] test explicit_child ... ok [INFO] [stdout] test message_without_delims ... ok [INFO] [stdout] test moved_field ... ok [INFO] [stdout] test nonzeroi32_event_without_message ... ok [INFO] [stdout] test move_field_out_of_struct ... ok [INFO] [stdout] test option_values ... ok [INFO] [stdout] test option_ref_values ... ok [INFO] [stdout] test option_ref_mut_values ... ok [INFO] [stdout] test wrapping_event_without_message ... ok [INFO] [stdout] test one_with_everything ... ok [INFO] [stdout] test string_message_without_delims ... ok [INFO] [stdout] test explicit_child_at_levels ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running tests/filter_caching_is_lexically_scoped.rs (/opt/rustwide/target/debug/deps/filter_caching_is_lexically_scoped-42de7513fa7cb66f) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test filter_caching_is_lexically_scoped ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/filters_are_not_reevaluated_for_the_same_span.rs (/opt/rustwide/target/debug/deps/filters_are_not_reevaluated_for_the_same_span-ddf03f7067b8c965) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test filters_are_not_reevaluated_for_the_same_span ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/filters_are_reevaluated_for_different_call_sites.rs (/opt/rustwide/target/debug/deps/filters_are_reevaluated_for_different_call_sites-7efe2036c6a6ff35) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test filters_are_reevaluated_for_different_call_sites ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/filters_dont_leak.rs (/opt/rustwide/target/debug/deps/filters_dont_leak-357210d503a6934f) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test events_dont_leak ... ok [INFO] [stdout] test spans_dont_leak ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/macro_imports.rs (/opt/rustwide/target/debug/deps/macro_imports-aedde3f7493b237e) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test prefixed_event_macros ... ok [INFO] [stdout] test prefixed_span_macros ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/macros.rs (/opt/rustwide/target/debug/deps/macros-af340bc6647946b4) [INFO] [stdout] [INFO] [stdout] running 43 tests [INFO] [stderr] Running tests/max_level_hint.rs (/opt/rustwide/target/debug/deps/max_level_hint-945c589d95e5e91c) [INFO] [stdout] test borrow_val_events ... ok [INFO] [stdout] test callsite_macro_api ... ok [INFO] [stdout] test borrow_val_spans ... ok [INFO] [stdout] test debug ... ok [INFO] [stdout] test debug_span ... ok [INFO] [stdout] test debug_root ... ok [INFO] [stdout] test debug_span_root ... ok [INFO] [stdout] test debug_span_with_parent ... ok [INFO] [stdout] test debug_with_parent ... ok [INFO] [stdout] test error_span ... ok [INFO] [stdout] test error ... ok [INFO] [stdout] test error_root ... ok [INFO] [stdout] test error_span_with_parent ... ok [INFO] [stdout] test error_span_root ... ok [INFO] [stdout] test error_with_parent ... ok [INFO] [stdout] test event ... ok [INFO] [stdout] test event_root ... ok [INFO] [stdout] test info_span ... ok [INFO] [stdout] test field_shorthand_only ... ok [INFO] [stdout] test info_root ... ok [INFO] [stdout] test info ... ok [INFO] [stdout] test info_span_root ... ok [INFO] [stdout] test event_with_parent ... ok [INFO] [stdout] test info_span_with_parent ... ok [INFO] [stdout] test info_with_parent ... ok [INFO] [stdout] test locals_no_message ... ok [INFO] [stdout] test locals_with_message ... ok [INFO] [stdout] test span ... ok [INFO] [stdout] test span_root ... ok [INFO] [stdout] test span_with_non_rust_symbol ... ok [INFO] [stdout] test span_with_parent ... ok [INFO] [stdout] test trace_root ... ok [INFO] [stdout] test trace ... ok [INFO] [stdout] test trace_span ... ok [INFO] [stdout] test trace_span_root ... ok [INFO] [stdout] test trace_span_with_parent ... ok [INFO] [stdout] test trace_with_parent ... ok [INFO] [stdout] test warn ... ok [INFO] [stdout] test warn_span ... ok [INFO] [stdout] test warn_span_root ... ok [INFO] [stdout] test warn_root ... ok [INFO] [stdout] test warn_span_with_parent ... ok [INFO] [stdout] test warn_with_parent ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 43 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s [INFO] [stdout] [INFO] [stderr] Running tests/multiple_max_level_hints.rs (/opt/rustwide/target/debug/deps/multiple_max_level_hints-8396a761a2f5afe2) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test max_level_hints ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test multiple_max_level_hints ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/span.rs (/opt/rustwide/target/debug/deps/span-d5f41ea7f366db54) [INFO] [stdout] [INFO] [stdout] running 34 tests [INFO] [stdout] test both_shorthands ... ok [INFO] [stdout] test borrowed_field ... ok [INFO] [stdout] test cloning_a_span_calls_clone_span ... ok [INFO] [stdout] test clone_and_drop_span_always_go_to_the_subscriber_that_tagged_the_span ... ok [INFO] [stdout] test dotted_field_name ... ok [INFO] [stdout] test drop_span_when_exiting_dispatchers_context ... ok [INFO] [stdout] test contextual_root ... ok [INFO] [stdout] test contextual_child ... ok [INFO] [stdout] test debug_shorthand ... ok [INFO] [stdout] test dropping_a_span_calls_drop_span ... ok [INFO] [stdout] test move_field_out_of_struct ... ok [INFO] [stdout] test span_closes_after_event ... ok [INFO] [stdout] test entered ... ok [INFO] [stdout] test handles_to_different_spans_are_not_equal ... ok [INFO] [stdout] test moved_field ... ok [INFO] [stdout] test event_outside_of_span ... ok [INFO] [stdout] test record_new_values_for_fields ... ok [INFO] [stdout] test display_shorthand ... ok [INFO] [stdout] test float_values ... ok [INFO] [stdout] test explicit_root_span_is_root_regardless_of_ctx ... ok [INFO] [stdout] test handles_to_different_spans_with_the_same_metadata_are_not_equal ... ok [INFO] [stdout] test handles_to_the_same_span_are_equal ... ok [INFO] [stdout] test new_span_after_event ... ok [INFO] [stdout] test entered_api ... ok [INFO] [stdout] test new_span_with_target_and_log_level ... ok [INFO] [stdout] test span_closes_when_exited ... ok [INFO] [stdout] test spans_always_go_to_the_subscriber_that_tagged_them ... ok [INFO] [stdout] test explicit_root_span_is_root ... ok [INFO] [stdout] test explicit_child_at_levels ... ok [INFO] [stdout] test explicit_child ... ok [INFO] [stdout] test enter ... ok [INFO] [stdout] test record_new_value_for_field ... ok [INFO] [stdout] test explicit_child_regardless_of_ctx ... ok [INFO] [stderr] Running tests/subscriber.rs (/opt/rustwide/target/debug/deps/subscriber-96d652db4258f6ae) [INFO] [stdout] test spans_always_go_to_the_subscriber_that_tagged_them_even_across_threads ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test boxed_subscriber ... ok [INFO] [stdout] test arced_subscriber ... ok [INFO] [stdout] test event_macros_dont_infinite_loop ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Doc-tests tracing [INFO] [stdout] [INFO] [stdout] running 84 tests [INFO] [stdout] test src/lib.rs - (line 158) ... ignored [INFO] [stdout] test src/lib.rs - (line 479) ... ignored [INFO] [stdout] test src/span.rs - span::Span::enter (line 662) ... ignored [INFO] [stdout] test src/span.rs - span::Span::enter (line 686) ... ignored [INFO] [stdout] test src/span.rs - span::Span::enter (line 703) ... ignored [INFO] [stdout] test src/lib.rs - (line 391) - compile fail ... ok [INFO] [stdout] test src/span.rs - span (line 159) ... FAILED [INFO] [stdout] test src/macros.rs - macros::trace (line 805) ... FAILED [INFO] [stdout] test src/span.rs - span::Span::follows_from (line 1298) ... FAILED [INFO] [stdout] test src/span.rs - span::Span::entered (line 809) ... FAILED [INFO] [stdout] test src/span.rs - span (line 90) ... FAILED [INFO] [stdout] test src/span.rs - span (line 138) ... FAILED [INFO] [stdout] test src/span.rs - span::Span::or_current (line 963) ... FAILED [INFO] [stdout] test src/span.rs - span::Span::enter (line 724) ... FAILED [INFO] [stdout] test src/span.rs - span::Span::or_current (line 941) ... FAILED [INFO] [stdout] test src/span.rs - span::Span::record (line 1141) ... FAILED [INFO] [stdout] test src/span.rs - span (line 243) ... FAILED [INFO] [stdout] test src/span.rs - span::Span::entered (line 838) ... FAILED [INFO] [stdout] test src/span.rs - span::Span::record (line 1126) ... FAILED [INFO] [stdout] test src/span.rs - span (line 277) ... FAILED [INFO] [stderr] error: test failed, to rerun pass '--doc' [INFO] [stderr] [INFO] [stderr] Caused by: [INFO] [stderr] process didn't exit successfully: `rustdoc --edition=2018 --crate-type lib --crate-name tracing --test /opt/rustwide/workdir/src/lib.rs -L dependency=/opt/rustwide/target/debug/deps -L dependency=/opt/rustwide/target/debug/deps --extern cfg_if=/opt/rustwide/target/debug/deps/libcfg_if-90e3626e3c41eec3.rlib --extern criterion=/opt/rustwide/target/debug/deps/libcriterion-b06d2e07b407d451.rlib --extern futures=/opt/rustwide/target/debug/deps/libfutures-0b0214b74e044a62.rlib --extern log=/opt/rustwide/target/debug/deps/liblog-d1d9e9bb2ac58ba1.rlib --extern pin_project_lite=/opt/rustwide/target/debug/deps/libpin_project_lite-c01d3460c002bb08.rlib --extern tokio=/opt/rustwide/target/debug/deps/libtokio-2c1b9d7f941cf7a6.rlib --extern tracing=/opt/rustwide/target/debug/deps/libtracing-2b6e40db38abd0f1.rlib --extern tracing_attributes=/opt/rustwide/target/debug/deps/libtracing_attributes-9b3777665437f933.so --extern tracing_core=/opt/rustwide/target/debug/deps/libtracing_core-b13817bade10c698.rlib -C embed-bitcode=no --cfg 'feature="attributes"' --cfg 'feature="default"' --cfg 'feature="std"' --cfg 'feature="tracing-attributes"' --error-format human` (signal: 9, SIGKILL: kill) [INFO] running `Command { std: "docker" "inspect" "c5f97cf875006030e1d990310bf71b138d6c010e685b90bfbd8b02e6eab6ab2d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c5f97cf875006030e1d990310bf71b138d6c010e685b90bfbd8b02e6eab6ab2d", kill_on_drop: false }` [INFO] [stdout] c5f97cf875006030e1d990310bf71b138d6c010e685b90bfbd8b02e6eab6ab2d