[INFO] fetching crate rovo-macros 0.4.8...
[INFO] testing rovo-macros-0.4.8 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-2
[INFO] extracting crate rovo-macros 0.4.8 into /workspace/builds/worker-3-tc2/source
[INFO] started tweaking crates.io crate rovo-macros 0.4.8
[INFO] finished tweaking crates.io crate rovo-macros 0.4.8
[INFO] tweaked toml for crates.io crate rovo-macros 0.4.8 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate rovo-macros 0.4.8 on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate rovo-macros 0.4.8 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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 45743ae3caf16e3310fd69bb009daa03491514691e6cbbec807dbec078a0c4d7
[INFO] running `Command { std: "docker" "start" "-a" "45743ae3caf16e3310fd69bb009daa03491514691e6cbbec807dbec078a0c4d7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "45743ae3caf16e3310fd69bb009daa03491514691e6cbbec807dbec078a0c4d7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "45743ae3caf16e3310fd69bb009daa03491514691e6cbbec807dbec078a0c4d7", kill_on_drop: false }`
[INFO] [stdout] 45743ae3caf16e3310fd69bb009daa03491514691e6cbbec807dbec078a0c4d7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 3d8fa479abd6499f32bece8087453140ca907f226ec8e21a5c8202739e3c5bea
[INFO] running `Command { std: "docker" "start" "-a" "3d8fa479abd6499f32bece8087453140ca907f226ec8e21a5c8202739e3c5bea", kill_on_drop: false }`
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling syn v2.0.116
[INFO] [stderr]    Compiling rovo-macros v0.4.8 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 3.46s
[INFO] running `Command { std: "docker" "inspect" "3d8fa479abd6499f32bece8087453140ca907f226ec8e21a5c8202739e3c5bea", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3d8fa479abd6499f32bece8087453140ca907f226ec8e21a5c8202739e3c5bea", kill_on_drop: false }`
[INFO] [stdout] 3d8fa479abd6499f32bece8087453140ca907f226ec8e21a5c8202739e3c5bea
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 29cfdbe44366b71fbeab70ab825d6459c28793fd824530b933db502105cccc22
[INFO] running `Command { std: "docker" "start" "-a" "29cfdbe44366b71fbeab70ab825d6459c28793fd824530b933db502105cccc22", kill_on_drop: false }`
[INFO] [stderr]    Compiling rovo-macros v0.4.8 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.21s
[INFO] running `Command { std: "docker" "inspect" "29cfdbe44366b71fbeab70ab825d6459c28793fd824530b933db502105cccc22", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "29cfdbe44366b71fbeab70ab825d6459c28793fd824530b933db502105cccc22", kill_on_drop: false }`
[INFO] [stdout] 29cfdbe44366b71fbeab70ab825d6459c28793fd824530b933db502105cccc22
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] fda5f6b54fae7cc004957b298106e2755aa3ef5e43ba916dc4ec0a14311e8019
[INFO] running `Command { std: "docker" "start" "-a" "fda5f6b54fae7cc004957b298106e2755aa3ef5e43ba916dc4ec0a14311e8019", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rovo_macros-b92e9f6c0716d020)
[INFO] [stdout] 
[INFO] [stdout] running 70 tests
[INFO] [stdout] test parser::annotations::tests::example_from_parts_empty_code ... ok
[INFO] [stdout] test parser::annotations::tests::example_from_parts_escaped_quotes ... ok
[INFO] [stdout] test parser::annotations::tests::example_from_parts_invalid_status ... ok
[INFO] [stdout] test parser::annotations::tests::example_from_parts_invalid_syntax ... ok
[INFO] [stdout] test parser::annotations::tests::example_from_parts_struct_expression ... ok
[INFO] [stdout] test parser::annotations::tests::example_from_parts_valid ... ok
[INFO] [stdout] test parser::annotations::tests::example_from_parts_vec_expression ... ok
[INFO] [stdout] test parser::annotations::tests::example_from_parts_whitespace_code ... ok
[INFO] [stdout] test parser::annotations::tests::id_allows_underscores ... ok
[INFO] [stdout] test parser::annotations::tests::id_allows_numbers ... ok
[INFO] [stdout] test parser::annotations::tests::id_rejects_empty_value ... ok
[INFO] [stdout] test parser::annotations::tests::id_rejects_special_characters ... ok
[INFO] [stdout] test parser::annotations::tests::parses_valid_id ... ok
[INFO] [stdout] test parser::annotations::tests::example_from_parts_method_chain ... ok
[INFO] [stdout] test parser::annotations::tests::parses_valid_security ... ok
[INFO] [stdout] test parser::annotations::tests::response_from_parts_invalid_status ... ok
[INFO] [stdout] test parser::annotations::tests::response_from_parts_unit_type ... ok
[INFO] [stdout] test parser::annotations::tests::id_rejects_spaces ... ok
[INFO] [stdout] test parser::annotations::tests::security_rejects_empty_value ... ok
[INFO] [stdout] test parser::annotations::tests::tag_rejects_empty_value ... ok
[INFO] [stdout] test parser::annotations::tests::tag_requires_value ... ok
[INFO] [stdout] test parser::error::tests::debug_format_works ... ok
[INFO] [stdout] test parser::error::tests::display_format_works ... ok
[INFO] [stdout] test parser::tokens::tests::detects_struct_pattern ... ok
[INFO] [stdout] test parser::annotations::tests::security_requires_value ... ok
[INFO] [stdout] test parser::tokens::tests::extract_state_handles_malformed_input ... ok
[INFO] [stdout] test parser::tokens::tests::extracts_doc_text_simple ... ok
[INFO] [stdout] test parser::tokens::tests::extract_state_handles_empty_type ... ok
[INFO] [stdout] test parser::annotations::tests::parses_valid_tag ... ok
[INFO] [stdout] test parser::annotations::tests::response_from_parts_empty_description ... ok
[INFO] [stdout] test parser::annotations::tests::id_requires_value ... ok
[INFO] [stdout] test parser::tokens::tests::extracts_from_full_function ... ok
[INFO] [stdout] test parser::error::tests::creates_error_without_span ... ok
[INFO] [stdout] test parser::tokens::tests::extracts_nested_state_type ... ok
[INFO] [stdout] test parser::annotations::tests::response_from_parts_whitespace_description ... ok
[INFO] [stdout] test parser::tokens::tests::extracts_multiline_doc_text ... ok
[INFO] [stdout] test parser::annotations::tests::response_from_parts_valid ... ok
[INFO] [stdout] test parser::annotations::tests::security_with_extra_spaces ... ok
[INFO] [stdout] test parser::tokens::tests::extracts_single_primitive_binding ... ok
[INFO] [stdout] test parser::annotations::tests::validates_status_code_range ... ok
[INFO] [stdout] test parser::annotations::tests::tag_with_extra_spaces ... ok
[INFO] [stdout] test parser::tokens::tests::extract_path_with_three_extractors ... ok
[INFO] [stdout] test parser::error::tests::creates_error_with_span ... ok
[INFO] [stdout] test parser::tokens::tests::find_path_pattern_finds_path_with_space ... ok
[INFO] [stdout] test parser::tokens::tests::find_path_pattern_returns_none_for_path_type_only ... ok
[INFO] [stdout] test parser::tokens::tests::handles_duplicate_bindings ... ok
[INFO] [stdout] test parser::tokens::tests::handles_empty_binding ... ok
[INFO] [stdout] test parser::tokens::tests::handles_complex_struct_destructure ... ok
[INFO] [stdout] test parser::tokens::tests::handles_empty_doc_text ... ok
[INFO] [stdout] test parser::tokens::tests::handles_multiple_path_extractors ... ok
[INFO] [stdout] test parser::tokens::tests::handles_empty_tuple_binding ... ok
[INFO] [stdout] test parser::tokens::tests::handles_multiple_path_extractors_multiline ... ok
[INFO] [stdout] test parser::tokens::tests::extracts_from_function_with_docs ... ok
[INFO] [stdout] test parser::tokens::tests::extracts_simple_state_type ... ok
[INFO] [stdout] test parser::tokens::tests::handles_path_followed_by_angle_brackets ... ok
[INFO] [stdout] test parser::tokens::tests::handles_path_with_state ... ok
[INFO] [stdout] test parser::tokens::tests::handles_path_type_without_binding ... ok
[INFO] [stdout] test parser::tokens::tests::returns_empty_string_when_only_one_quote ... ok
[INFO] [stdout] test parser::tokens::tests::returns_none_for_empty_tokens ... ok
[INFO] [stdout] test parser::tokens::tests::returns_none_for_non_path_tokens ... ok
[INFO] [stdout] test parser::tokens::tests::returns_none_when_no_state ... ok
[INFO] [stdout] test parser::tokens::tests::test_parse_rovo_function_returns_path_params ... ok
[INFO] [stdout] test parser::tokens::tests::handles_nested_generics_in_type ... ok
[INFO] [stdout] test parser::tokens::tests::handles_state_with_surrounding_params ... ok
[INFO] [stdout] test parser::tokens::tests::handles_path_with_spaces ... ok
[INFO] [stdout] test parser::tokens::tests::extract_path_with_no_type_annotation ... ok
[INFO] [stderr]    Doc-tests rovo_macros
[INFO] [stdout] test parser::tokens::tests::returns_empty_string_when_no_quotes ... ok
[INFO] [stdout] test parser::tokens::tests::extracts_doc_text_with_special_chars ... ok
[INFO] [stdout] test parser::tokens::tests::extracts_string_path_binding ... ok
[INFO] [stdout] test parser::tokens::tests::extracts_tuple_bindings ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 70 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test src/lib.rs - derive_json_schema (line 470) ... ignored
[INFO] [stdout] test src/lib.rs - rovo (line 164) ... ignored
[INFO] [stdout] test src/lib.rs - rovo (line 190) ... ignored
[INFO] [stdout] test src/lib.rs - rovo (line 209) ... ignored
[INFO] [stdout] test src/lib.rs - rovo (line 230) ... ignored
[INFO] [stdout] test src/lib.rs - rovo (line 258) ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 6 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "fda5f6b54fae7cc004957b298106e2755aa3ef5e43ba916dc4ec0a14311e8019", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fda5f6b54fae7cc004957b298106e2755aa3ef5e43ba916dc4ec0a14311e8019", kill_on_drop: false }`
[INFO] [stdout] fda5f6b54fae7cc004957b298106e2755aa3ef5e43ba916dc4ec0a14311e8019