[INFO] fetching crate tracing 0.1.21... [INFO] testing tracing-0.1.21 against try#eafdee2dfae8c2233b74f98b123308be7ccefcc6 for pr-79296 [INFO] extracting crate tracing 0.1.21 into /workspace/builds/worker-12/source [INFO] validating manifest of crates.io crate tracing 0.1.21 on toolchain eafdee2dfae8c2233b74f98b123308be7ccefcc6 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "read-manifest" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] started tweaking crates.io crate tracing 0.1.21 [INFO] finished tweaking crates.io crate tracing 0.1.21 [INFO] tweaked toml for crates.io crate tracing 0.1.21 written to /workspace/builds/worker-12/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 70ba3d3608af79cd1e8c1c7085fb3209ca155ca6b355017c4188ca3f6f02dfd3 [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" "70ba3d3608af79cd1e8c1c7085fb3209ca155ca6b355017c4188ca3f6f02dfd3", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "70ba3d3608af79cd1e8c1c7085fb3209ca155ca6b355017c4188ca3f6f02dfd3", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "70ba3d3608af79cd1e8c1c7085fb3209ca155ca6b355017c4188ca3f6f02dfd3", kill_on_drop: false }` [INFO] [stdout] 70ba3d3608af79cd1e8c1c7085fb3209ca155ca6b355017c4188ca3f6f02dfd3 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=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" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 8dbfa722b5cf2095dd92d3c87732615ad1c0b35740a218f16ef63e7958cfd948 [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" "8dbfa722b5cf2095dd92d3c87732615ad1c0b35740a218f16ef63e7958cfd948", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling pin-project-lite v0.1.11 [INFO] [stderr] Compiling tracing-core v0.1.17 [INFO] [stderr] Compiling tracing v0.1.21 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 2.11s [INFO] running `Command { std: "docker" "inspect" "8dbfa722b5cf2095dd92d3c87732615ad1c0b35740a218f16ef63e7958cfd948", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8dbfa722b5cf2095dd92d3c87732615ad1c0b35740a218f16ef63e7958cfd948", kill_on_drop: false }` [INFO] [stdout] 8dbfa722b5cf2095dd92d3c87732615ad1c0b35740a218f16ef63e7958cfd948 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=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" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] bb70ff7328d0876e83d8e94792c7e65df092821824130efb9cf1502ec517f469 [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" "bb70ff7328d0876e83d8e94792c7e65df092821824130efb9cf1502ec517f469", kill_on_drop: false }` [INFO] [stderr] Compiling serde v1.0.117 [INFO] [stderr] Compiling const_fn v0.4.3 [INFO] [stderr] Compiling semver-parser v0.7.0 [INFO] [stderr] Compiling memchr v2.3.4 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling bitflags v1.2.1 [INFO] [stderr] Compiling unicode-width v0.1.8 [INFO] [stderr] Compiling log v0.4.11 [INFO] [stderr] Compiling slab v0.4.2 [INFO] [stderr] Compiling bytes v0.5.6 [INFO] [stderr] Compiling oorandom v11.1.3 [INFO] [stderr] Compiling futures v0.1.30 [INFO] [stderr] Compiling crossbeam-utils v0.8.1 [INFO] [stderr] Compiling memoffset v0.6.1 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling rayon v1.5.0 [INFO] [stderr] Compiling regex v1.4.2 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling semver v0.9.0 [INFO] [stderr] Compiling clap v2.33.3 [INFO] [stderr] Compiling tokio v0.2.23 [INFO] [stderr] Compiling rustc_version v0.2.3 [INFO] [stderr] Compiling csv-core v0.1.10 [INFO] [stderr] Compiling crossbeam-channel v0.5.0 [INFO] [stderr] Compiling cast v0.2.3 [INFO] [stderr] Compiling crossbeam-epoch v0.9.1 [INFO] [stderr] Compiling criterion-plot v0.4.3 [INFO] [stderr] Compiling plotters v0.2.15 [INFO] [stderr] Compiling crossbeam-deque v0.8.0 [INFO] [stderr] Compiling rayon-core v1.9.0 [INFO] [stderr] Compiling bstr v0.2.14 [INFO] [stderr] Compiling serde_json v1.0.59 [INFO] [stderr] Compiling serde_cbor v0.11.1 [INFO] [stderr] Compiling csv v1.1.5 [INFO] [stderr] Compiling tinytemplate v1.1.0 [INFO] [stderr] Compiling criterion v0.3.3 [INFO] [stderr] Compiling tracing v0.1.21 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 1m 51s [INFO] running `Command { std: "docker" "inspect" "bb70ff7328d0876e83d8e94792c7e65df092821824130efb9cf1502ec517f469", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "bb70ff7328d0876e83d8e94792c7e65df092821824130efb9cf1502ec517f469", kill_on_drop: false }` [INFO] [stdout] bb70ff7328d0876e83d8e94792c7e65df092821824130efb9cf1502ec517f469 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=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" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 784d766c94502a12f6722aaf4bd34c55b36095acb5395e28f9086fa4ea38446b [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" "784d766c94502a12f6722aaf4bd34c55b36095acb5395e28f9086fa4ea38446b", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.71s [INFO] [stdout] [INFO] [stderr] Running /opt/rustwide/target/debug/deps/tracing-1d848a432a286dae [INFO] [stdout] running 0 tests [INFO] [stderr] Running /opt/rustwide/target/debug/deps/event-33a91d7df7e2c89e [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 16 tests [INFO] [stdout] test borrowed_field ... ok [INFO] [stdout] test both_shorthands ... ok [INFO] [stdout] test event_with_message ... ok [INFO] [stdout] test moved_field ... ok [INFO] [stdout] test event_without_message ... ok [INFO] [stdout] test debug_shorthand ... ok [INFO] [stdout] test string_message_without_delims ... ok [INFO] [stdout] test display_shorthand ... ok [INFO] [stdout] test dotted_field_name ... ok [INFO] [stdout] test explicit_child_at_levels ... ok [INFO] [stdout] test message_without_delims ... ok [INFO] [stdout] test move_field_out_of_struct ... ok [INFO] [stdout] test explicit_child ... ok [INFO] [stdout] test one_with_everything ... ok [INFO] [stdout] test nonzeroi32_event_without_message ... ok [INFO] [stdout] test wrapping_event_without_message ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stderr] Running /opt/rustwide/target/debug/deps/filter_caching_is_lexically_scoped-2449d136d37267d0 [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 [INFO] [stdout] [INFO] [stderr] Running /opt/rustwide/target/debug/deps/filters_are_not_reevaluated_for_the_same_span-83632fdb7566a68a [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 [INFO] [stdout] [INFO] [stderr] Running /opt/rustwide/target/debug/deps/filters_are_reevaluated_for_different_call_sites-ac082a36c557879a [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stderr] Running /opt/rustwide/target/debug/deps/filters_dont_leak-cf1c2d7179d717c8 [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 [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test spans_dont_leak ... ok [INFO] [stderr] Running /opt/rustwide/target/debug/deps/macro_imports-1d7fd71d4f32aa58 [INFO] [stdout] test events_dont_leak ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [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 [INFO] [stdout] [INFO] [stderr] Running /opt/rustwide/target/debug/deps/macros-9f88da7a7e6d6d47 [INFO] [stdout] [INFO] [stdout] running 43 tests [INFO] [stdout] test error_with_parent ... ok [INFO] [stdout] test debug_span ... ok [INFO] [stdout] test debug_span_root ... ok [INFO] [stdout] test event_root ... ok [INFO] [stdout] test event ... ok [INFO] [stdout] test field_shorthand_only ... ok [INFO] [stdout] test error_span_with_parent ... ok [INFO] [stdout] test info_root ... ok [INFO] [stdout] test error_span ... ok [INFO] [stdout] test error_span_root ... ok [INFO] [stdout] test borrow_val_events ... ok [INFO] [stdout] test info_span_root ... ok [INFO] [stdout] test info_span_with_parent ... ok [INFO] [stdout] test event_with_parent ... ok [INFO] [stdout] test info ... ok [INFO] [stdout] test borrow_val_spans ... ok [INFO] [stdout] test callsite_macro_api ... ok [INFO] [stdout] test debug_span_with_parent ... ok [INFO] [stdout] test span_with_non_rust_symbol ... ok [INFO] [stdout] test info_span ... ok [INFO] [stdout] test locals_with_message ... ok [INFO] [stdout] test span_root ... ok [INFO] [stdout] test locals_no_message ... ok [INFO] [stdout] test span_with_parent ... ok [INFO] [stdout] test error_root ... ok [INFO] [stdout] test info_with_parent ... ok [INFO] [stdout] test trace_span ... ok [INFO] [stdout] test trace_span_with_parent ... ok [INFO] [stdout] test span ... ok [INFO] [stdout] test debug_root ... ok [INFO] [stdout] test error ... ok [INFO] [stdout] test warn_span_with_parent ... ok [INFO] [stdout] test debug_with_parent ... ok [INFO] [stdout] test debug ... ok [INFO] [stdout] test trace_root ... ok [INFO] [stdout] test trace ... ok [INFO] [stdout] test warn_with_parent ... ok [INFO] [stdout] test trace_span_root ... ok [INFO] [stdout] test warn_span_root ... ok [INFO] [stdout] test warn_span ... ok [INFO] [stdout] test trace_with_parent ... ok [INFO] [stdout] test warn_root ... ok [INFO] [stdout] test warn ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 43 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stderr] Running /opt/rustwide/target/debug/deps/max_level_hint-73b553815cd17746 [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 [INFO] [stdout] [INFO] [stderr] Running /opt/rustwide/target/debug/deps/multiple_max_level_hints-ef7a6a12a5be7ba0 [INFO] [stdout] [INFO] [stderr] Running /opt/rustwide/target/debug/deps/span-71b231691b1fec11 [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 [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 31 tests [INFO] [stdout] test explicit_child ... ok [INFO] [stdout] test both_shorthands ... ok [INFO] [stdout] test debug_shorthand ... ok [INFO] [stdout] test dotted_field_name ... ok [INFO] [stdout] test enter ... ok [INFO] [stdout] test contextual_root ... ok [INFO] [stdout] test display_shorthand ... ok [INFO] [stdout] test borrowed_field ... ok [INFO] [stdout] test contextual_child ... ok [INFO] [stdout] test cloning_a_span_calls_clone_span ... ok [INFO] [stdout] test drop_span_when_exiting_dispatchers_context ... ok [INFO] [stdout] test explicit_child_at_levels ... ok [INFO] [stdout] test explicit_root_span_is_root ... ok [INFO] [stdout] test moved_field ... ok [INFO] [stdout] test clone_and_drop_span_always_go_to_the_subscriber_that_tagged_the_span ... ok [INFO] [stdout] test handles_to_different_spans_with_the_same_metadata_are_not_equal ... ok [INFO] [stdout] test new_span_after_event ... ok [INFO] [stdout] test event_outside_of_span ... ok [INFO] [stdout] test handles_to_different_spans_are_not_equal ... ok [INFO] [stdout] test explicit_root_span_is_root_regardless_of_ctx ... ok [INFO] [stdout] test new_span_with_target_and_log_level ... ok [INFO] [stdout] test move_field_out_of_struct ... ok [INFO] [stdout] test handles_to_the_same_span_are_equal ... ok [INFO] [stdout] test record_new_values_for_fields ... ok [INFO] [stdout] test explicit_child_regardless_of_ctx ... ok [INFO] [stdout] test record_new_value_for_field ... ok [INFO] [stdout] test dropping_a_span_calls_drop_span ... ok [INFO] [stdout] test spans_always_go_to_the_subscriber_that_tagged_them ... ok [INFO] [stdout] test span_closes_when_exited ... ok [INFO] [stdout] test span_closes_after_event ... ok [INFO] [stdout] test spans_always_go_to_the_subscriber_that_tagged_them_even_across_threads ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stderr] Running /opt/rustwide/target/debug/deps/subscriber-f26f38fb21512d17 [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test event_macros_dont_infinite_loop ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stderr] Doc-tests tracing [INFO] [stdout] [INFO] [stdout] running 69 tests [INFO] [stdout] test src/lib.rs - (line 165) ... ignored [INFO] [stdout] test src/lib.rs - (line 214) ... ok [INFO] [stdout] test src/lib.rs - (line 191) ... ok [INFO] [stdout] test src/lib.rs - (line 312) ... ok [INFO] [stdout] test src/lib.rs - (line 278) ... ok [INFO] [stdout] test src/instrument.rs - instrument::Instrument::instrument (line 23) ... ok [INFO] [stdout] test src/lib.rs - (line 299) ... ok [INFO] [stdout] test src/lib.rs - (line 482) ... ignored [INFO] [stdout] test src/dispatcher.rs - dispatcher (line 48) ... ok [INFO] [stdout] test src/lib.rs - (line 141) ... ok [INFO] [stdout] test src/lib.rs - (line 253) ... ok [INFO] [stdout] test src/dispatcher.rs - dispatcher (line 83) ... ok [INFO] [stdout] test src/dispatcher.rs - dispatcher (line 25) ... ok [INFO] [stdout] test src/lib.rs - (line 222) ... ok [INFO] [stdout] test src/lib.rs - (line 239) ... ok [INFO] [stdout] test src/lib.rs - (line 266) ... ok [INFO] [stdout] test src/lib.rs - (line 334) ... ok [INFO] [stdout] test src/instrument.rs - instrument::Instrument::in_current_span (line 54) ... ok [INFO] [stdout] test src/lib.rs - (line 392) ... ok [INFO] [stdout] test src/macros.rs - debug_span (line 238) ... ok [INFO] [stdout] test src/lib.rs - (line 355) ... ok [INFO] [stdout] test src/lib.rs - (line 376) ... ok [INFO] [stdout] test src/macros.rs - debug_span (line 229) ... ok [INFO] [stdout] test src/lib.rs - (line 42) ... ok [INFO] [stdout] test src/lib.rs - (line 560) ... ok [INFO] [stdout] test src/macros.rs - error (line 1631) ... ok [INFO] [stdout] test src/lib.rs - (line 415) ... ok [INFO] [stdout] test src/macros.rs - error_span (line 471) ... ok [INFO] [stdout] test src/macros.rs - debug (line 1013) ... ok [INFO] [stdout] test src/macros.rs - error_span (line 480) ... ok [INFO] [stdout] test src/lib.rs - (line 75) ... ok [INFO] [stdout] test src/lib.rs - (line 602) ... ok [INFO] [stdout] test src/macros.rs - event (line 550) ... ok [INFO] [stdout] test src/macros.rs - info_span (line 319) ... ok [INFO] [stdout] test src/macros.rs - info_span (line 310) ... ok [INFO] [stdout] test src/macros.rs - info (line 1214) ... ok [INFO] [stdout] test src/macros.rs - span (line 11) ... ok [INFO] [stdout] test src/macros.rs - trace (line 813) ... ok [INFO] [stdout] test src/span.rs - span (line 275) ... ok [INFO] [stdout] test src/span.rs - span::Span::enter (line 629) ... ignored [INFO] [stdout] test src/span.rs - span::Span::enter (line 654) ... ignored [INFO] [stdout] test src/span.rs - span::Span::enter (line 672) ... ignored [INFO] [stdout] test src/span.rs - span (line 198) ... ok [INFO] [stdout] test src/macros.rs - trace_span (line 148) ... ok [INFO] [stdout] test src/macros.rs - trace_span (line 157) ... ok [INFO] [stdout] test src/span.rs - span (line 132) ... ok [INFO] [stdout] test src/macros.rs - warn (line 1426) ... ok [INFO] [stdout] test src/span.rs - span (line 240) ... ok [INFO] [stdout] test src/macros.rs - warn_span (line 391) ... ok [INFO] [stdout] test src/macros.rs - warn_span (line 400) ... ok [INFO] [stdout] test src/span.rs - span (line 288) ... ok [INFO] [stdout] test src/span.rs - span (line 154) ... ok [INFO] [stdout] test src/span.rs - span::Span::enter (line 709) ... ok [INFO] [stdout] test src/span.rs - span::Span::enter (line 693) ... ok [INFO] [stdout] test src/span.rs - span (line 31) ... ok [INFO] [stdout] test src/span.rs - span (line 66) ... ok [INFO] [stdout] test src/span.rs - span (line 94) ... ok [INFO] [stdout] test src/span.rs - span::Span::enter (line 604) ... ok [INFO] [stdout] test src/span.rs - span::Span::enter (line 574) ... ok [INFO] [stdout] test src/span.rs - span::Span::enter (line 731) ... ok [INFO] [stdout] test src/span.rs - span::Span::in_scope (line 787) ... ok [INFO] [stdout] test src/span.rs - span::Span::follows_from (line 1000) ... ok [INFO] [stdout] test src/span.rs - span::Span::follows_from (line 977) ... ok [INFO] [stdout] test src/span.rs - span::Span::follows_from (line 992) ... ok [INFO] [stdout] test src/span.rs - span::Span::record (line 826) ... ok [INFO] [stdout] test src/span.rs - span::Span::follows_from (line 985) ... ok [INFO] [stdout] test src/span.rs - span::Span::in_scope (line 772) ... ok [INFO] [stdout] test src/span.rs - span::Span::record (line 841) ... ok [INFO] [stdout] test src/span.rs - span::Span::record (line 872) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 64 passed; 0 failed; 5 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "784d766c94502a12f6722aaf4bd34c55b36095acb5395e28f9086fa4ea38446b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "784d766c94502a12f6722aaf4bd34c55b36095acb5395e28f9086fa4ea38446b", kill_on_drop: false }` [INFO] [stdout] 784d766c94502a12f6722aaf4bd34c55b36095acb5395e28f9086fa4ea38446b