[INFO] fetching crate tracing-gstreamer 0.9.0... [INFO] testing tracing-gstreamer-0.9.0 against 1.91.0 for beta-1.92-2 [INFO] extracting crate tracing-gstreamer 0.9.0 into /workspace/builds/worker-7-tc1/source [INFO] removed /workspace/builds/worker-7-tc1/source/rust-toolchain [INFO] started tweaking crates.io crate tracing-gstreamer 0.9.0 [INFO] removed 0 missing examples [INFO] finished tweaking crates.io crate tracing-gstreamer 0.9.0 [INFO] tweaked toml for crates.io crate tracing-gstreamer 0.9.0 written to /workspace/builds/worker-7-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate tracing-gstreamer 0.9.0 on toolchain 1.91.0 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.91.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate tracing-gstreamer 0.9.0 already has a lockfile, it will not be regenerated [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.91.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded tracing-tracy v0.11.4 [INFO] [stderr] Downloaded generator v0.8.5 [INFO] [stderr] Downloaded kstring v2.0.2 [INFO] [stderr] Downloaded option-operations v0.5.0 [INFO] [stderr] Downloaded tracy-client v0.18.2 [INFO] [stderr] Downloaded muldiv v1.0.1 [INFO] [stderr] Downloaded tracing-chrome v0.7.2 [INFO] [stderr] Downloaded system-deps v7.0.5 [INFO] [stderr] Downloaded gobject-sys v0.21.0 [INFO] [stderr] Downloaded cfg-expr v0.20.1 [INFO] [stderr] Downloaded tracy-client-sys v0.26.1 [INFO] [stderr] Downloaded gio-sys v0.21.0 [INFO] [stderr] Downloaded gstreamer-sys v0.24.0 [INFO] [stderr] Downloaded glib-sys v0.21.0 [INFO] [stderr] Downloaded gstreamer v0.24.0 [INFO] [stderr] Downloaded glib-macros v0.21.0 [INFO] [stderr] Downloaded glib v0.21.0 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+1.91.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 516735ae85b9d8deb008280c997edb141e1c556c47498b37e6176783ddca2bba [INFO] running `Command { std: "docker" "start" "-a" "516735ae85b9d8deb008280c997edb141e1c556c47498b37e6176783ddca2bba", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "516735ae85b9d8deb008280c997edb141e1c556c47498b37e6176783ddca2bba", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "516735ae85b9d8deb008280c997edb141e1c556c47498b37e6176783ddca2bba", kill_on_drop: false }` [INFO] [stdout] 516735ae85b9d8deb008280c997edb141e1c556c47498b37e6176783ddca2bba [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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=warn" "-e" "RUSTDOCFLAGS=--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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+1.91.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] b4df5d09e1245a31f1fbcca75b2e209dde3d331b5bd369e5bd2736ae9917a10f [INFO] running `Command { std: "docker" "start" "-a" "b4df5d09e1245a31f1fbcca75b2e209dde3d331b5bd369e5bd2736ae9917a10f", kill_on_drop: false }` [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling hashbrown v0.15.4 [INFO] [stderr] Compiling winnow v0.7.12 [INFO] [stderr] Compiling target-lexicon v0.13.2 [INFO] [stderr] Compiling smallvec v1.15.1 [INFO] [stderr] Compiling version-compare v0.2.0 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling slab v0.4.10 [INFO] [stderr] Compiling thiserror v2.0.12 [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling kstring v2.0.2 [INFO] [stderr] Compiling muldiv v1.0.1 [INFO] [stderr] Compiling syn v2.0.104 [INFO] [stderr] Compiling option-operations v0.5.0 [INFO] [stderr] Compiling thread_local v1.1.9 [INFO] [stderr] Compiling cfg-expr v0.20.1 [INFO] [stderr] Compiling num-integer v0.1.46 [INFO] [stderr] Compiling indexmap v2.10.0 [INFO] [stderr] Compiling num-rational v0.4.2 [INFO] [stderr] Compiling toml_datetime v0.6.11 [INFO] [stderr] Compiling serde_spanned v0.6.9 [INFO] [stderr] Compiling toml_edit v0.22.27 [INFO] [stderr] Compiling futures-macro v0.3.31 [INFO] [stderr] Compiling thiserror-impl v2.0.12 [INFO] [stderr] Compiling tracing-attributes v0.1.30 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling tracing v0.1.41 [INFO] [stderr] Compiling toml v0.8.23 [INFO] [stderr] Compiling proc-macro-crate v3.3.0 [INFO] [stderr] Compiling glib-macros v0.21.0 [INFO] [stderr] Compiling system-deps v7.0.5 [INFO] [stderr] Compiling glib-sys v0.21.0 [INFO] [stderr] Compiling gobject-sys v0.21.0 [INFO] [stderr] Compiling gio-sys v0.21.0 [INFO] [stderr] Compiling gstreamer-sys v0.24.0 [INFO] [stderr] Compiling futures-executor v0.3.31 [INFO] [stderr] Compiling glib v0.21.0 [INFO] [stderr] Compiling gstreamer v0.24.0 [INFO] [stderr] Compiling tracing-gstreamer v0.9.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 41.25s [INFO] running `Command { std: "docker" "inspect" "b4df5d09e1245a31f1fbcca75b2e209dde3d331b5bd369e5bd2736ae9917a10f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b4df5d09e1245a31f1fbcca75b2e209dde3d331b5bd369e5bd2736ae9917a10f", kill_on_drop: false }` [INFO] [stdout] b4df5d09e1245a31f1fbcca75b2e209dde3d331b5bd369e5bd2736ae9917a10f [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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=warn" "-e" "RUSTDOCFLAGS=--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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+1.91.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 7b9b9ffd72be75cf6e231c3f59038e8100a6074ba2a090b7ca0692348de66208 [INFO] running `Command { std: "docker" "start" "-a" "7b9b9ffd72be75cf6e231c3f59038e8100a6074ba2a090b7ca0692348de66208", kill_on_drop: false }` [INFO] [stderr] Compiling cc v1.2.30 [INFO] [stderr] Compiling log v0.4.27 [INFO] [stderr] Compiling regex v1.11.1 [INFO] [stderr] Compiling tracing-log v0.2.0 [INFO] [stderr] Compiling tracing-subscriber v0.3.19 [INFO] [stderr] Compiling tracy-client-sys v0.26.1 [INFO] [stderr] Compiling tracy-client v0.18.2 [INFO] [stderr] Compiling tracing-tracy v0.11.4 [INFO] [stderr] Compiling tracing-gstreamer v0.9.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 11.18s [INFO] running `Command { std: "docker" "inspect" "7b9b9ffd72be75cf6e231c3f59038e8100a6074ba2a090b7ca0692348de66208", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "7b9b9ffd72be75cf6e231c3f59038e8100a6074ba2a090b7ca0692348de66208", kill_on_drop: false }` [INFO] [stdout] 7b9b9ffd72be75cf6e231c3f59038e8100a6074ba2a090b7ca0692348de66208 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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=warn" "-e" "RUSTDOCFLAGS=--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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+1.91.0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 98cd3ec9da5266c719445f01b36baf5dc91a3ce41b901931ebea1384483376bb [INFO] running `Command { std: "docker" "start" "-a" "98cd3ec9da5266c719445f01b36baf5dc91a3ce41b901931ebea1384483376bb", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tracing_gstreamer-5c9bd835d649887b) [INFO] [stderr] Doc-tests tracing_gstreamer [INFO] [stdout] [test_simple_error] event: Event { fields: ValueSet { message: "simple error", callsite: Identifier(Pointer { addr: 0x613076b1f3f0, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::test_error_cat", level: Level(Error), module_path: "tracing_gstreamer::tests::test_simple_error::{{closure}}", location: src/tests.rs:237, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076b1f3f0, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Current } [INFO] [stdout] [test_simple_warning] event: Event { fields: ValueSet { message: "simple warning", callsite: Identifier(Pointer { addr: 0x613076b5d970, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::test_simple_cat", level: Level(Warn), module_path: "tracing_gstreamer::tests::test_simple_warning::{{closure}}", location: src/tests.rs:255, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076b5d970, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Current } [INFO] [stdout] [test_simple_events] event: Event { fields: ValueSet { message: "simple fixme", callsite: Identifier(Pointer { addr: 0x613076b54350, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::test_simple_cat", level: Level(Warn), module_path: "tracing_gstreamer::tests::test_simple_events::{{closure}}", location: src/tests.rs:273, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076b54350, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Current } [INFO] [stdout] [test_simple_events] event: Event { fields: ValueSet { message: "simple info", callsite: Identifier(Pointer { addr: 0x613076b32260, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::test_simple_cat", level: Level(Info), module_path: "tracing_gstreamer::tests::test_simple_events::{{closure}}", location: src/tests.rs:274, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076b32260, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Current } [INFO] [stdout] [test_simple_events] event: Event { fields: ValueSet { message: "simple memdump", callsite: Identifier(Pointer { addr: 0x613076afe6d0, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::test_simple_cat", level: Level(Trace), module_path: "tracing_gstreamer::tests::test_simple_events::{{closure}}", location: src/tests.rs:275, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076afe6d0, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Current } [INFO] [stdout] [test_simple_events] event: Event { fields: ValueSet { message: "simple trace", callsite: Identifier(Pointer { addr: 0x613076afbe00, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::test_simple_cat", level: Level(Trace), module_path: "tracing_gstreamer::tests::test_simple_events::{{closure}}", location: src/tests.rs:276, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076afbe00, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Current } [INFO] [stdout] [test_with_object] event: Event { fields: ValueSet { message: "with object", gobject.address: 106860779200816, gobject.type: "GstPipeline", gstobject.name: "pipeline0", gstelement.state: "null", gstelement.pending_state: "void-pending", callsite: Identifier(Pointer { addr: 0x613076c41d60, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::test_with_object", level: Level(Error), module_path: "tracing_gstreamer::tests::test_with_object::{{closure}}", location: src/tests.rs:319, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076c41d60, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Current } [INFO] [stdout] [test_with_upcast_object] event: Event { fields: ValueSet { message: "with upcast object", gobject.address: 106860778892496, gobject.type: "GstBin", gstobject.name: "bin0", gstelement.state: "null", gstelement.pending_state: "void-pending", callsite: Identifier(Pointer { addr: 0x613076b041a0, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::test_with_upcast_object", level: Level(Error), module_path: "tracing_gstreamer::tests::test_with_upcast_object::{{closure}}", location: src/tests.rs:347, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076b041a0, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Current } [INFO] [stdout] [test_with_pad] event: Event { fields: ValueSet { message: "with pad object", gobject.address: 106860778893488, gobject.type: "GstPad", gstobject.name: "custom_pad_name", gstpad.state: {FLUSHING, NEED_PARENT}, gstpad.parent.name: "custom_bin_name", gstpad.parent.state: "null", gstpad.parent.pending_state: "void-pending", callsite: Identifier(Pointer { addr: 0x613076b5d440, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::test_pad_cat", level: Level(Error), module_path: "tracing_gstreamer::tests::test_with_pad::{{closure}}", location: src/tests.rs:378, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076b5d440, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Current } [INFO] [stdout] [test_disintegration] event: Event { fields: ValueSet { message: "apple", callsite: Identifier(Pointer { addr: 0x613076c42f60, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::disintegration", level: Level(Error), module_path: "tracing_gstreamer::tests::test_disintegration::{{closure}}", location: src/tests.rs:405, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076c42f60, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Current } [INFO] [stdout] [test_disintegration] event: Event { fields: ValueSet { message: "chaenomeles", callsite: Identifier(Pointer { addr: 0x613076c441a0, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::disintegration", level: Level(Error), module_path: "tracing_gstreamer::tests::test_disintegration::{{closure}}", location: src/tests.rs:409, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076c441a0, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Current } [INFO] [stdout] [test_formatting] event: Event { fields: ValueSet { message: "the answer is believed to be 42.", callsite: Identifier(Pointer { addr: 0x613076b53e80, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::ANSWERS", level: Level(Warn), module_path: "tracing_gstreamer::tests::test_formatting::{{closure}}", location: src/tests.rs:436, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076b53e80, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Current } [INFO] [stdout] [test_interests] event: Event { fields: ValueSet { message: "warnings should be visible", callsite: Identifier(Pointer { addr: 0x613076b48de0, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::INTERESTS", level: Level(Warn), module_path: "tracing_gstreamer::tests::test_interests::{{closure}}", location: src/tests.rs:476, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076b48de0, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Current } [INFO] [stdout] [test_interests] event: Event { fields: ValueSet { message: "errors should be visible", callsite: Identifier(Pointer { addr: 0x613076b31d50, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::INTERESTS", level: Level(Error), module_path: "tracing_gstreamer::tests::test_interests::{{closure}}", location: src/tests.rs:477, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076b31d50, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Current } [INFO] [stdout] [test_user_span] new_span: Attributes { metadata: Metadata { name: "pipeline span", target: "gstreamer::test_user_span", level: Level(Error), module_path: "tracing_gstreamer::tests", location: src/tests.rs:498, fields: {pipeline}, callsite: Identifier(Pointer { addr: 0x6130511984a0, metadata: DynMetadata(0x6130511883b8) }), kind: Kind(SPAN) }, values: ValueSet { pipeline: true, callsite: Identifier(Pointer { addr: 0x6130511984a0, metadata: DynMetadata(0x6130511883b8) }) }, parent: Current } [INFO] [stdout] [test_user_span] event: Event { fields: ValueSet { message: "with object", gobject.address: 106860778942816, gobject.type: "GstPipeline", gstobject.name: "pipeline1", gstelement.state: "null", gstelement.pending_state: "void-pending", callsite: Identifier(Pointer { addr: 0x613076c44c60, metadata: DynMetadata(0x6130511898e0) }) }, metadata: Metadata { name: "", target: "gstreamer::test_user_span", level: Level(Error), module_path: "tracing_gstreamer::tests::test_user_span::{{closure}}", location: src/tests.rs:505, fields: {message, gobject.address, gobject.type, gstobject.name, gstelement.state, gstelement.pending_state, gstpad.state, gstpad.parent.name, gstpad.parent.state, gstpad.parent.pending_state}, callsite: Identifier(Pointer { addr: 0x613076c44c60, metadata: DynMetadata(0x6130511898e0) }), kind: Kind(EVENT) }, parent: Explicit(Id(99)) } [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test src/lib.rs - (line 41) ... ok [INFO] [stdout] test src/lib.rs - (line 14) ... ok [INFO] [stdout] test src/lib.rs - (line 27) ... ok [INFO] [stdout] test src/log.rs - log::attach_span (line 304) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.89s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "98cd3ec9da5266c719445f01b36baf5dc91a3ce41b901931ebea1384483376bb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "98cd3ec9da5266c719445f01b36baf5dc91a3ce41b901931ebea1384483376bb", kill_on_drop: false }` [INFO] [stdout] 98cd3ec9da5266c719445f01b36baf5dc91a3ce41b901931ebea1384483376bb