[INFO] fetching crate sc-observability-log 1.5.0...
[INFO] testing sc-observability-log-1.5.0 against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate sc-observability-log 1.5.0 into /workspace/builds/worker-3-tc2/source
[INFO] started tweaking crates.io crate sc-observability-log 1.5.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate sc-observability-log 1.5.0
[INFO] tweaked toml for crates.io crate sc-observability-log 1.5.0 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate sc-observability-log 1.5.0 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate sc-observability-log 1.5.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.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | homepage = "https://github.com/randlee/sc-observability"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 72 | repository = "https://github.com/randlee/sc-observability"
[INFO] [stderr]    |              ---------------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `sc-observability-log` (manifest) generated 1 warning
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] fb61d637240b2f90a78f15b5f0068e42ea959b881c67545622c1de866a714751
[INFO] running `Command { std: "docker" "start" "fb61d637240b2f90a78f15b5f0068e42ea959b881c67545622c1de866a714751", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "fb61d637240b2f90a78f15b5f0068e42ea959b881c67545622c1de866a714751", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "fb61d637240b2f90a78f15b5f0068e42ea959b881c67545622c1de866a714751" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "fb61d637240b2f90a78f15b5f0068e42ea959b881c67545622c1de866a714751", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "fb61d637240b2f90a78f15b5f0068e42ea959b881c67545622c1de866a714751" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | homepage = "https://github.com/randlee/sc-observability"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 72 | repository = "https://github.com/randlee/sc-observability"
[INFO] [stderr]    |              ---------------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `sc-observability-log` (manifest) generated 1 warning
[INFO] [stderr]    Compiling log v0.4.34
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling sc-lint-directives v0.4.0
[INFO] [stderr]    Compiling time v0.3.55
[INFO] [stderr]    Compiling sc-observability-log-macros v1.5.0
[INFO] [stderr]    Compiling hostname v0.4.2
[INFO] [stderr]    Compiling sc-lint-attributes v0.4.0
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling sc-observability-types v1.5.0
[INFO] [stderr]    Compiling sc-observability v1.5.0
[INFO] [stderr]    Compiling sc-observability-log v1.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 56.01s
[INFO] running `Command { std: "docker" "inspect" "fb61d637240b2f90a78f15b5f0068e42ea959b881c67545622c1de866a714751", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "fb61d637240b2f90a78f15b5f0068e42ea959b881c67545622c1de866a714751" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | homepage = "https://github.com/randlee/sc-observability"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 72 | repository = "https://github.com/randlee/sc-observability"
[INFO] [stderr]    |              ---------------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `sc-observability-log` (manifest) generated 1 warning
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling target-tuple v1.0.2
[INFO] [stderr]    Compiling rustix v1.1.5
[INFO] [stderr]    Compiling toml v1.1.6+spec-1.1.0
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling trybuild v1.0.121
[INFO] [stderr]    Compiling sc-lint-directives v0.4.0
[INFO] [stderr]    Compiling sc-lint-attributes v0.4.0
[INFO] [stderr]    Compiling sc-observability-log-macros v1.5.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling sc-observability-types v1.5.0
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling sc-observability v1.5.0
[INFO] [stderr]    Compiling sc-observability-log v1.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 2m 36s
[INFO] running `Command { std: "docker" "inspect" "fb61d637240b2f90a78f15b5f0068e42ea959b881c67545622c1de866a714751", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "fb61d637240b2f90a78f15b5f0068e42ea959b881c67545622c1de866a714751" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> Cargo.toml:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | homepage = "https://github.com/randlee/sc-observability"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 72 | repository = "https://github.com/randlee/sc-observability"
[INFO] [stderr]    |              ---------------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `sc-observability-log` (manifest) generated 1 warning
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.14s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/build/sc-observability-log/251399a2c7481c8b/out/sc_observability_log-251399a2c7481c8b)
[INFO] [stdout] 
[INFO] [stdout] running 82 tests
[INFO] [stdout] test callsite::tests::serialize_errors_key_is_reserved ... ok
[INFO] [stdout] test callsite::tests::callsite_caches_sanitized_labels ... ok
[INFO] [stdout] test callsite::tests::dynamic_key_caches_field_key_label ... ok
[INFO] [stdout] test context::tests::call_span_is_send_and_sync ... ok
[INFO] [stdout] test context::tests::all_outcome_labels_validate ... ok
[INFO] [stdout] test context::tests::entered_records_a_panic_while_unwinding ... ok
[INFO] [stdout] test callsite::tests::serialize_failures_record_null_and_error ... ok
[INFO] [stdout] test context::tests::current_trace_is_none_on_a_fresh_thread ... ok
[INFO] [stdout] test callsite::tests::static_fields_use_the_same_canonical_key_as_dynamic_fields ... ok
[INFO] [stdout] test context::tests::entered_pops_only_its_own_entry ... ok
[INFO] [stdout] test context::tests::fields_are_not_recorded_when_every_level_is_disabled ... ok
[INFO] [stdout] test control::tests::control_is_send_and_sync ... ok
[INFO] [stdout] test control::tests::core_event_errors_share_one_classification_and_keep_their_diagnostic ... ok
[INFO] [stdout] test error::tests::canonical_operation_errors_preserve_context_source_and_codes ... ok
[INFO] [stdout] test error::tests::field_key_error_variants_are_cloneable_and_round_trip ... ok
[INFO] [stdout] test error::tests::drop_cause_all_lists_every_variant_once ... ok
[INFO] [stdout] test context::tests::nested_spans_link_and_the_stack_unwinds ... ok
[INFO] [stdout] test error_codes::tests::all_codes_are_unique_and_prefixed ... ok
[INFO] [stdout] test error_codes::tests::foreign_logger_codes_have_distinct_lifecycle_contracts ... ok
[INFO] [stdout] test error::tests::remaining_facade_errors_keep_their_diagnostic_contracts ... ok
[INFO] [stdout] test handle::tests::bridge_has_no_independent_level_policy ... ok
[INFO] [stdout] test error::tests::stale_attachment_errors_are_typed_and_round_trip ... ok
[INFO] [stdout] test handle::tests::flush_completion_observer_confirms_release_before_notification ... ok
[INFO] [stdout] test bridge::tests::facade_record_enters_an_attachment_once ... ok
[INFO] [stdout] test handle::tests::flight_claim_is_exclusive_and_released_on_drop_or_panic ... ok
[INFO] [stdout] test bridge::tests::skipped_facade_records_count_no_drop ... ok
[INFO] [stdout] test handle::tests::log_level_rank_ordering_covers_every_filter_pair ... ok
[INFO] [stdout] test handle::tests::emit_core_counts_panics_and_reentry ... ok
[INFO] [stdout] test handle::tests::native_flush_counter_positive_control_and_facade_zero_proof ... ok
[INFO] [stdout] test handle::tests::missing_shutdown_hook_times_out_and_releases_worker ... ok
[INFO] [stdout] test handle::tests::coordinator_failure_returns_runtime_start_before_global_install ... ok
[INFO] [stdout] test bridge::tests::attachment_flush_classifies_real_helper_spawn_and_loss ... ok
[INFO] [stdout] test context::tests::generated_ids_always_validate ... ok
[INFO] [stdout] test handle::tests::run_bounded_returns_value ... ok
[INFO] [stdout] test handle::tests::native_flush_classifies_real_helper_spawn_and_loss ... ok
[INFO] [stdout] test handle::tests::health_snapshot_failure_notifies_and_retains_unavailable_for_all_controls ... ok
[INFO] [stdout] test handle::tests::shared_level_gate_covers_every_level_and_filter ... ok
[INFO] [stdout] test handle::tests::reserved_shutdown_worker_publishes_failure_after_a_waiter_times_out ... ok
[INFO] [stdout] test handle::tests::shutdown_test_release_survives_assertion_unwind ... ok
[INFO] [stdout] test health::tests::native_shape_round_trips ... ok
[INFO] [stdout] test handle::tests::run_bounded_losing_race_returns_the_published_value ... ok
[INFO] [stdout] test handle::tests::run_bounded_reports_worker_lost_on_panic ... ok
[INFO] [stdout] test mapping::tests::code_location_rows_present_and_omitted ... ok
[INFO] [stdout] test mapping::tests::envelope_rows_filled_by_assemble_event ... ok
[INFO] [stdout] test mapping::tests::action_label_rejects_empty ... ok
[INFO] [stdout] test health::tests::unavailable_has_the_target_code_and_remediation ... ok
[INFO] [stdout] test handle::tests::run_bounded_counts_a_detached_helper_until_it_finishes ... ok
[INFO] [stdout] test mapping::tests::identity_auto_uses_hostname_and_current_pid ... ok
[INFO] [stdout] test mapping::tests::field_key_label_rules ... ok
[INFO] [stdout] test mapping::tests::identity_auto_fails_on_an_empty_hostname ... ok
[INFO] [stdout] test mapping::tests::identity_auto_fails_when_the_hostname_lookup_fails ... ok
[INFO] [stdout] test mapping::tests::kv_row_types_json_values ... ok
[INFO] [stdout] test mapping::tests::identity_fixed_is_used_as_given ... ok
[INFO] [stdout] test mapping::tests::identity_resolver_ok_and_err ... ok
[INFO] [stdout] test mapping::tests::kv_key_rules_omit_reserved_and_empty_keys_and_shadow_code_keys ... ok
[INFO] [stdout] test mapping::tests::level_row_maps_every_level ... ok
[INFO] [stdout] test mapping::tests::message_row_formats_args ... ok
[INFO] [stdout] test mapping::tests::otherwise_row_uses_default_action ... ok
[INFO] [stdout] test mapping::tests::target_label_maps_empty_to_log ... ok
[INFO] [stdout] test mapping::tests::tag_row_extracts_valid_tags ... ok
[INFO] [stdout] test mapping::tests::tag_row_leaves_invalid_tags_in_message ... ok
[INFO] [stdout] test mapping::tests::target_row_sanitizes_invalid_and_empty_targets ... ok
[INFO] [stdout] test tests::level_converts_one_to_one ... ok
[INFO] [stdout] test tests::level_serializes_with_the_log_event_spelling ... ok
[INFO] [stdout] test v1::tests::legacy_emit_root_contract_rows_preserve_root_contracts ... ok
[INFO] [stdout] test v1::tests::legacy_emit_table_covers_each_remaining_released_row ... ok
[INFO] [stdout] test v1::tests::legacy_flush_in_progress_and_logger_rows_preserve_root_contracts ... ok
[INFO] [stdout] test v1::tests::legacy_flush_table_preserves_released_variants_and_contracts ... ok
[INFO] [stdout] test v1::tests::legacy_init_preserves_runtime_start_variant_and_diagnostic ... ok
[INFO] [stdout] test v1::tests::legacy_init_special_configuration_rows_preserve_root_contracts ... ok
[INFO] [stdout] test v1::tests::legacy_shutdown_and_emit_tables_preserve_root_contracts ... ok
[INFO] [stdout] test v1::tests::legacy_init_table_preserves_released_variants_and_contracts ... ok
[INFO] [stdout] test mapping::tests::sanitizer_rewrites_paths_and_invalid_chars ... ok
[INFO] [stdout] test v1::tests::released_log_control_keeps_released_auto_traits ... ok
[INFO] [stdout] test handle::tests::run_bounded_uncounts_a_detached_helper_that_panics ... ok
[INFO] [stdout] test v1::tests::unknown_runtime_code_remains_released_logger ... ok
[INFO] [stdout] test v1::tests::detached_attachment_maps_not_installed_to_released_stopped_while_global_is_running ... ok
[INFO] [stdout] test v1::tests::synthetic_released_control_flush_preserves_non_running_phase_at_the_adapter_boundary ... ok
[INFO] [stdout] test handle::tests::take_sole_succeeds_once_clone_is_released ... ok
[INFO] [stdout] test v1::tests::owned_init_guard_flush_rejects_a_second_in_flight_flush ... ok
[INFO] [stdout] test handle::tests::isolated_test_child_timeout_kills_and_reaps ... ok
[INFO] [stdout] test handle::tests::run_bounded_times_out_on_blocked_work ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 82 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.15s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/api_freeze.rs (/opt/rustwide/target/release/build/sc-observability-log/dfe97e3ba758dae9/out/api_freeze-dfe97e3ba758dae9)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test bp3_public_api_is_frozen ... 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/attachment_contracts.rs (/opt/rustwide/target/release/build/sc-observability-log/4e31b0c7e761df52/out/attachment_contracts-4e31b0c7e761df52)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test detach_retry_after_timeout ... ok
[INFO] [stdout] test foreign_logger_rejected ... ok
[INFO] [stdout] test detached_slot_reattaches ... ok
[INFO] [stdout] test stale_control_not_installed ... ok
[INFO] [stdout] test attachment_options_accept_open_policy ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running tests/bridge_attachment.rs (/opt/rustwide/target/release/build/sc-observability-log/578cb8f4773a778b/out/bridge_attachment-578cb8f4773a778b)
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test flush_detach_race_releases_all_logger_arcs_before_success ... ok
[INFO] [stdout] test detach_max_duration_waits_for_entered_call_without_overflow ... ok
[INFO] [stdout] test dropped_attachment_finishes_detaching_when_last_call_drains ... ok
[INFO] [stdout] test logging_detach_race_releases_all_logger_arcs_before_success ... ok
[INFO] [stdout] test reattachment_rejects_old_control_and_init_while_attached ... ok
[INFO] [stdout] test timed_out_flush_keeps_attachment_owned_logger_until_helper_drains ... ok
[INFO] [stdout] test timeout_retains_attachment_for_retry_and_stale_control_is_rejected ... ok
[INFO] [stdout] test attachment_routes_direct_and_macro_calls_and_recovers_host_ownership ... ok
[INFO] [stderr]      Running tests/bridge_foreign.rs (/opt/rustwide/target/release/build/sc-observability-log/754a1e5c6048f861/out/bridge_foreign-754a1e5c6048f861)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.12s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test attachment_rejects_a_foreign_process_global_logger ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/bridge_guard.rs (/opt/rustwide/target/release/build/sc-observability-log/69541a6925944345/out/bridge_guard-69541a6925944345)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/bridge_jsonl.rs (/opt/rustwide/target/release/build/sc-observability-log/265ab0bbd2a30dcf/out/bridge_jsonl-265ab0bbd2a30dcf)
[INFO] [stdout] test bridge_guard_contains_user_formatting ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test bridge_writes_mapped_jsonl_and_is_install_once ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/bridge_owned.rs (/opt/rustwide/target/release/build/sc-observability-log/809eac4034e38df7/out/bridge_owned-809eac4034e38df7)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/bridge_policy.rs (/opt/rustwide/target/release/build/sc-observability-log/169884fb2e874878/out/bridge_policy-169884fb2e874878)
[INFO] [stdout] test owned_init_excludes_host_attachment ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test instrumented_completion_is_routed_through_attachment ... ok
[INFO] [stdout] test every_policy_reason_has_concrete_steps_and_facade_diagnostics ... ok
[INFO] [stdout] test policy_rejection_and_panic_are_counted_once_at_the_boundary ... ok
[INFO] [stdout] test policy_allowlist_and_bound_run_before_host_redaction_and_sink_admission ... ok
[INFO] [stderr]      Running tests/bridge_queue_full.rs (/opt/rustwide/target/release/build/sc-observability-log/a01a4ef3866c43f1/out/bridge_queue_full-a01a4ef3866c43f1)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 2026-10-18T16:54:25.114001609Z INFO flood log.record thread 1 record 0
[INFO] [stdout] 2026-10-18T16:54:25.115108679Z INFO flood log.record thread 1 record 20
[INFO] [stdout] 2026-10-18T16:54:25.115155639Z INFO flood log.record thread 1 record 22
[INFO] [stdout] 2026-10-18T16:54:25.115165479Z INFO flood log.record thread 1 record 23
[INFO] [stdout] 2026-10-18T16:54:25.115178829Z INFO flood log.record thread 1 record 24
[INFO] [stdout] 2026-10-18T16:54:25.115228009Z INFO flood log.record thread 0 record 1
[INFO] [stdout] 2026-10-18T16:54:25.115240819Z INFO flood log.record thread 0 record 2
[INFO] [stdout] 2026-10-18T16:54:25.115263969Z INFO flood log.record thread 2 record 8
[INFO] [stdout] 2026-10-18T16:54:25.115281629Z INFO flood log.record thread 0 record 4
[INFO] [stdout] 2026-10-18T16:54:25.115305559Z INFO flood log.record thread 1 record 26
[INFO] [stdout] 2026-10-18T16:54:25.118633198Z INFO flood log.record thread 6 record 22
[INFO] [stdout] 2026-10-18T16:54:25.121560838Z INFO flood log.record thread 2 record 59
[INFO] [stdout] 2026-10-18T16:54:25.121588928Z INFO flood log.record thread 1 record 29
[INFO] [stdout] 2026-10-18T16:54:25.121614488Z INFO flood log.record thread 0 record 9
[INFO] [stdout] 2026-10-18T16:54:25.121687888Z INFO flood log.record thread 0 record 11
[INFO] [stdout] 2026-10-18T16:54:25.121729978Z INFO flood log.record thread 1 record 32
[INFO] [stdout] 2026-10-18T16:54:25.121754477Z INFO flood log.record thread 0 record 13
[INFO] [stdout] 2026-10-18T16:54:25.121782768Z INFO flood log.record thread 0 record 15
[INFO] [stdout] 2026-10-18T16:54:25.121815677Z INFO flood log.record thread 4 record 60
[INFO] [stdout] 2026-10-18T16:54:25.121824937Z INFO flood log.record thread 1 record 34
[INFO] [stdout] 2026-10-18T16:54:25.121856817Z INFO flood log.record thread 0 record 17
[INFO] [stdout] 2026-10-18T16:54:25.121875788Z INFO flood log.record thread 1 record 35
[INFO] [stdout] 2026-10-18T16:54:25.121879128Z INFO flood log.record thread 1 record 36
[INFO] [stdout] 2026-10-18T16:54:25.121902788Z INFO flood log.record thread 2 record 62
[INFO] [stdout] 2026-10-18T16:54:25.121920988Z INFO flood log.record thread 1 record 39
[INFO] [stdout] 2026-10-18T16:54:25.121942888Z INFO flood log.record thread 0 record 19
[INFO] [stdout] 2026-10-18T16:54:25.121949657Z INFO flood log.record thread 2 record 63
[INFO] [stdout] 2026-10-18T16:54:25.121983317Z INFO flood log.record thread 0 record 22
[INFO] [stdout] 2026-10-18T16:54:25.122013108Z INFO flood log.record thread 2 record 64
[INFO] [stdout] 2026-10-18T16:54:25.122029897Z INFO flood log.record thread 3 record 137
[INFO] [stdout] 2026-10-18T16:54:25.123569317Z INFO flood log.record thread 5 record 4
[INFO] [stdout] 2026-10-18T16:54:25.123593097Z INFO flood log.record thread 1 record 41
[INFO] [stdout] 2026-10-18T16:54:25.123639427Z INFO flood log.record thread 0 record 23
[INFO] [stdout] 2026-10-18T16:54:25.123645657Z INFO flood log.record thread 0 record 24
[INFO] [stdout] 2026-10-18T16:54:25.123650727Z INFO flood log.record thread 2 record 67
[INFO] [stdout] 2026-10-18T16:54:25.123666027Z INFO flood log.record thread 0 record 25
[INFO] [stdout] 2026-10-18T16:54:25.123679687Z INFO flood log.record thread 2 record 68
[INFO] [stdout] 2026-10-18T16:54:25.123703017Z INFO flood log.record thread 2 record 69
[INFO] [stdout] 2026-10-18T16:54:25.123720957Z INFO flood log.record thread 4 record 158
[INFO] [stdout] 2026-10-18T16:54:25.123724827Z INFO flood log.record thread 4 record 159
[INFO] [stdout] 2026-10-18T16:54:25.123736367Z INFO flood log.record thread 0 record 27
[INFO] [stdout] 2026-10-18T16:54:25.123772887Z INFO flood log.record thread 5 record 7
[INFO] [stdout] 2026-10-18T16:54:25.123821807Z INFO flood log.record thread 4 record 163
[INFO] [stdout] 2026-10-18T16:54:25.123831387Z INFO flood log.record thread 4 record 164
[INFO] [stdout] 2026-10-18T16:54:25.123852277Z INFO flood log.record thread 0 record 29
[INFO] [stdout] 2026-10-18T16:54:25.123873517Z INFO flood log.record thread 4 record 166
[INFO] [stdout] 2026-10-18T16:54:25.123902527Z INFO flood log.record thread 3 record 138
[INFO] [stdout] 2026-10-18T16:54:25.123906817Z INFO flood log.record thread 3 record 139
[INFO] [stdout] 2026-10-18T16:54:25.123951207Z INFO flood log.record thread 2 record 71
[INFO] [stdout] 2026-10-18T16:54:25.123971747Z INFO flood log.record thread 3 record 142
[INFO] [stdout] 2026-10-18T16:54:25.123992197Z INFO flood log.record thread 1 record 43
[INFO] [stdout] 2026-10-18T16:54:25.124025317Z INFO flood log.record thread 0 record 31
[INFO] [stdout] 2026-10-18T16:54:25.124046407Z INFO flood log.record thread 7 record 71
[INFO] [stdout] 2026-10-18T16:54:25.124085867Z INFO flood log.record thread 7 record 73
[INFO] [stdout] 2026-10-18T16:54:25.124122897Z INFO flood log.record thread 2 record 73
[INFO] [stdout] 2026-10-18T16:54:25.124129247Z INFO flood log.record thread 5 record 10
[INFO] [stdout] 2026-10-18T16:54:25.124147817Z INFO flood log.record thread 2 record 74
[INFO] [stdout] 2026-10-18T16:54:25.124167077Z INFO flood log.record thread 6 record 66
[INFO] [stdout] 2026-10-18T16:54:25.124188827Z INFO flood log.record thread 2 record 76
[INFO] [stdout] 2026-10-18T16:54:25.124284527Z INFO flood log.record thread 6 record 67
[INFO] [stdout] 2026-10-18T16:54:25.124292327Z INFO flood log.record thread 0 record 34
[INFO] [stdout] 2026-10-18T16:54:25.124338577Z INFO flood log.record thread 0 record 35
[INFO] [stdout] 2026-10-18T16:54:25.124347297Z INFO flood log.record thread 7 record 78
[INFO] [stdout] 2026-10-18T16:54:25.124352907Z INFO flood log.record thread 7 record 79
[INFO] [stderr]      Running tests/canonical_exports.rs (/opt/rustwide/target/release/build/sc-observability-log/389323e1e40001da/out/canonical_exports-389323e1e40001da)
[INFO] [stdout] 2026-10-18T16:54:25.124368927Z INFO flood log.record thread 7 record 80
[INFO] [stdout] test full_queue_drops_without_blocking ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.74s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test canonical_log_exports_have_real_public_signatures ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/compat_events.rs (/opt/rustwide/target/release/build/sc-observability-log/04a49cef5824ca1a/out/compat_events-04a49cef5824ca1a)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/compat_instrument.rs (/opt/rustwide/target/release/build/sc-observability-log/babc802a454380b3/out/compat_instrument-babc802a454380b3)
[INFO] [stdout] test compat_fixture_matches_tracing_syntax_and_emits_jsonl ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test compat_fixture_matches_tracing_syntax_and_emits_jsonl ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/compat_v2_conversion.rs (/opt/rustwide/target/release/build/sc-observability-log/e5ce76795d1c4c0e/out/compat_v2_conversion-e5ce76795d1c4c0e)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test released_control_moves_into_canonical_error_surface ... ok
[INFO] [stdout] test released_zero_queue_init_preserves_logger_diagnostic ... ok
[INFO] [stderr]      Running tests/flush_single_flight.rs (/opt/rustwide/target/release/build/sc-observability-log/e924dd1dda8b72ec/out/flush_single_flight-e924dd1dda8b72ec)
[INFO] [stdout] test released_no_sink_init_preserves_logger_diagnostic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/health_snapshot.rs (/opt/rustwide/target/release/build/sc-observability-log/e7ab1aca00c9204c/out/health_snapshot-e7ab1aca00c9204c)
[INFO] [stdout] test stuck_flush_keeps_one_detached_helper_and_rejects_retries ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.11s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test health_uses_the_core_report_and_retains_it_after_shutdown ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/instrument_jsonl.rs (/opt/rustwide/target/release/build/sc-observability-log/a1748f910447f027/out/instrument_jsonl-a1748f910447f027)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/macros_jsonl.rs (/opt/rustwide/target/release/build/sc-observability-log/e4064ed609fcc5f3/out/macros_jsonl-e4064ed609fcc5f3)
[INFO] [stdout] test instrument_emits_completion_events_with_trace_context ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test event_macros_write_structured_jsonl ... ok
[INFO] [stderr]      Running tests/one_writer.rs (/opt/rustwide/target/release/build/sc-observability-log/139b6b7b261f14fd/out/one_writer-139b6b7b261f14fd)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test direct_facade_and_macro_share_guard_accounting_and_envelope ... 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] [stderr]      Running tests/reinstall_subprocess.rs (/opt/rustwide/target/release/build/sc-observability-log/7080b8969fac7638/out/reinstall_subprocess-7080b8969fac7638)
[INFO] [stdout] running 1 test
[INFO] [stdout] test bridge_cannot_be_reinstalled_or_replaced_after_shutdown ... ok
[INFO] [stderr]      Running tests/runtime_level_bridge.rs (/opt/rustwide/target/release/build/sc-observability-log/40880fd0974fee57/out/runtime_level_bridge-40880fd0974fee57)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test direct_facade_and_macro_admission_share_the_core_level_owner ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/shutdown_timeout.rs (/opt/rustwide/target/release/build/sc-observability-log/9c718e4b285ba48e/out/shutdown_timeout-9c718e4b285ba48e)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test gate_release_survives_assertion_unwind ... ok
[INFO] [stderr]      Running tests/ui.rs (/opt/rustwide/target/release/build/sc-observability-log/9df12d9eb8b6caaa/out/ui-9df12d9eb8b6caaa)
[INFO] [stdout] test timed_out_owner_shutdown_completes_late_for_repeated_control_waiters ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.18s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]   --> /opt/rustwide/workdir/Cargo.toml:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | homepage = "https://github.com/randlee/sc-observability"
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 72 | repository = "https://github.com/randlee/sc-observability"
[INFO] [stderr]    |              ---------------------------------------------
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `sc-observability-log` (manifest) generated 1 warning
[INFO] [stderr]    Compiling unicode-ident v1.0.26
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling zmij v1.0.23
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]     Checking itoa v1.0.18
[INFO] [stderr]     Checking num-conv v0.2.2
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]     Checking time-core v0.1.9
[INFO] [stderr]     Checking cfg-if v1.0.5
[INFO] [stderr]     Checking memchr v2.8.3
[INFO] [stderr]     Checking powerfmt v0.2.0
[INFO] [stderr]    Compiling rustix v1.1.5
[INFO] [stderr]     Checking once_cell v1.21.4
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]     Checking bitflags v2.13.2
[INFO] [stderr]     Checking pin-project-lite v0.2.17
[INFO] [stderr]     Checking linux-raw-sys v0.12.1
[INFO] [stderr]     Checking tracing-core v0.1.36
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]     Checking fastrand v2.5.0
[INFO] [stderr]     Checking log v0.4.34
[INFO] [stderr]    Compiling syn v3.0.6
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]     Checking deranged v0.5.8
[INFO] [stderr]     Checking hostname v0.4.2
[INFO] [stderr]     Checking tempfile v3.27.0
[INFO] [stderr]     Checking time v0.3.55
[INFO] [stdout] test log_control_is_not_constructible_outside_the_crate ... FAILED
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling tokio-macros v2.7.2
[INFO] [stderr]    Compiling sc-lint-directives v0.4.0
[INFO] [stderr]     Checking tokio v1.53.1
[INFO] [stderr]    Compiling sc-lint-attributes v0.4.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling sc-observability-log-macros v1.5.0
[INFO] [stderr]     Checking tracing v0.1.44
[INFO] [stderr]     Checking sc-observability-types v1.5.0
[INFO] [stderr]     Checking sc-observability v1.5.0
[INFO] [stderr]     Checking sc-observability-log v1.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Checking sc-observability-log-tests v0.0.0 (/opt/rustwide/target/tests/trybuild/sc-observability-log)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 47.30s
[INFO] [stderr] 
[INFO] [stderr] 
[INFO] [stdout] test rejected_event_forms_fail_to_compile has been running for over 60 seconds
[INFO] [stderr] test tests/ui/event_empty_key.rs ... ok
[INFO] [stderr] test tests/ui/event_field_empty.rs ... ok
[INFO] [stderr] test tests/ui/event_parent.rs ... ok
[INFO] [stderr] test tests/ui/event_reserved_key_dotted.rs ... ok
[INFO] [stderr] test tests/ui/event_reserved_key_string.rs ... ok
[INFO] [stderr] test tests/ui/event_span_macro.rs ... mismatch
[INFO] [stderr] 
[INFO] [stderr] EXPECTED:
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] error[E0433]: failed to resolve: could not find `info_span` in `sc_observability_log`
[INFO] [stderr]  --> tests/ui/event_span_macro.rs:3:39
[INFO] [stderr]   |
[INFO] [stderr] 3 |     let _span = sc_observability_log::info_span!("span");
[INFO] [stderr]   |                                       ^^^^^^^^^ could not find `info_span` in `sc_observability_log`
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] 
[INFO] [stderr] ACTUAL OUTPUT:
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] error[E0433]: cannot find `info_span` in `sc_observability_log`
[INFO] [stderr]  --> tests/ui/event_span_macro.rs:3:39
[INFO] [stderr]   |
[INFO] [stderr] 3 |     let _span = sc_observability_log::info_span!("span");
[INFO] [stderr]   |                                       ^^^^^^^^^ could not find `info_span` in `sc_observability_log`
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] note: If the actual output is the correct output you can bless it by rerunning
[INFO] [stderr]       your test with the environment variable TRYBUILD=overwrite
[INFO] [stderr] 
[INFO] [stderr] test tests/ui/event_target_before_name.rs ... ok
[INFO] [stderr] test tests/ui/field_not_serialize_or_debug.rs ... mismatch
[INFO] [stderr] 
[INFO] [stderr] EXPECTED:
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] error[E0277]: field value `Neither` implements neither `serde::Serialize` nor `core::fmt::Debug`
[INFO] [stderr]  --> tests/ui/field_not_serialize_or_debug.rs:8:19
[INFO] [stderr]   |
[INFO] [stderr] 8 |     info!(field = neither, "message");
[INFO] [stderr]   |                   ^^^^^^^ this field value cannot be recorded
[INFO] [stderr]   |
[INFO] [stderr]   = help: the trait `std::fmt::Debug` is not implemented for `Neither`
[INFO] [stderr]   = note: record it with `?value` (Debug) or `%value` (Display), or implement `serde::Serialize`
[INFO] [stderr]   = note: required for `Neither` to implement `FieldDebug`
[INFO] [stderr] note: required by a bound in `DebugKind::record`
[INFO] [stderr]  --> src/callsite.rs
[INFO] [stderr]   |
[INFO] [stderr]   |     pub fn record<T: ?Sized + FieldDebug>(self, v: &T) -> FieldRecord {
[INFO] [stderr]   |                               ^^^^^^^^^^ required by this bound in `DebugKind::record`
[INFO] [stderr] help: consider annotating `Neither` with `#[derive(Debug)]`
[INFO] [stderr]   |
[INFO] [stderr] 4 + #[derive(Debug)]
[INFO] [stderr] 5 | struct Neither;
[INFO] [stderr]   |
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] 
[INFO] [stderr] ACTUAL OUTPUT:
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] error[E0277]: field value `Neither` implements neither `serde::Serialize` nor `core::fmt::Debug`
[INFO] [stderr]  --> tests/ui/field_not_serialize_or_debug.rs:8:19
[INFO] [stderr]   |
[INFO] [stderr] 8 |     info!(field = neither, "message");
[INFO] [stderr]   |                   ^^^^^^^ this field value cannot be recorded
[INFO] [stderr]   |
[INFO] [stderr]   = help: the trait `std::fmt::Debug` is not implemented for `Neither`
[INFO] [stderr]   = note: record it with `?value` (Debug) or `%value` (Display), or implement `serde::Serialize`
[INFO] [stderr]   = note: required for `Neither` to implement `sc_observability_log::__private::FieldDebug`
[INFO] [stderr] note: required by a bound in `sc_observability_log::__private::DebugKind::record`
[INFO] [stderr]  --> src/callsite.rs
[INFO] [stderr]   |
[INFO] [stderr]   | impl DebugKind {
[INFO] [stderr]   |     /// Records the `Debug` string of `v`.
[INFO] [stderr]   |     pub fn record<T: ?Sized + FieldDebug>(self, v: &T) -> FieldRecord {
[INFO] [stderr]   |                               ^^^^^^^^^^ required by this bound in `DebugKind::record`
[INFO] [stderr] help: consider annotating `Neither` with `#[derive(Debug)]`
[INFO] [stderr]   |
[INFO] [stderr] 4 + #[derive(Debug)]
[INFO] [stderr] 5 | struct Neither;
[INFO] [stderr]   |
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] note: If the actual output is the correct output you can bless it by rerunning
[INFO] [stderr]       your test with the environment variable TRYBUILD=overwrite
[INFO] [stderr] 
[INFO] [stderr] test tests/ui/fixture_attachment_no_owner_authority.rs ... ok
[INFO] [stderr] test tests/ui/instrument_deferred_field.rs ... ok
[INFO] [stderr] test tests/ui/instrument_entered_across_await.rs ... mismatch
[INFO] [stderr] 
[INFO] [stderr] EXPECTED:
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] error: future cannot be sent between threads safely
[INFO] [stderr]   --> tests/ui/instrument_entered_across_await.rs:18:13
[INFO] [stderr]    |
[INFO] [stderr] 18 |       let _ = require_send(async move {
[INFO] [stderr]    |  _____________^
[INFO] [stderr] 19 | |         let span = CallSpan::new(&CALLSITE, levels, Map::new);
[INFO] [stderr] 20 | |         let _entered = span.enter();
[INFO] [stderr] 21 | |         yield_point().await;
[INFO] [stderr] 22 | |     });
[INFO] [stderr]    | |______^ future created by async block is not `Send`
[INFO] [stderr]    |
[INFO] [stderr]    = help: within `{async block@$DIR/tests/ui/instrument_entered_across_await.rs:18:26: 18:36}`, the trait `Send` is not implemented for `*const ()`
[INFO] [stderr] note: future is not `Send` as this value is used across an await
[INFO] [stderr]   --> tests/ui/instrument_entered_across_await.rs:21:23
[INFO] [stderr]    |
[INFO] [stderr] 20 |         let _entered = span.enter();
[INFO] [stderr]    |             -------- has type `Entered<'_>` which is not `Send`
[INFO] [stderr] 21 |         yield_point().await;
[INFO] [stderr]    |                       ^^^^^ await occurs here, with `_entered` maybe used later
[INFO] [stderr] note: required by a bound in `require_send`
[INFO] [stderr]   --> tests/ui/instrument_entered_across_await.rs:8:42
[INFO] [stderr]    |
[INFO] [stderr]  8 | fn require_send<F: std::future::Future + Send>(future: F) -> F {
[INFO] [stderr]    |                                          ^^^^ required by this bound in `require_send`
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] 
[INFO] [stderr] ACTUAL OUTPUT:
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] error: future cannot be sent between threads safely
[INFO] [stderr]   --> tests/ui/instrument_entered_across_await.rs:18:13
[INFO] [stderr]    |
[INFO] [stderr] 18 |       let _ = require_send(async move {
[INFO] [stderr]    |  _____________^
[INFO] [stderr] 19 | |         let span = CallSpan::new(&CALLSITE, levels, Map::new);
[INFO] [stderr] 20 | |         let _entered = span.enter();
[INFO] [stderr] 21 | |         yield_point().await;
[INFO] [stderr] 22 | |     });
[INFO] [stderr]    | |______^ future created by async block is not `Send`
[INFO] [stderr]    |
[INFO] [stderr]    = help: within `{async block@$DIR/tests/ui/instrument_entered_across_await.rs:18:26: 18:36}`, the trait `Send` is not implemented for `*const ()`
[INFO] [stderr] note: future is not `Send` as this value is used across an await
[INFO] [stderr]   --> tests/ui/instrument_entered_across_await.rs:21:23
[INFO] [stderr]    |
[INFO] [stderr] 20 |         let _entered = span.enter();
[INFO] [stderr]    |             -------- has type `sc_observability_log::__private::Entered<'_>` which is not `Send`
[INFO] [stderr] 21 |         yield_point().await;
[INFO] [stderr]    |                       ^^^^^ await occurs here, with `_entered` maybe used later
[INFO] [stderr] note: required by a bound in `require_send`
[INFO] [stderr]   --> tests/ui/instrument_entered_across_await.rs:8:42
[INFO] [stderr]    |
[INFO] [stderr]  8 | fn require_send<F: std::future::Future + Send>(future: F) -> F {
[INFO] [stderr]    |                                          ^^^^ required by this bound in `require_send`
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] note: If the actual output is the correct output you can bless it by rerunning
[INFO] [stderr]       your test with the environment variable TRYBUILD=overwrite
[INFO] [stderr] 
[INFO] [stderr] test tests/ui/instrument_field_empty.rs ... ok
[INFO] [stderr] test tests/ui/instrument_follows_from.rs ... ok
[INFO] [stderr] test tests/ui/instrument_literal_key.rs ... ok
[INFO] [stderr] test tests/ui/instrument_non_fn.rs ... ok
[INFO] [stderr] test tests/ui/instrument_parent.rs ... ok
[INFO] [stderr] test tests/ui/instrument_reserved_key.rs ... ok
[INFO] [stderr] test tests/ui/log_control_cannot_elevate_or_reset.rs ... ok
[INFO] [stderr] test tests/ui/log_control_not_owner.rs ... ok
[INFO] [stderr] test tests/ui/log_guard_not_clone.rs ... ok
[INFO] [stderr] 
[INFO] [stderr] 
[INFO] [stderr] error: test failed, to rerun pass `--test ui`
[INFO] [stdout] test rejected_event_forms_fail_to_compile ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- log_control_is_not_constructible_outside_the_crate stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'log_control_is_not_constructible_outside_the_crate' (2068) panicked at tests/ui.rs:173:9:
[INFO] [stdout] cargo failed before compiling the probe (resolution, network or toolchain); infrastructure failure, not privacy evidence
[INFO] [stdout] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stdout]   --> /opt/rustwide/workdir/Cargo.toml:67:12
[INFO] [stdout]    |
[INFO] [stdout] 67 | homepage = "https://github.com/randlee/sc-observability"
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] ...
[INFO] [stdout] 72 | repository = "https://github.com/randlee/sc-observability"
[INFO] [stdout]    |              ---------------------------------------------
[INFO] [stdout]    |
[INFO] [stdout]    = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stdout] help: consider removing `package.homepage`
[INFO] [stdout] error: failed to get `hostname` as a dependency of package `sc-observability-log v1.5.0 (/opt/rustwide/workdir)`
[INFO] [stdout]     ... which satisfies path dependency `sc-observability-log` of package `log-control-privacy-probe v0.0.0 (/tmp/.tmpIjCPua)`
[INFO] [stdout] 
[INFO] [stdout] Caused by:
[INFO] [stdout]   failed to load source for dependency `hostname`
[INFO] [stdout] 
[INFO] [stdout] Caused by:
[INFO] [stdout]   unable to update registry `crates-io`
[INFO] [stdout] 
[INFO] [stdout] Caused by:
[INFO] [stdout]   download of config.json failed
[INFO] [stdout] 
[INFO] [stdout] Caused by:
[INFO] [stdout]   [6] Could not resolve hostname (Could not resolve host: index.crates.io)
[INFO] [stdout] 
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x556bbfd81a71 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x556bbfd97e7a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x556bbfd862bc - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x556bbfd59dc6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x556bbfd78209 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x556bbfd0bff0 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x556bbfd783c2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x556bbfd59e72 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x556bbfd526c9 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x556bbfd5aa7d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x556bbfd985ec - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x556bbfc57133 - <ui[77423a553a7cad96]::ConsumerProbe>::check
[INFO] [stdout]   12:     0x556bbfc57cc6 - <ui[77423a553a7cad96]::log_control_is_not_constructible_outside_the_crate::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   13:     0x556bbfcff43b - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   14:     0x556bbfd0c615 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   15:     0x556bbfd05f04 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   16:     0x556bbfd0f6a2 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   17:     0x556bbfd80ccf - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   18:     0x7f8ab0cf6dfa - <unknown>
[INFO] [stdout]   19:     0x7f8ab0d8a3d4 - clone
[INFO] [stdout]   20:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- rejected_event_forms_fail_to_compile stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'rejected_event_forms_fail_to_compile' (2069) panicked at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/trybuild-1.0.121/src/run.rs:103:13:
[INFO] [stdout] 3 of 20 tests failed
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x556bbfd81a71 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x556bbfd97e7a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x556bbfd862bc - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x556bbfd59dc6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x556bbfd78209 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x556bbfd0bff0 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x556bbfd783c2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x556bbfd59e72 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x556bbfd526c9 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x556bbfd5aa7d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x556bbfd985ec - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x556bbfc65058 - <trybuild[9f00ed1fdcfad4f9]::Runner>::run
[INFO] [stdout]   12:     0x556bbfc682c0 - <trybuild[9f00ed1fdcfad4f9]::TestCases as core[a373ad73a504971]::ops::drop::Drop>::drop
[INFO] [stdout]   13:     0x556bbfc57854 - <ui[77423a553a7cad96]::rejected_event_forms_fail_to_compile::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x556bbfcff43b - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   15:     0x556bbfd0c615 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   16:     0x556bbfd05f04 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x556bbfd0f6a2 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x556bbfd80ccf - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x7f8ab0cf6dfa - <unknown>
[INFO] [stdout]   20:     0x7f8ab0d8a3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     log_control_is_not_constructible_outside_the_crate
[INFO] [stdout]     rejected_event_forms_fail_to_compile
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 69.53s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "fb61d637240b2f90a78f15b5f0068e42ea959b881c67545622c1de866a714751", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fb61d637240b2f90a78f15b5f0068e42ea959b881c67545622c1de866a714751", kill_on_drop: false }`
[INFO] [stdout] fb61d637240b2f90a78f15b5f0068e42ea959b881c67545622c1de866a714751
