[INFO] fetching crate amaru-observability-macros 0.1.2...
[INFO] testing amaru-observability-macros-0.1.2 against 1.98.0-beta.8+cargoflags=--release for beta-release-1.99-2
[INFO] extracting crate amaru-observability-macros 0.1.2 into /workspace/builds/worker-2-tc1/source
[INFO] started tweaking crates.io crate amaru-observability-macros 0.1.2
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate amaru-observability-macros 0.1.2
[INFO] tweaked toml for crates.io crate amaru-observability-macros 0.1.2 written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate amaru-observability-macros 0.1.2 on toolchain 1.98.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.98.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate amaru-observability-macros 0.1.2 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.98.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 toml_writer v1.0.6+spec-1.1.0
[INFO] [stderr]   Downloaded serde_spanned v1.0.4
[INFO] [stderr]   Downloaded trybuild v1.0.115
[INFO] [stderr]   Downloaded target-triple v1.0.0
[INFO] [stderr]   Downloaded toml v0.9.10+spec-1.1.0
[INFO] [stderr]   Downloaded inventory v0.3.21
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:8683fc1fc2eb5c9ac98e0d076ab094b2ffac7f99da555d2b6a2e27f346de2ec7" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 24dcfb6eeb377d06975a4b67f00ee266fb93127c7353aca9def06a26abc417b2
[INFO] running `Command { std: "docker" "start" "24dcfb6eeb377d06975a4b67f00ee266fb93127c7353aca9def06a26abc417b2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "24dcfb6eeb377d06975a4b67f00ee266fb93127c7353aca9def06a26abc417b2", 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" "24dcfb6eeb377d06975a4b67f00ee266fb93127c7353aca9def06a26abc417b2" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "24dcfb6eeb377d06975a4b67f00ee266fb93127c7353aca9def06a26abc417b2", 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" "24dcfb6eeb377d06975a4b67f00ee266fb93127c7353aca9def06a26abc417b2" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.103
[INFO] [stderr]    Compiling unicode-ident v1.0.22
[INFO] [stderr]    Compiling quote v1.0.42
[INFO] [stderr]    Compiling inventory v0.3.21
[INFO] [stderr]    Compiling syn v2.0.111
[INFO] [stderr]    Compiling amaru-observability-macros v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 10.04s
[INFO] running `Command { std: "docker" "inspect" "24dcfb6eeb377d06975a4b67f00ee266fb93127c7353aca9def06a26abc417b2", 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" "24dcfb6eeb377d06975a4b67f00ee266fb93127c7353aca9def06a26abc417b2" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling target-triple v1.0.0
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling unicode-ident v1.0.22
[INFO] [stderr]    Compiling regex-syntax v0.8.8
[INFO] [stderr]    Compiling winnow v0.7.14
[INFO] [stderr]    Compiling proc-macro2 v1.0.103
[INFO] [stderr]    Compiling quote v1.0.42
[INFO] [stderr]    Compiling toml_writer v1.0.6+spec-1.1.0
[INFO] [stderr]    Compiling pin-project-lite v0.2.16
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling syn v2.0.111
[INFO] [stderr]    Compiling termcolor v1.4.1
[INFO] [stderr]    Compiling glob v0.3.3
[INFO] [stderr]    Compiling inventory v0.3.21
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling ryu v1.0.20
[INFO] [stderr]    Compiling itoa v1.0.15
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling nu-ansi-term v0.50.3
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling toml_parser v1.0.6+spec-1.1.0
[INFO] [stderr]    Compiling serde_spanned v1.0.4
[INFO] [stderr]    Compiling toml_datetime v0.7.5+spec-1.1.0
[INFO] [stderr]    Compiling toml v0.9.10+spec-1.1.0
[INFO] [stderr]    Compiling tracing-serde v0.2.0
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling amaru-observability-macros v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling tracing-subscriber v0.3.22
[INFO] [stderr]    Compiling trybuild v1.0.115
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1m 07s
[INFO] running `Command { std: "docker" "inspect" "24dcfb6eeb377d06975a4b67f00ee266fb93127c7353aca9def06a26abc417b2", 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" "24dcfb6eeb377d06975a4b67f00ee266fb93127c7353aca9def06a26abc417b2" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.8" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.09s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/amaru_observability_macros-32759cd93e12b5da)
[INFO] [stdout] 
[INFO] [stdout] running 17 tests
[INFO] [stdout] test define_schemas::tests::test_duplicate_field_error ... ok
[INFO] [stdout] test define_schemas::tests::test_extract_schema_with_optional ... ok
[INFO] [stdout] test define_schemas::tests::test_missing_description_error ... ok
[INFO] [stdout] test define_schemas::tests::test_multiline_description ... ok
[INFO] [stdout] test define_schemas::tests::test_schema_validation_string ... ok
[INFO] [stdout] test define_schemas::tests::test_tokenize_nested ... ok
[INFO] [stdout] test define_schemas::tests::test_tokenize_simple ... ok
[INFO] [stdout] test define_schemas::tests::test_with_description ... ok
[INFO] [stdout] test utils::tests::test_is_identifier_start ... ok
[INFO] [stdout] test utils::tests::test_is_uppercase_identifier ... ok
[INFO] [stdout] test utils::tests::test_path_operations ... ok
[INFO] [stdout] test utils::tests::test_path_edge_cases ... ok
[INFO] [stdout] test utils::tests::test_strip_leading_underscores ... ok
[INFO] [stdout] test utils::tests::test_is_valid_identifier ... ok
[INFO] [stdout] test define_schemas::tests::test_tokenize_with_commas ... ok
[INFO] [stdout] test define_schemas::tests::test_extract_multiple_schemas ... ok
[INFO] [stdout] test define_schemas::tests::test_extract_simple_schema ... ok
[INFO] [stderr]      Running tests/instrument_target.rs (/opt/rustwide/target/release/deps/instrument_target-231456af616be314)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test test_span_level_is_trace ... ok
[INFO] [stdout] test test_schema_fields_declared ... ok
[INFO] [stdout] test test_span_target_and_name ... ok
[INFO] [stdout] test test_field_values_recorded ... ok
[INFO] [stdout] test test_trace_record_records_to_span ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/private_keyword.rs (/opt/rustwide/target/release/deps/private_keyword-6281216e11166d9c)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test_private_keyword_in_schemas ... 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/trace_levels.rs (/opt/rustwide/target/release/deps/trace_levels-8eb5b338429ab38d)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test test_trace_with_error_level ... ok
[INFO] [stdout] test test_trace_default_trace_level ... ok
[INFO] [stdout] test test_trace_with_level_and_custom_fields ... ok
[INFO] [stdout] test test_trace_with_info_level ... ok
[INFO] [stdout] test test_trace_with_warn_level ... ok
[INFO] [stdout] test test_trace_with_debug_level ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/trace_span_record_levels.rs (/opt/rustwide/target/release/deps/trace_span_record_levels-f98df4d15014a188)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test test_trace_record_with_debug_level_emits_event ... ok
[INFO] [stdout] test test_trace_record_with_error_level_emits_event ... ok
[INFO] [stdout] test test_trace_record_with_info_level_emits_event ... ok
[INFO] [stdout] test test_trace_record_with_trace_level_emits_event ... ok
[INFO] [stdout] test test_trace_record_without_level_no_event ... ok
[INFO] [stdout] test test_trace_span_default_trace_level ... ok
[INFO] [stdout] test test_trace_span_with_error_level ... ok
[INFO] [stdout] test test_trace_span_with_debug_level ... ok
[INFO] [stdout] test test_trace_span_with_info_level ... ok
[INFO] [stdout] test test_trace_record_with_warn_level_emits_event ... ok
[INFO] [stdout] test test_trace_span_with_warn_level ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ui.rs (/opt/rustwide/target/release/deps/ui-5ee2338c5907318d)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]    Compiling proc-macro2 v1.0.103
[INFO] [stderr]    Compiling quote v1.0.42
[INFO] [stderr]    Compiling unicode-ident v1.0.22
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]     Checking once_cell v1.21.3
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]     Checking regex-syntax v0.8.8
[INFO] [stderr]     Checking lazy_static v1.5.0
[INFO] [stderr]     Checking log v0.4.29
[INFO] [stderr]     Checking itoa v1.0.15
[INFO] [stderr]     Checking pin-project-lite v0.2.16
[INFO] [stderr]     Checking memchr v2.7.6
[INFO] [stderr]     Checking ryu v1.0.20
[INFO] [stderr]     Checking cfg-if v1.0.4
[INFO] [stderr]    Compiling inventory v0.3.21
[INFO] [stderr]     Checking thread_local v1.1.9
[INFO] [stderr]     Checking nu-ansi-term v0.50.3
[INFO] [stderr]     Checking sharded-slab v0.1.7
[INFO] [stderr]     Checking smallvec v1.15.1
[INFO] [stderr]     Checking tracing-core v0.1.36
[INFO] [stderr]     Checking tracing-log v0.2.0
[INFO] [stderr]     Checking syn v2.0.111
[INFO] [stderr]     Checking regex-automata v0.4.13
[INFO] [stderr]     Checking matchers v0.2.0
[INFO] [stderr]     Checking tracing-serde v0.2.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling amaru-observability-macros v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Checking tracing v0.1.44
[INFO] [stderr]     Checking tracing-subscriber v0.3.22
[INFO] [stderr]     Checking amaru-observability-macros-tests v0.0.0 (/opt/rustwide/target/tests/trybuild/amaru-observability-macros)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 13.23s
[INFO] [stderr] 
[INFO] [stderr] 
[INFO] [stdout] test ui_compile_fail_tests ... ok
[INFO] [stderr] test tests/ui/compile_fail/custom_expr_unknown_field.rs ... ok
[INFO] [stdout] 
[INFO] [stderr] test tests/ui/compile_fail/duplicate_field.rs ... ok
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 20.80s
[INFO] [stderr] test tests/ui/compile_fail/invalid_schema_name_with_colon.rs ... ok
[INFO] [stdout] 
[INFO] [stderr] test tests/ui/compile_fail/missing_required_field.rs ... ok
[INFO] [stderr] test tests/ui/compile_fail/underscore_collision.rs ... ok
[INFO] [stderr] test tests/ui/compile_fail/wrong_field_type.rs ... ok
[INFO] [stderr] test tests/ui/compile_fail/wrong_schema_in_module.rs ... ok
[INFO] [stderr] 
[INFO] [stderr] 
[INFO] [stderr]      Running tests/validation.rs (/opt/rustwide/target/release/deps/validation-5581a3d1d5b1172f)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test extra_params::test_extra_params_ignored ... ok
[INFO] [stdout] test namespace_paths::test_namespace_paths ... ok
[INFO] [stdout] test required_fields::test_required_fields ... ok
[INFO] [stdout] test trace_record_tests::test_trace_record ... ok
[INFO] [stdout] test custom_expressions::test_custom_expressions ... ok
[INFO] [stdout] test optional_fields::test_optional_fields ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests amaru_observability_macros
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/utils.rs - utils::parse_schema_path (line 68) ... 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] [stdout] running 2 tests
[INFO] [stdout] test src/utils.rs - utils::parse_full_schema_path (line 125) ... ignored
[INFO] [stdout] test src/utils.rs - utils::parse_macro_module (line 91) ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.51s; merged doctests compilation took 0.50s
[INFO] running `Command { std: "docker" "inspect" "24dcfb6eeb377d06975a4b67f00ee266fb93127c7353aca9def06a26abc417b2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "24dcfb6eeb377d06975a4b67f00ee266fb93127c7353aca9def06a26abc417b2", kill_on_drop: false }`
[INFO] [stdout] 24dcfb6eeb377d06975a4b67f00ee266fb93127c7353aca9def06a26abc417b2
