[INFO] fetching crate tracing-capture 0.2.0-beta.1... [INFO] testing tracing-capture-0.2.0-beta.1 against master#1ddedbaa5919b7b3e70d984660e21e844c615c97 for pr-128400 [INFO] extracting crate tracing-capture 0.2.0-beta.1 into /workspace/builds/worker-5-tc1/source [INFO] validating manifest of crates.io crate tracing-capture 0.2.0-beta.1 on toolchain 1ddedbaa5919b7b3e70d984660e21e844c615c97 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate tracing-capture 0.2.0-beta.1 [INFO] finished tweaking crates.io crate tracing-capture 0.2.0-beta.1 [INFO] tweaked toml for crates.io crate tracing-capture 0.2.0-beta.1 written to /workspace/builds/worker-5-tc1/source/Cargo.toml [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Locking 60 packages to latest compatible versions [INFO] [stderr] Adding idna v0.5.0 (latest: v1.0.2) [INFO] [stderr] Adding nu-ansi-term v0.46.0 (latest: v0.50.1) [INFO] [stderr] Adding pulldown-cmark v0.9.6 (latest: v0.11.0) [INFO] [stderr] Adding toml v0.7.8 (latest: v0.8.19) [INFO] [stderr] Adding toml_edit v0.19.15 (latest: v0.22.20) [INFO] [stderr] Adding winnow v0.5.40 (latest: v0.6.18) [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded tracing-tunnel v0.2.0-beta.1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 660ef66ef7389d17a6a0fcfc3f3c7cbd76549888db210acf67fcdd88d454760e [INFO] running `Command { std: "docker" "start" "-a" "660ef66ef7389d17a6a0fcfc3f3c7cbd76549888db210acf67fcdd88d454760e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "660ef66ef7389d17a6a0fcfc3f3c7cbd76549888db210acf67fcdd88d454760e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "660ef66ef7389d17a6a0fcfc3f3c7cbd76549888db210acf67fcdd88d454760e", kill_on_drop: false }` [INFO] [stdout] 660ef66ef7389d17a6a0fcfc3f3c7cbd76549888db210acf67fcdd88d454760e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/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" "RUSTDOCFLAGS=--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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] ced88633bc25a0c731fd23809cbe9603fb9f343612255883d64e1769cd3cc084 [INFO] running `Command { std: "docker" "start" "-a" "ced88633bc25a0c731fd23809cbe9603fb9f343612255883d64e1769cd3cc084", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.86 [INFO] [stderr] Compiling serde v1.0.204 [INFO] [stderr] Compiling predicates-core v1.0.8 [INFO] [stderr] Compiling anstyle v1.0.8 [INFO] [stderr] Compiling id-arena v2.2.1 [INFO] [stderr] Compiling tracing-subscriber v0.3.18 [INFO] [stderr] Compiling predicates v3.1.2 [INFO] [stderr] Compiling quote v1.0.36 [INFO] [stderr] Compiling syn v2.0.72 [INFO] [stderr] Compiling serde_derive v1.0.204 [INFO] [stderr] Compiling tracing-tunnel v0.2.0-beta.1 [INFO] [stderr] Compiling tracing-capture v0.2.0-beta.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 8.30s [INFO] running `Command { std: "docker" "inspect" "ced88633bc25a0c731fd23809cbe9603fb9f343612255883d64e1769cd3cc084", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "ced88633bc25a0c731fd23809cbe9603fb9f343612255883d64e1769cd3cc084", kill_on_drop: false }` [INFO] [stdout] ced88633bc25a0c731fd23809cbe9603fb9f343612255883d64e1769cd3cc084 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/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" "RUSTDOCFLAGS=--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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 3f99b818b479aff6ab24fbb210cca600cc34b60051b9874505c417db5024f93e [INFO] running `Command { std: "docker" "start" "-a" "3f99b818b479aff6ab24fbb210cca600cc34b60051b9874505c417db5024f93e", kill_on_drop: false }` [INFO] [stderr] Compiling unicode-ident v1.0.12 [INFO] [stderr] Compiling proc-macro2 v1.0.86 [INFO] [stderr] Compiling winnow v0.5.40 [INFO] [stderr] Compiling pulldown-cmark v0.9.6 [INFO] [stderr] Compiling unicase v2.7.0 [INFO] [stderr] Compiling regex-syntax v0.8.4 [INFO] [stderr] Compiling semver v1.0.23 [INFO] [stderr] Compiling doc-comment v0.3.3 [INFO] [stderr] Compiling tracing-subscriber v0.3.18 [INFO] [stderr] Compiling assert_matches v1.5.0 [INFO] [stderr] Compiling quote v1.0.36 [INFO] [stderr] Compiling syn v2.0.72 [INFO] [stderr] Compiling regex-automata v0.4.7 [INFO] [stderr] Compiling regex v1.10.6 [INFO] [stderr] Compiling serde_derive v1.0.204 [INFO] [stderr] Compiling tracing-attributes v0.1.27 [INFO] [stderr] Compiling tracing v0.1.40 [INFO] [stderr] Compiling serde v1.0.204 [INFO] [stderr] Compiling toml_datetime v0.6.8 [INFO] [stderr] Compiling serde_spanned v0.6.7 [INFO] [stderr] Compiling tracing-tunnel v0.2.0-beta.1 [INFO] [stderr] Compiling toml_edit v0.19.15 [INFO] [stderr] Compiling tracing-capture v0.2.0-beta.1 (/opt/rustwide/workdir) [INFO] [stderr] Compiling toml v0.7.8 [INFO] [stderr] Compiling version-sync v0.9.5 [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 10.48s [INFO] running `Command { std: "docker" "inspect" "3f99b818b479aff6ab24fbb210cca600cc34b60051b9874505c417db5024f93e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3f99b818b479aff6ab24fbb210cca600cc34b60051b9874505c417db5024f93e", kill_on_drop: false }` [INFO] [stdout] 3f99b818b479aff6ab24fbb210cca600cc34b60051b9874505c417db5024f93e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/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" "RUSTDOCFLAGS=--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:923055f121b5182466d55868a8b05e67af8ba4a3a3f6bad814e953ca3cd3ac2a" "/opt/rustwide/cargo-home/bin/cargo" "+1ddedbaa5919b7b3e70d984660e21e844c615c97" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 244e8b6b237207c8908b782fb70d89f14418a461178a80a0a80aaf4de53a9e2a [INFO] running `Command { std: "docker" "start" "-a" "244e8b6b237207c8908b782fb70d89f14418a461178a80a0a80aaf4de53a9e2a", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tracing_capture-a73c6550169dba44) [INFO] [stdout] [INFO] [stdout] running 7 tests [INFO] [stdout] test predicates::tests::compound_predicates ... ok [INFO] [stdout] test predicates::tests::level_predicates ... ok [INFO] [stdout] test predicates::tests::message_predicates ... ok [INFO] [stdout] test predicates::tests::name_predicates ... ok [INFO] [stdout] test predicates::tests::using_extensions ... ok [INFO] [stdout] test predicates::tests::compound_predicates_combining_and_or ... ok [INFO] [stdout] test predicates::tests::target_predicates ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/integration/main.rs (/opt/rustwide/target/debug/deps/integration-e58683c54f0c3b19) [INFO] [stdout] [INFO] [stdout] running 12 tests [INFO] [stdout] test capturing_spans_directly ... ok [INFO] [stdout] test explicit_parent_is_correctly_handled ... ok [INFO] [stdout] test capturing_events_with_indirect_ancestor ... ok [INFO] [stdout] test capturing_span_hierarchy ... ok [INFO] [stdout] test recorded_span_values_are_restored ... ok [INFO] [stdout] test capturing_spans_for_replayed_events ... ok [INFO] [stdout] test capturing_wide_span_graph ... ok [INFO] [stdout] test items_from_different_storages_are_not_comparable ... ok [INFO] [stdout] test replayed_spans_are_closed_if_entered_multiple_times ... ok [INFO] [stdout] test spans_are_exited_on_receiver_drop ... ok [INFO] [stdout] test failed_assertion_while_storage_is_locked ... ok [INFO] [stdout] test recording_follows_from_relations ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stderr] Running tests/version_match.rs (/opt/rustwide/target/debug/deps/version_match-739db40881a9c640) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test readme_is_in_sync ... ok [INFO] [stdout] test html_root_url_is_in_sync ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Doc-tests tracing_capture [INFO] [stdout] [INFO] [stdout] running 15 tests [INFO] [stdout] test src/lib.rs - CapturedEvent (line 105) ... ok [INFO] [stdout] test src/lib.rs - CapturedSpan (line 243) ... ok [INFO] [stdout] test src/predicates/mod.rs - predicates (line 24) ... ok [INFO] [stdout] test src/predicates/field.rs - predicates::field::value (line 177) ... ok [INFO] [stdout] test src/predicates/mod.rs - predicates::into_fn (line 78) ... ok [INFO] [stdout] test src/predicates/name.rs - predicates::name::name (line 21) ... ok [INFO] [stdout] test src/predicates/target.rs - predicates::target::target (line 85) ... ok [INFO] [stdout] test src/predicates/parent.rs - predicates::parent::ancestor (line 96) ... ok [INFO] [stdout] test src/predicates/field.rs - predicates::field::field (line 63) ... ok [INFO] [stdout] test src/predicates/level.rs - predicates::level::level (line 63) ... ok [INFO] [stdout] test src/predicates/field.rs - predicates::field::message (line 284) ... ok [INFO] [stdout] test src/lib.rs - (line 485) ... ok [INFO] [stdout] test src/predicates/parent.rs - predicates::parent::parent (line 18) ... ok [INFO] [stdout] test src/lib.rs - (line 10) ... ok [INFO] [stdout] test src/lib.rs - (line 454) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.39s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "244e8b6b237207c8908b782fb70d89f14418a461178a80a0a80aaf4de53a9e2a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "244e8b6b237207c8908b782fb70d89f14418a461178a80a0a80aaf4de53a9e2a", kill_on_drop: false }` [INFO] [stdout] 244e8b6b237207c8908b782fb70d89f14418a461178a80a0a80aaf4de53a9e2a