[INFO] fetching crate scah 0.0.17...
[INFO] testing scah-0.0.17 against master#ec6f9a5b4413f74386267ef8efc93712c2ce6db6 for pr-155739-1
[INFO] extracting crate scah 0.0.17 into /workspace/builds/worker-2-tc1/source
[INFO] started tweaking crates.io crate scah 0.0.17
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate scah 0.0.17
[INFO] tweaked toml for crates.io crate scah 0.0.17 written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate scah 0.0.17 on toolchain ec6f9a5b4413f74386267ef8efc93712c2ce6db6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate scah 0.0.17 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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded scah-query-ir v0.0.17
[INFO] [stderr]   Downloaded scah-reader v0.0.17
[INFO] [stderr]   Downloaded scah-macros v0.0.17
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 268915299a9b2f9d8857845b600044b52aa546b340279cd06133b892a2084927
[INFO] running `Command { std: "docker" "start" "-a" "268915299a9b2f9d8857845b600044b52aa546b340279cd06133b892a2084927", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "268915299a9b2f9d8857845b600044b52aa546b340279cd06133b892a2084927", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "268915299a9b2f9d8857845b600044b52aa546b340279cd06133b892a2084927", kill_on_drop: false }`
[INFO] [stdout] 268915299a9b2f9d8857845b600044b52aa546b340279cd06133b892a2084927
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a116435cdf9c22c96ba4ba347a0e793b2d92e9020d4a780276589c1795ef918c
[INFO] running `Command { std: "docker" "start" "-a" "a116435cdf9c22c96ba4ba347a0e793b2d92e9020d4a780276589c1795ef918c", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.22
[INFO] [stderr]    Compiling scah-reader v0.0.17
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling scah-query-ir v0.0.17
[INFO] [stderr]    Compiling quote v1.0.45
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling scah-macros v0.0.17
[INFO] [stderr]    Compiling scah v0.0.17 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 5.96s
[INFO] running `Command { std: "docker" "inspect" "a116435cdf9c22c96ba4ba347a0e793b2d92e9020d4a780276589c1795ef918c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a116435cdf9c22c96ba4ba347a0e793b2d92e9020d4a780276589c1795ef918c", kill_on_drop: false }`
[INFO] [stdout] a116435cdf9c22c96ba4ba347a0e793b2d92e9020d4a780276589c1795ef918c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e8f0dceef0d5622fb647f11a23a0abbe87d3489d4bc080cd73d6e994ef12cde1
[INFO] running `Command { std: "docker" "start" "-a" "e8f0dceef0d5622fb647f11a23a0abbe87d3489d4bc080cd73d6e994ef12cde1", kill_on_drop: false }`
[INFO] [stderr]    Compiling diff v0.1.13
[INFO] [stderr]    Compiling yansi v1.0.1
[INFO] [stderr]    Compiling pretty_assertions v1.4.1
[INFO] [stderr]    Compiling scah v0.0.17 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 3.09s
[INFO] running `Command { std: "docker" "inspect" "e8f0dceef0d5622fb647f11a23a0abbe87d3489d4bc080cd73d6e994ef12cde1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e8f0dceef0d5622fb647f11a23a0abbe87d3489d4bc080cd73d6e994ef12cde1", kill_on_drop: false }`
[INFO] [stdout] e8f0dceef0d5622fb647f11a23a0abbe87d3489d4bc080cd73d6e994ef12cde1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 240d105b28727b064ca5c0c07795077eb3120c97144591ac6854a9c6349d9600
[INFO] running `Command { std: "docker" "start" "-a" "240d105b28727b064ca5c0c07795077eb3120c97144591ac6854a9c6349d9600", 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/scah-b711f98ca99d325e)
[INFO] [stdout] 
[INFO] [stdout] running 65 tests
[INFO] [stdout] test debug::tests::trace_store_formats_jsonl ... ok
[INFO] [stdout] test engine::executor::tests::test_complex_fsm_query ... ok
[INFO] [stdout] test engine::cursor::tests::test_fsm_next_descendant ... ok
[INFO] [stdout] test engine::executor::tests::test_fsm_next_descendant ... ok
[INFO] [stdout] test html::element::builder::tests::test_key_no_quote_and_escaped_space_value ... ignored, Known issue: Escapes are not handled
[INFO] [stdout] test engine::executor::tests::test_simple_open_close ... ok
[INFO] [stdout] test html::element::builder::tests::test_key_no_quote_and_no_value ... ok
[INFO] [stdout] test html::element::builder::tests::test_key_no_quote_and_value_with_quote ... ok
[INFO] [stdout] test html::element::builder::tests::test_long_key_and_value_with_spaces_and_real_same_quote_inside ... ignored, Known issue: Escapes are not handled
[INFO] [stdout] test html::element::builder::tests::test_key_with_quote_and_value_with_quote ... ok
[INFO] [stdout] test html::element::builder::tests::test_long_key_with_spaces ... ok
[INFO] [stdout] test html::element::builder::tests::test_long_key_with_spaces_and_real_same_quote_inside ... ignored, Known issue: Escapes are not handled
[INFO] [stdout] test html::element::builder::tests::test_long_key_with_spaces_and_different_quote_inside ... ok
[INFO] [stdout] test debug::tests::trace_store_writes_jsonl_file ... ok
[INFO] [stdout] test html::element::builder::tests::test_valid_anchor_tag_attributes ... ok
[INFO] [stdout] test html::element::builder::tests::test_xhtml_tag_close_weird_formatting ... ok
[INFO] [stdout] test html::element::builder::tests::test_xhtml_tag_close ... ok
[INFO] [stdout] test html::element::builder::tests::test_xhtml_tag_open ... ok
[INFO] [stdout] test html::element::tokenizer::tests::basic_attribute_iterator ... ok
[INFO] [stdout] test html::open_elements::tests::test_misnested_close_bubbles_to_match ... ok
[INFO] [stdout] test html::open_elements::tests::test_opening_button_closes_previous_button ... ok
[INFO] [stdout] test html::open_elements::tests::test_opening_li_closes_previous_li ... ok
[INFO] [stdout] test html::open_elements::tests::test_opening_optgroup_closes_option_then_optgroup ... ok
[INFO] [stdout] test html::open_elements::tests::test_select_scope_ignores_non_select_end_tags ... ok
[INFO] [stdout] test html::open_elements::tests::test_stray_close_is_ignored ... ok
[INFO] [stdout] test html::parser::tests::test_basic_html ... ok
[INFO] [stdout] test html::parser::tests::test_eof_drain_finalizes_open_elements ... ok
[INFO] [stdout] test html::parser::tests::test_descendant_and_child_queries_remain_stable_on_malformed_html ... ok
[INFO] [stdout] test html::parser::tests::test_first_anchor_in_list_selection ... ok
[INFO] [stdout] test html::parser::tests::test_dt_dd_auto_close_sequence ... ok
[INFO] [stdout] test html::element::builder::tests::test_multiple_key_value_pairs ... ok
[INFO] [stdout] test html::element::builder::tests::test_parsing_comment ... ok
[INFO] [stdout] test html::element::builder::tests::test_parsing_mutiline_comment ... ok
[INFO] [stdout] test html::parser::tests::test_li_auto_close_on_next_li ... ok
[INFO] [stdout] test html::parser::tests::test_first_anchor_tag_from_bench ... ok
[INFO] [stdout] test html::parser::tests::test_misnested_close_finalizes_bubbled_elements ... ok
[INFO] [stdout] test html::parser::tests::test_multi_selection ... ignored, Known issue: Duplication of elements is not handled
[INFO] [stdout] test html::parser::tests::test_implicit_p_close_finalizes_content ... ok
[INFO] [stdout] test html::parser::tests::test_multiple_queries_attach_to_same_open_element ... ok
[INFO] [stdout] test html::parser::tests::test_optgroup_closes_previous_option_and_optgroup ... ok
[INFO] [stdout] test html::parser::tests::test_option_auto_close_on_next_option ... ok
[INFO] [stdout] test html::parser::tests::test_python_test_html ... ok
[INFO] [stdout] test html::parser::tests::test_script_tag_with_html_like_content ... ok
[INFO] [stdout] test html::element::builder::tests::test_complex_open_tag ... ok
[INFO] [stdout] test html::open_elements::tests::test_opening_td_closes_previous_cell ... ok
[INFO] [stdout] test html::parser::tests::test_anchor_list_selection ... ok
[INFO] [stdout] test html::parser::tests::test_self_closing_tags_with_content_query ... ok
[INFO] [stdout] test html::parser::tests::test_product_listing_html ... ok
[INFO] [stdout] test html::parser::tests::test_self_closing_tags ... ok
[INFO] [stdout] test html::parser::tests::test_single_product_listing_html ... ok
[INFO] [stdout] test engine::executor::tests::test_scoped_fsm_pruning_removes_interleaved_expired_cursors ... ok
[INFO] [stdout] test html::parser::tests::test_td_auto_close_on_next_td ... ok
[INFO] [stdout] test html::parser::tests::test_text_before_first_tag_does_not_break_text_content ... ok
[INFO] [stdout] test html::parser::tests::test_text_content ... ok
[INFO] [stdout] test store::tests::test_find_next_query ... ok
[INFO] [stdout] test store::tests::test_branching_next_query ... ok
[INFO] [stdout] test html::parser::tests::test_top_level_multi_selection ... ok
[INFO] [stdout] test store::text_content::tests::test_textcontent ... ok
[INFO] [stdout] test store::tests::test_push_multi_section ... ok
[INFO] [stdout] test store::tests::test_multi_root_queries ... ok
[INFO] [stdout] test store::tests::test_link_query_to_element ... ok
[INFO] [stdout] test html::parser::tests::test_stray_close_tag_is_ignored ... ok
[INFO] [stdout] test html::open_elements::tests::test_opening_option_closes_previous_option ... ok
[INFO] [stdout] test html::element::builder::tests::test_key_no_quote_and_value_no_quote ... ok
[INFO] [stdout] test html::element::builder::tests::test_key_with_quote_and_no_value ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 61 passed; 0 failed; 4 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/debugging_test.rs (/opt/rustwide/target/debug/deps/debugging_test-068a7f03781a966b)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test first_context_waits_for_required_child_before_early_exit ... ok
[INFO] [stdout] test first_selection_as_root_early_exit ... ok
[INFO] [stdout] test html_scope_problem_intro_example ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/html_soup_test.rs (/opt/rustwide/target/debug/deps/html_soup_test-77e4b2f810dfa75c)
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test html_soup::eof_recovery_test::consecutive_unclosed_p_tags_split_before_eof ... ok
[INFO] [stdout] test html_soup::eof_recovery_test::leaf_element_finalizes_at_eof ... ok
[INFO] [stdout] test html_soup::eof_recovery_test::multiple_nested_unclosed_elements_finalize_in_order ... ok
[INFO] [stdout] test html_soup::misnesting_test::closing_ancestor_before_descendant_bubbles_recovery_without_duplicate_matches ... ok
[INFO] [stdout] test html_soup::implied_close_test::implied_p_close_splits_content_correctly ... ok
[INFO] [stdout] test html_soup::implied_close_test::implied_dt_dd_close_creates_expected_pairs ... ok
[INFO] [stdout] test html_soup::misnesting_test::stray_end_tag_is_ignored_for_selection_but_preserved_in_inner_html ... ok
[INFO] [stdout] test html_soup::selector_stability_test::descendant_and_child_selectors_survive_implied_close ... ok
[INFO] [stdout] test html_soup::selector_stability_test::misnest_recovery_does_not_duplicate_nested_matches ... ok
[INFO] [stdout] test html_soup::selector_stability_test::first_selector_returns_first_recovered_match_only ... ok
[INFO] [stdout] test html_soup::misnesting_test::extra_end_tag_after_valid_close_does_not_create_extra_matches ... ok
[INFO] [stdout] test html_soup::void_rawtext_test::void_syntax_and_plain_void_behavior_match ... ok
[INFO] [stdout] test html_soup::void_rawtext_test::script_contents_do_not_emit_false_selector_matches ... ok
[INFO] [stdout] test html_soup::void_rawtext_test::void_elements_do_not_capture_following_text ... ok
[INFO] [stdout] test html_soup::implied_close_test::implied_li_close_creates_distinct_siblings ... ok
[INFO] [stdout] test html_soup::implied_close_test::implied_option_close_splits_options ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_test.rs (/opt/rustwide/target/debug/deps/integration_test-e6152c19f2d3d003)
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test test_html_page_all_anchor_tag_starting_with_link_selection ... ok
[INFO] [stdout] test test_html_page ... ok
[INFO] [stdout] test test_html_page_first_anchor_tag_selection ... ok
[INFO] [stdout] test test_html_page_children_valid_anchor_tags_in_main ... ok
[INFO] [stdout] test test_html_multi_selection ... ok
[INFO] [stdout] test test_html_page_all_anchor_tag_selection ... ok
[INFO] [stdout] test test_html_page_single_main ... ok
[INFO] [stdout] test test_macro_static_query ... ok
[INFO] [stdout] test trace_records_first_query_early_exit ... ok
[INFO] [stdout] test trace_records_implied_li_close ... ok
[INFO] [stdout] test trace_records_open_and_save_events ... ok
[INFO] [stdout] test trace_records_transition_rejections ... ok
[INFO] [stdout] test test_macro_query_matches_runtime_query_structure ... ok
[INFO] [stdout] test test_macro_query_matches_runtime_store_contents ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/real_html_test.rs (/opt/rustwide/target/debug/deps/real_html_test-3cbf3e2c4963737f)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_all_anchor_tags_for_albert_einstein_wikipedia ... ignored, Real files
[INFO] [stdout] test test_all_anchor_tags_for_whatwg_html_spec ... ignored, Real files
[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] [stderr]    Doc-tests scah
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test src/lib.rs - parse (line 146) ... ok
[INFO] [stdout] test src/store/element.rs - store::element::Element<'html>::attribute (line 96) ... ok
[INFO] [stdout] test src/lib.rs - (line 55) ... ok
[INFO] [stdout] test src/store/mod.rs - store::Store (line 30) ... ok
[INFO] [stdout] test src/lib.rs - (line 21) ... ok
[INFO] [stdout] test src/html/element/builder.rs - html::element::builder::XHtmlElement (line 12) ... ok
[INFO] [stdout] test src/store/mod.rs - store::Store<'html,'query>::get (line 107) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.78s; merged doctests compilation took 0.77s
[INFO] running `Command { std: "docker" "inspect" "240d105b28727b064ca5c0c07795077eb3120c97144591ac6854a9c6349d9600", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "240d105b28727b064ca5c0c07795077eb3120c97144591ac6854a9c6349d9600", kill_on_drop: false }`
[INFO] [stdout] 240d105b28727b064ca5c0c07795077eb3120c97144591ac6854a9c6349d9600
