[INFO] fetching crate sc-observability-log 1.4.1...
[INFO] testing sc-observability-log-1.4.1 against 1.99.0-beta.8 for beta-1.100-2
[INFO] extracting crate sc-observability-log 1.4.1 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate sc-observability-log 1.4.1
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate sc-observability-log 1.4.1
[INFO] tweaked toml for crates.io crate sc-observability-log 1.4.1 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate sc-observability-log 1.4.1 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate sc-observability-log 1.4.1 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.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded hostname v0.4.2
[INFO] [stderr]   Downloaded sc-observability-types v1.4.1
[INFO] [stderr]   Downloaded sc-observability v1.4.1
[INFO] [stderr]   Downloaded sc-observability-log-macros v1.4.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] b9af44ce58074668e5ffa8d1f830e08378ac678f851f24ff719581b59b9fc271
[INFO] running `Command { std: "docker" "start" "b9af44ce58074668e5ffa8d1f830e08378ac678f851f24ff719581b59b9fc271", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b9af44ce58074668e5ffa8d1f830e08378ac678f851f24ff719581b59b9fc271", 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" "b9af44ce58074668e5ffa8d1f830e08378ac678f851f24ff719581b59b9fc271" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b9af44ce58074668e5ffa8d1f830e08378ac678f851f24ff719581b59b9fc271", 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" "b9af44ce58074668e5ffa8d1f830e08378ac678f851f24ff719581b59b9fc271" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v3.0.6
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling num-conv v0.2.2
[INFO] [stderr]    Compiling time-core v0.1.9
[INFO] [stderr]    Compiling powerfmt v0.2.0
[INFO] [stderr]    Compiling log v0.4.34
[INFO] [stderr]    Compiling sc-observability-log-macros v1.4.1
[INFO] [stderr]    Compiling deranged v0.5.8
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling hostname v0.4.2
[INFO] [stderr]    Compiling time v0.3.55
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling sc-observability-types v1.4.1
[INFO] [stderr]    Compiling sc-observability v1.4.1
[INFO] [stderr]    Compiling sc-observability-log v1.4.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 16.50s
[INFO] running `Command { std: "docker" "inspect" "b9af44ce58074668e5ffa8d1f830e08378ac678f851f24ff719581b59b9fc271", 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" "b9af44ce58074668e5ffa8d1f830e08378ac678f851f24ff719581b59b9fc271" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling target-tuple v1.0.2
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling rustix v1.1.5
[INFO] [stderr]    Compiling winnow v1.0.4
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling bitflags v2.13.2
[INFO] [stderr]    Compiling toml_writer v1.1.2+spec-1.1.0
[INFO] [stderr]    Compiling glob v0.3.4
[INFO] [stderr]    Compiling fastrand v2.5.0
[INFO] [stderr]    Compiling syn v3.0.6
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]    Compiling serde_spanned v1.1.1
[INFO] [stderr]    Compiling toml_datetime v1.1.1+spec-1.1.0
[INFO] [stderr]    Compiling toml_parser v1.1.3+spec-1.1.0
[INFO] [stderr]    Compiling toml v1.1.6+spec-1.1.0
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling tokio-macros v2.7.2
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling sc-observability-log-macros v1.4.1
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling sc-observability-types v1.4.1
[INFO] [stderr]    Compiling trybuild v1.0.121
[INFO] [stderr]    Compiling sc-observability v1.4.1
[INFO] [stderr]    Compiling sc-observability-log v1.4.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 27.22s
[INFO] running `Command { std: "docker" "inspect" "b9af44ce58074668e5ffa8d1f830e08378ac678f851f24ff719581b59b9fc271", 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" "b9af44ce58074668e5ffa8d1f830e08378ac678f851f24ff719581b59b9fc271" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen", 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/sc_observability_log-983d9c7a744fd321)
[INFO] [stdout] 
[INFO] [stdout] running 58 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::serialize_failures_record_null_and_error ... 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 callsite::tests::dynamic_key_caches_field_key_label ... ok
[INFO] [stdout] test callsite::tests::static_fields_use_the_same_canonical_key_as_dynamic_fields ... ok
[INFO] [stdout] test context::tests::fields_are_not_recorded_when_every_level_is_disabled ... ok
[INFO] [stdout] test error::tests::field_key_error_variants_are_cloneable_and_round_trip ... ok
[INFO] [stdout] test control::tests::control_is_send_and_sync ... ok
[INFO] [stdout] test error::tests::drop_cause_all_lists_every_variant_once ... ok
[INFO] [stdout] test error::tests::flush_error_codes_and_remediations ... ok
[INFO] [stdout] test handle::tests::native_flush_counter_positive_control_and_facade_zero_proof ... ok
[INFO] [stdout] test context::tests::current_trace_is_none_on_a_fresh_thread ... ok
[INFO] [stdout] test error::tests::shutdown_error_codes_and_remediations ... ok
[INFO] [stdout] test context::tests::entered_pops_only_its_own_entry ... ok
[INFO] [stdout] test error_codes::tests::all_codes_are_unique_and_prefixed ... ok
[INFO] [stdout] test error::tests::init_error_codes_and_remediations ... ok
[INFO] [stdout] test handle::tests::run_bounded_returns_value ... ok
[INFO] [stdout] test error::tests::every_native_operation_error_variant_is_data_only_and_round_trips ... ok
[INFO] [stdout] test context::tests::nested_spans_link_and_the_stack_unwinds ... ok
[INFO] [stdout] test handle::tests::bridge_has_no_independent_level_policy ... ok
[INFO] [stdout] test mapping::tests::action_label_rejects_empty ... 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::field_key_label_rules ... ok
[INFO] [stdout] test health::tests::native_shape_round_trips ... ok
[INFO] [stdout] test health::tests::unavailable_has_the_target_code_and_remediation ... ok
[INFO] [stdout] test mapping::tests::identity_auto_uses_hostname_and_current_pid ... ok
[INFO] [stdout] test mapping::tests::identity_fixed_is_used_as_given ... ok
[INFO] [stdout] test handle::tests::run_bounded_counts_a_detached_helper_until_it_finishes ... ok
[INFO] [stdout] test handle::tests::run_bounded_losing_race_returns_the_published_value ... ok
[INFO] [stdout] test mapping::tests::kv_key_rules_omit_reserved_and_empty_keys_and_shadow_code_keys ... ok
[INFO] [stdout] test mapping::tests::kv_row_types_json_values ... 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::sanitizer_rewrites_paths_and_invalid_chars ... 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 mapping::tests::target_label_maps_empty_to_log ... ok
[INFO] [stdout] test tests::level_serializes_with_the_log_event_spelling ... ok
[INFO] [stdout] test context::tests::entered_records_a_panic_while_unwinding ... ok
[INFO] [stdout] test mapping::tests::identity_auto_fails_on_an_empty_hostname ... ok
[INFO] [stdout] test mapping::tests::identity_resolver_ok_and_err ... ok
[INFO] [stdout] test handle::tests::emit_core_counts_panics_and_reentry ... ok
[INFO] [stdout] test handle::tests::flight_claim_is_exclusive_and_released_on_drop_or_panic ... ok
[INFO] [stdout] test handle::tests::reserved_shutdown_worker_publishes_failure_after_a_waiter_times_out ... ok
[INFO] [stdout] test mapping::tests::identity_auto_fails_when_the_hostname_lookup_fails ... ok
[INFO] [stdout] test handle::tests::shutdown_test_release_survives_assertion_unwind ... ok
[INFO] [stdout] test handle::tests::run_bounded_reports_worker_lost_on_panic ... ok
[INFO] [stdout] test handle::tests::missing_shutdown_hook_times_out_and_releases_worker ... ok
[INFO] [stdout] test handle::tests::run_bounded_uncounts_a_detached_helper_that_panics ... ok
[INFO] [stdout] test handle::tests::take_sole_succeeds_once_clone_is_released ... ok
[INFO] [stdout] test context::tests::generated_ids_always_validate ... ok
[INFO] [stdout] test handle::tests::run_bounded_times_out_on_blocked_work ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 58 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.11s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/api_freeze.rs (/opt/rustwide/target/debug/deps/api_freeze-73dbb41c2ef7de04)
[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/bridge_guard.rs (/opt/rustwide/target/debug/deps/bridge_guard-e81dd2b23b9c803c)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[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.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/bridge_jsonl.rs (/opt/rustwide/target/debug/deps/bridge_jsonl-9544dfd184d3365b)
[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_queue_full.rs (/opt/rustwide/target/debug/deps/bridge_queue_full-7a770ddf2ab0fd5b)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] 2026-10-06T17:57:42.822788868Z INFO flood log.record thread 1 record 0
[INFO] [stdout] 2026-10-06T17:57:42.825239168Z INFO flood log.record thread 4 record 4
[INFO] [stdout] 2026-10-06T17:57:42.826774298Z INFO flood log.record thread 6 record 25
[INFO] [stdout] 2026-10-06T17:57:42.826847248Z INFO flood log.record thread 6 record 27
[INFO] [stdout] 2026-10-06T17:57:42.826971918Z INFO flood log.record thread 6 record 30
[INFO] [stdout] 2026-10-06T17:57:42.828481708Z INFO flood log.record thread 7 record 42
[INFO] [stdout] 2026-10-06T17:57:42.828565978Z INFO flood log.record thread 7 record 44
[INFO] [stdout] 2026-10-06T17:57:42.828633058Z INFO flood log.record thread 7 record 46
[INFO] [stdout] 2026-10-06T17:57:42.828654808Z INFO flood log.record thread 7 record 47
[INFO] [stdout] 2026-10-06T17:57:42.828665678Z INFO flood log.record thread 7 record 48
[INFO] [stdout] 2026-10-06T17:57:42.828772468Z INFO flood log.record thread 4 record 14
[INFO] [stdout] 2026-10-06T17:57:42.828847408Z INFO flood log.record thread 4 record 16
[INFO] [stdout] 2026-10-06T17:57:42.828859658Z INFO flood log.record thread 4 record 17
[INFO] [stdout] 2026-10-06T17:57:42.828994398Z INFO flood log.record thread 4 record 20
[INFO] [stdout] 2026-10-06T17:57:42.829014588Z INFO flood log.record thread 4 record 21
[INFO] [stdout] 2026-10-06T17:57:42.829083828Z INFO flood log.record thread 4 record 23
[INFO] [stdout] 2026-10-06T17:57:42.829152478Z INFO flood log.record thread 4 record 25
[INFO] [stdout] 2026-10-06T17:57:42.829170558Z INFO flood log.record thread 4 record 26
[INFO] [stdout] 2026-10-06T17:57:42.829206818Z INFO flood log.record thread 4 record 27
[INFO] [stdout] 2026-10-06T17:57:42.829301748Z INFO flood log.record thread 5 record 1
[INFO] [stdout] 2026-10-06T17:57:42.829381768Z INFO flood log.record thread 4 record 29
[INFO] [stdout] 2026-10-06T17:57:42.829455858Z INFO flood log.record thread 4 record 31
[INFO] [stdout] 2026-10-06T17:57:42.829473328Z INFO flood log.record thread 4 record 32
[INFO] [stdout] 2026-10-06T17:57:42.829540078Z INFO flood log.record thread 4 record 34
[INFO] [stdout] 2026-10-06T17:57:42.829558258Z INFO flood log.record thread 4 record 35
[INFO] [stdout] 2026-10-06T17:57:42.829573698Z INFO flood log.record thread 4 record 36
[INFO] [stdout] 2026-10-06T17:57:42.829588228Z INFO flood log.record thread 4 record 37
[INFO] [stdout] 2026-10-06T17:57:42.829891368Z INFO flood log.record thread 3 record 8
[INFO] [stdout] 2026-10-06T17:57:42.829926698Z INFO flood log.record thread 3 record 9
[INFO] [stdout] 2026-10-06T17:57:42.830016748Z INFO flood log.record thread 1 record 18
[INFO] [stdout] 2026-10-06T17:57:42.830087448Z INFO flood log.record thread 1 record 20
[INFO] [stdout] 2026-10-06T17:57:42.830227528Z INFO flood log.record thread 1 record 23
[INFO] [stdout] 2026-10-06T17:57:42.830296088Z INFO flood log.record thread 1 record 25
[INFO] [stdout] 2026-10-06T17:57:42.830494448Z INFO flood log.record thread 1 record 30
[INFO] [stdout] 2026-10-06T17:57:42.830564708Z INFO flood log.record thread 1 record 32
[INFO] [stdout] 2026-10-06T17:57:42.830639858Z INFO flood log.record thread 1 record 34
[INFO] [stdout] 2026-10-06T17:57:42.830754888Z INFO flood log.record thread 1 record 37
[INFO] [stdout] 2026-10-06T17:57:42.830824718Z INFO flood log.record thread 1 record 39
[INFO] [stdout] 2026-10-06T17:57:42.830844728Z INFO flood log.record thread 1 record 40
[INFO] [stdout] 2026-10-06T17:57:42.831025938Z INFO flood log.record thread 1 record 44
[INFO] [stdout] 2026-10-06T17:57:42.831047058Z INFO flood log.record thread 1 record 45
[INFO] [stdout] 2026-10-06T17:57:42.831056528Z INFO flood log.record thread 1 record 46
[INFO] [stdout] 2026-10-06T17:57:42.831119108Z INFO flood log.record thread 1 record 48
[INFO] [stdout] 2026-10-06T17:57:42.831209208Z INFO flood log.record thread 1 record 50
[INFO] [stdout] 2026-10-06T17:57:42.831266018Z INFO flood log.record thread 1 record 52
[INFO] [stdout] 2026-10-06T17:57:42.831275898Z INFO flood log.record thread 1 record 53
[INFO] [stdout] 2026-10-06T17:57:42.831377848Z INFO flood log.record thread 1 record 56
[INFO] [stdout] 2026-10-06T17:57:42.831492718Z INFO flood log.record thread 7 record 50
[INFO] [stdout] 2026-10-06T17:57:42.831512378Z INFO flood log.record thread 7 record 51
[INFO] [stdout] 2026-10-06T17:57:42.831865518Z INFO flood log.record thread 0 record 3
[INFO] [stdout] 2026-10-06T17:57:42.831906678Z INFO flood log.record thread 0 record 4
[INFO] [stdout] 2026-10-06T17:57:42.832123898Z INFO flood log.record thread 0 record 10
[INFO] [stdout] 2026-10-06T17:57:42.832195338Z INFO flood log.record thread 0 record 12
[INFO] [stdout] 2026-10-06T17:57:42.832342988Z INFO flood log.record thread 0 record 16
[INFO] [stdout] 2026-10-06T17:57:42.832360908Z INFO flood log.record thread 0 record 17
[INFO] [stdout] 2026-10-06T17:57:42.832414678Z INFO flood log.record thread 0 record 19
[INFO] [stdout] 2026-10-06T17:57:42.832476848Z INFO flood log.record thread 0 record 21
[INFO] [stdout] 2026-10-06T17:57:42.832594378Z INFO flood log.record thread 0 record 24
[INFO] [stdout] 2026-10-06T17:57:42.832779578Z INFO flood log.record thread 0 record 29
[INFO] [stdout] 2026-10-06T17:57:42.832862728Z INFO flood log.record thread 0 record 31
[INFO] [stdout] 2026-10-06T17:57:42.832922208Z INFO flood log.record thread 0 record 33
[INFO] [stdout] 2026-10-06T17:57:42.833192308Z INFO flood log.record thread 0 record 40
[INFO] [stdout] 2026-10-06T17:57:42.833432058Z INFO flood log.record thread 0 record 46
[INFO] [stdout] 2026-10-06T17:57:42.833543548Z INFO flood log.record thread 0 record 49
[INFO] [stdout] 2026-10-06T17:57:42.833562618Z INFO flood log.record thread 0 record 50
[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 1.76s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/compat_events.rs (/opt/rustwide/target/debug/deps/compat_events-cb1bde25fed02555)
[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_instrument.rs (/opt/rustwide/target/debug/deps/compat_instrument-d3356fd256556d9f)
[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/flush_single_flight.rs (/opt/rustwide/target/debug/deps/flush_single_flight-f9589a7f9f797ce9)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test stuck_flush_keeps_one_detached_helper_and_rejects_retries ... ok
[INFO] [stderr]      Running tests/health_snapshot.rs (/opt/rustwide/target/debug/deps/health_snapshot-5ff01dbe9b8bb3a5)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.15s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/init_runtime_start.rs (/opt/rustwide/target/debug/deps/init_runtime_start-10d2658103c1bab6)
[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] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stderr]      Running tests/instrument_jsonl.rs (/opt/rustwide/target/debug/deps/instrument_jsonl-07b5c6998006548a)
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test 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.16s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/macros_jsonl.rs (/opt/rustwide/target/debug/deps/macros_jsonl-19c3c271778dfeea)
[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/debug/deps/one_writer-ae9a8dea3fda0cac)
[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] [stderr]      Running tests/reinstall_subprocess.rs (/opt/rustwide/target/debug/deps/reinstall_subprocess-dd9ff02d809d94ff)
[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.01s
[INFO] [stdout] 
[INFO] [stdout] 
[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/debug/deps/runtime_level_bridge-80c6a440e29368fb)
[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] [stderr]      Running tests/shutdown_snapshot_unavailable.rs (/opt/rustwide/target/debug/deps/shutdown_snapshot_unavailable-70bdecd22263b756)
[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] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/shutdown_timeout.rs (/opt/rustwide/target/debug/deps/shutdown_timeout-594b93ab0921cf1a)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test gate_release_survives_assertion_unwind ... ok
[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] [stderr]      Running tests/static_level_cap.rs (/opt/rustwide/target/debug/deps/static_level_cap-182e3d0a5880f386)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ui.rs (/opt/rustwide/target/debug/deps/ui-b023e262442dfe57)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling unicode-ident v1.0.26
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling zmij v1.0.23
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]     Checking time-core v0.1.9
[INFO] [stderr]     Checking powerfmt v0.2.0
[INFO] [stderr]     Checking num-conv v0.2.2
[INFO] [stderr]     Checking cfg-if v1.0.5
[INFO] [stderr]     Checking memchr v2.8.3
[INFO] [stderr]     Checking itoa v1.0.18
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]     Checking once_cell v1.21.4
[INFO] [stderr]    Compiling rustix v1.1.5
[INFO] [stderr]     Checking linux-raw-sys v0.12.1
[INFO] [stderr]     Checking bitflags v2.13.2
[INFO] [stderr]     Checking pin-project-lite v0.2.17
[INFO] [stderr]     Checking log v0.4.34
[INFO] [stderr]     Checking fastrand v2.5.0
[INFO] [stderr]     Checking tracing-core v0.1.36
[INFO] [stderr]    Compiling syn v3.0.6
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]     Checking hostname v0.4.2
[INFO] [stderr]     Checking tempfile v3.27.0
[INFO] [stderr]     Checking deranged v0.5.8
[INFO] [stderr]     Checking time v0.3.55
[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]     Checking tokio v1.53.1
[INFO] [stderr]    Compiling sc-observability-log-macros v1.4.1
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]     Checking tracing v0.1.44
[INFO] [stderr]     Checking sc-observability-types v1.4.1
[INFO] [stderr]     Checking sc-observability v1.4.1
[INFO] [stderr]     Checking sc-observability-log v1.4.1 (/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 25.43s
[INFO] [stderr] 
[INFO] [stderr] 
[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]   |     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/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_constructible.rs ... ok
[INFO] [stderr] test tests/ui/log_control_not_owner.rs ... mismatch
[INFO] [stderr] 
[INFO] [stderr] EXPECTED:
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] error[E0599]: no method named `shutdown` found for struct `LogControl` in the current scope
[INFO] [stderr]  --> tests/ui/log_control_not_owner.rs:7:21
[INFO] [stderr]   |
[INFO] [stderr] 7 |     let _ = control.shutdown(Duration::from_secs(1));
[INFO] [stderr]   |                     ^^^^^^^^ method not found in `LogControl`
[INFO] [stderr] 
[INFO] [stderr] error[E0308]: mismatched types
[INFO] [stderr]   --> tests/ui/log_control_not_owner.rs:11:20
[INFO] [stderr]    |
[INFO] [stderr] 11 |     LogGuard::from(control)
[INFO] [stderr]    |     -------------- ^^^^^^^ expected `LogGuard`, found `LogControl`
[INFO] [stderr]    |     |
[INFO] [stderr]    |     arguments to this function are incorrect
[INFO] [stderr]    |
[INFO] [stderr] note: associated function defined here
[INFO] [stderr]   --> $RUST/core/src/convert/mod.rs
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] 
[INFO] [stderr] ACTUAL OUTPUT:
[INFO] [stderr] ┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈┈
[INFO] [stderr] error[E0599]: no method named `shutdown` found for struct `LogControl` in the current scope
[INFO] [stderr]  --> tests/ui/log_control_not_owner.rs:7:21
[INFO] [stderr]   |
[INFO] [stderr] 7 |     let _ = control.shutdown(Duration::from_secs(1));
[INFO] [stderr]   |                     ^^^^^^^^ method not found in `LogControl`
[INFO] [stderr] 
[INFO] [stderr] error[E0308]: mismatched types
[INFO] [stderr]   --> tests/ui/log_control_not_owner.rs:11:20
[INFO] [stderr]    |
[INFO] [stderr] 10 | fn control_into_owner(control: LogControl) -> LogGuard {
[INFO] [stderr]    |                                               -------- this return type influences the call expression's return type
[INFO] [stderr] 11 |     LogGuard::from(control)
[INFO] [stderr]    |     -------------- ^^^^^^^ expected `LogGuard`, found `LogControl`
[INFO] [stderr]    |     |
[INFO] [stderr]    |     arguments to this function are incorrect
[INFO] [stderr]    |
[INFO] [stderr] note: associated function defined here
[INFO] [stderr]   --> $RUST/core/src/convert/mod.rs
[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/log_guard_not_clone.rs ... ok
[INFO] [stderr] 
[INFO] [stderr] 
[INFO] [stdout] test rejected_event_forms_fail_to_compile ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- rejected_event_forms_fail_to_compile stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'rejected_event_forms_fail_to_compile' (1673) panicked at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/trybuild-1.0.121/src/run.rs:103:13:
[INFO] [stdout] 4 of 20 tests failed
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x621365610241 - std[70759c8f55707aa4]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x621365610241 - std[70759c8f55707aa4]::backtrace_rs::backtrace::trace_unsynchronized::<std[70759c8f55707aa4]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x621365610241 - std[70759c8f55707aa4]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x621365610241 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x621365626a4a - <core[df12db4294e9bfd3]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x621365626a4a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    6:     0x621365614d0c - core[df12db4294e9bfd3]::io::write::default_write_fmt::<alloc[2182bb758b4b3781]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x621365614d0c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x6213655e9726 - <std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x6213655e9726 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x6213656078b9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x6213655a0b90 - <alloc[2182bb758b4b3781]::boxed::Box<dyn for<'a, 'b> core[df12db4294e9bfd3]::ops::function::Fn<(&'a std[70759c8f55707aa4]::panic::PanicHookInfo<'b>,), Output = ()> + core[df12db4294e9bfd3]::marker::Send + core[df12db4294e9bfd3]::marker::Sync> as core[df12db4294e9bfd3]::ops::function::Fn<(&std[70759c8f55707aa4]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/alloc/src/boxed.rs:2334:9
[INFO] [stdout]   12:     0x6213655a0b90 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x621365607a72 - <alloc[2182bb758b4b3781]::boxed::Box<dyn for<'a, 'b> core[df12db4294e9bfd3]::ops::function::Fn<(&'a std[70759c8f55707aa4]::panic::PanicHookInfo<'b>,), Output = ()> + core[df12db4294e9bfd3]::marker::Send + core[df12db4294e9bfd3]::marker::Sync> as core[df12db4294e9bfd3]::ops::function::Fn<(&std[70759c8f55707aa4]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/alloc/src/boxed.rs:2334:9
[INFO] [stdout]   14:     0x621365607a72 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:823:13
[INFO] [stdout]   15:     0x6213655e97d2 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:688:13
[INFO] [stdout]   16:     0x6213655e2099 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x6213655ea3cd - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:679:5
[INFO] [stdout]   18:     0x62136562723c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x62136537cda4 - <trybuild[8e828c289c0b27d2]::Runner>::run
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/trybuild-1.0.121/src/run.rs:103:13
[INFO] [stdout]   20:     0x621365388338 - <trybuild[8e828c289c0b27d2]::TestCases as core[df12db4294e9bfd3]::ops::drop::Drop>::drop
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/trybuild-1.0.121/src/lib.rs:342:38
[INFO] [stdout]   21:     0x621365375d47 - core[df12db4294e9bfd3]::ptr::drop_glue::<trybuild[8e828c289c0b27d2]::TestCases>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/ptr/mod.rs:847:1
[INFO] [stdout]   22:     0x621365375f53 - ui[80d55f9bfd38f0c2]::rejected_event_forms_fail_to_compile
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/ui.rs:10:1
[INFO] [stdout]   23:     0x621365375ea7 - ui[80d55f9bfd38f0c2]::rejected_event_forms_fail_to_compile::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/ui.rs:7:42
[INFO] [stdout]   24:     0x6213653763b6 - <ui[80d55f9bfd38f0c2]::rejected_event_forms_fail_to_compile::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x621365593e7b - <fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String> as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x621365593e7b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:733:18
[INFO] [stdout]   27:     0x6213655a14e5 - test[9d35eded1c95d3be]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:756:74
[INFO] [stdout]   28:     0x6213655a14e5 - <core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<test[9d35eded1c95d3be]::run_test_in_process::{closure#0}> as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x6213655a14e5 - std[70759c8f55707aa4]::panicking::catch_unwind::do_call::<core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<test[9d35eded1c95d3be]::run_test_in_process::{closure#0}>, core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:576:43
[INFO] [stdout]   30:     0x6213655a14e5 - std[70759c8f55707aa4]::panicking::catch_unwind::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<test[9d35eded1c95d3be]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x6213655a14e5 - std[70759c8f55707aa4]::panic::catch_unwind::<core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<test[9d35eded1c95d3be]::run_test_in_process::{closure#0}>, core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x6213655a14e5 - test[9d35eded1c95d3be]::run_test_in_process
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:756:27
[INFO] [stdout]   33:     0x6213655a14e5 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:677:43
[INFO] [stdout]   34:     0x62136559ada4 - test[9d35eded1c95d3be]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:707:41
[INFO] [stdout]   35:     0x62136559ada4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x6213655a4642 - std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   37:     0x6213655a4642 - <core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x6213655a4642 - std[70759c8f55707aa4]::panicking::catch_unwind::do_call::<core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:576:43
[INFO] [stdout]   39:     0x6213655a4642 - std[70759c8f55707aa4]::panicking::catch_unwind::<(), core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x6213655a4642 - std[70759c8f55707aa4]::panic::catch_unwind::<core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x6213655a4642 - std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   42:     0x6213655a4642 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x62136560f4f9 - <alloc[2182bb758b4b3781]::boxed::Box<dyn core[df12db4294e9bfd3]::ops::function::FnOnce<(), Output = ()> + core[df12db4294e9bfd3]::marker::Send> as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/alloc/src/boxed.rs:2320:9
[INFO] [stdout]   44:     0x62136560f4f9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/thread/unix.rs:123:17
[INFO] [stdout]   45:     0x7a34dcbeddfa - <unknown>
[INFO] [stdout]   46:     0x7a34dcc813d4 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     rejected_event_forms_fail_to_compile
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 38.65s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test ui`
[INFO] running `Command { std: "docker" "inspect" "b9af44ce58074668e5ffa8d1f830e08378ac678f851f24ff719581b59b9fc271", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b9af44ce58074668e5ffa8d1f830e08378ac678f851f24ff719581b59b9fc271", kill_on_drop: false }`
[INFO] [stdout] b9af44ce58074668e5ffa8d1f830e08378ac678f851f24ff719581b59b9fc271
