[INFO] fetching crate substrait-explain 0.3.1...
[INFO] testing substrait-explain-0.3.1 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-2
[INFO] extracting crate substrait-explain 0.3.1 into /workspace/builds/worker-7-tc2/source
[INFO] started tweaking crates.io crate substrait-explain 0.3.1
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate substrait-explain 0.3.1
[INFO] tweaked toml for crates.io crate substrait-explain 0.3.1 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate substrait-explain 0.3.1 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 substrait-explain 0.3.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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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] 396145cd76f0a41649a7a116c618e4365497435ddc8a33ef4e95eb534e2de20f
[INFO] running `Command { std: "docker" "start" "-a" "396145cd76f0a41649a7a116c618e4365497435ddc8a33ef4e95eb534e2de20f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "396145cd76f0a41649a7a116c618e4365497435ddc8a33ef4e95eb534e2de20f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "396145cd76f0a41649a7a116c618e4365497435ddc8a33ef4e95eb534e2de20f", kill_on_drop: false }`
[INFO] [stdout] 396145cd76f0a41649a7a116c618e4365497435ddc8a33ef4e95eb534e2de20f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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] ebd68128cfbd7609fc482178a0c35fc41185841c3f03f34c300b40f55036d163
[INFO] running `Command { std: "docker" "start" "-a" "ebd68128cfbd7609fc482178a0c35fc41185841c3f03f34c300b40f55036d163", kill_on_drop: false }`
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling libc v0.2.180
[INFO] [stderr]    Compiling bitflags v2.10.0
[INFO] [stderr]    Compiling foldhash v0.1.5
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling indexmap v2.13.0
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling semver v1.0.27
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling schemars v0.8.22
[INFO] [stderr]    Compiling beef v0.5.2
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling dyn-clone v1.0.20
[INFO] [stderr]    Compiling regress v0.10.5
[INFO] [stderr]    Compiling ryu v1.0.22
[INFO] [stderr]    Compiling pest v2.8.5
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling hashbrown v0.15.5
[INFO] [stderr]    Compiling ordered-float v2.10.1
[INFO] [stderr]    Compiling clap_lex v0.7.7
[INFO] [stderr]    Compiling rustc_version v0.4.1
[INFO] [stderr]    Compiling itertools v0.14.0
[INFO] [stderr]    Compiling clap_builder v4.5.56
[INFO] [stderr]    Compiling logos-codegen v0.15.1
[INFO] [stderr]    Compiling petgraph v0.8.3
[INFO] [stderr]    Compiling pest_meta v2.8.5
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling regex v1.12.2
[INFO] [stderr]    Compiling tempfile v3.24.0
[INFO] [stderr]    Compiling prettyplease v0.2.37
[INFO] [stderr]    Compiling serde_derive_internals v0.29.1
[INFO] [stderr]    Compiling pest_generator v2.8.5
[INFO] [stderr]    Compiling prost-derive v0.14.3
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling miette-derive v7.6.0
[INFO] [stderr]    Compiling clap_derive v4.5.55
[INFO] [stderr]    Compiling schemars_derive v0.8.22
[INFO] [stderr]    Compiling pest_derive v2.8.5
[INFO] [stderr]    Compiling logos-derive v0.15.1
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling miette v7.6.0
[INFO] [stderr]    Compiling logos v0.15.1
[INFO] [stderr]    Compiling prost v0.14.3
[INFO] [stderr]    Compiling prost-types v0.14.3
[INFO] [stderr]    Compiling clap v4.5.56
[INFO] [stderr]    Compiling prost-build v0.14.3
[INFO] [stderr]    Compiling pbjson-build v0.8.0
[INFO] [stderr]    Compiling prost-reflect v0.16.3
[INFO] [stderr]    Compiling protox-parse v0.9.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling serde_tokenstream v0.2.2
[INFO] [stderr]    Compiling serde_yaml v0.9.34+deprecated
[INFO] [stderr]    Compiling pbjson v0.8.0
[INFO] [stderr]    Compiling serde-value v0.7.0
[INFO] [stderr]    Compiling pbjson-types v0.8.0
[INFO] [stderr]    Compiling typify-impl v0.5.0
[INFO] [stderr]    Compiling protox v0.9.1
[INFO] [stderr]    Compiling substrait-explain v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling typify-macro v0.5.0
[INFO] [stderr]    Compiling typify v0.5.0
[INFO] [stderr]    Compiling substrait v0.62.2
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 08s
[INFO] running `Command { std: "docker" "inspect" "ebd68128cfbd7609fc482178a0c35fc41185841c3f03f34c300b40f55036d163", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ebd68128cfbd7609fc482178a0c35fc41185841c3f03f34c300b40f55036d163", kill_on_drop: false }`
[INFO] [stdout] ebd68128cfbd7609fc482178a0c35fc41185841c3f03f34c300b40f55036d163
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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] dc0f32921fa58828e71038ef0a3e68f3c086fac0686f576496be516e77ef0b57
[INFO] running `Command { std: "docker" "start" "-a" "dc0f32921fa58828e71038ef0a3e68f3c086fac0686f576496be516e77ef0b57", kill_on_drop: false }`
[INFO] [stderr]    Compiling substrait-explain v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 17.99s
[INFO] running `Command { std: "docker" "inspect" "dc0f32921fa58828e71038ef0a3e68f3c086fac0686f576496be516e77ef0b57", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dc0f32921fa58828e71038ef0a3e68f3c086fac0686f576496be516e77ef0b57", kill_on_drop: false }`
[INFO] [stdout] dc0f32921fa58828e71038ef0a3e68f3c086fac0686f576496be516e77ef0b57
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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] 397170fd0973dc5bb9984025ddc24383ce2513587c1bc990f67504294a534f95
[INFO] running `Command { std: "docker" "start" "-a" "397170fd0973dc5bb9984025ddc24383ce2513587c1bc990f67504294a534f95", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.22s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/substrait_explain-08d8c7c19572ad3e)
[INFO] [stdout] 
[INFO] [stdout] running 176 tests
[INFO] [stdout] test cli::tests::test_auto_detect_from_extension ... ok
[INFO] [stdout] test cli::tests::test_auto_detection_error_unknown_input_extension ... ok
[INFO] [stdout] test cli::tests::test_convert_text_to_json ... ok
[INFO] [stdout] test cli::tests::test_auto_detection_error_unknown_output_extension ... ok
[INFO] [stdout] test cli::tests::test_convert_with_auto_detection ... ok
[INFO] [stdout] test cli::tests::test_protobuf_roundtrip ... ok
[INFO] [stdout] test extensions::args::tests::extension_multi_allows_zero_children ... ok
[INFO] [stdout] test extensions::examples::tests::from_args_rejects_non_enum_positional ... ok
[INFO] [stdout] test cli::tests::test_convert_with_formatting_options ... ok
[INFO] [stdout] test cli::tests::test_validate_command ... ok
[INFO] [stdout] test extensions::args::tests::extension_single_rejects_wrong_child_counts ... ok
[INFO] [stdout] test extensions::args::tests::extension_multi_allows_single_child ... ok
[INFO] [stdout] test extensions::examples::tests::from_args_round_trip ... ok
[INFO] [stdout] test cli::tests::test_convert_text_to_text ... ok
[INFO] [stdout] test extensions::examples::tests::from_args_rejects_unknown_strategy ... ok
[INFO] [stdout] test cli::tests::test_explicit_format_overrides_auto_detection ... ok
[INFO] [stdout] test extensions::examples::tests::round_trip_via_any ... ok
[INFO] [stdout] test extensions::examples::tests::registry_roundtrip ... ok
[INFO] [stdout] test cli::tests::test_write_plan_reports_formatting_issues ... ok
[INFO] [stdout] test extensions::examples::tests::from_args_empty_strategies_roundtrip ... ok
[INFO] [stdout] test extensions::examples::tests::from_args_rejects_extra_named_args ... ok
[INFO] [stdout] test extensions::examples::tests::to_args_omits_zero_count ... ok
[INFO] [stdout] test extensions::registry::tests::test_conflicting_type_url_leaves_registry_unchanged ... ok
[INFO] [stdout] test extensions::registry::tests::test_enhancement_duplicate_registration_returns_error ... ok
[INFO] [stdout] test extensions::registry::tests::test_extension_args ... ok
[INFO] [stdout] test extensions::args::tests::extension_multi_allows_multiple_children ... ok
[INFO] [stdout] test extensions::registry::tests::test_enhancement_not_found_error ... ok
[INFO] [stdout] test extensions::examples::tests::to_args_produces_enum_and_named ... ok
[INFO] [stdout] test cli::tests::test_convert_with_protobuf_output ... ok
[INFO] [stdout] test extensions::simple::tests::test_compound_name_roundtrip_in_extensions_section ... ok
[INFO] [stdout] test extensions::simple::tests::test_compound_name_trailing_colon ... ok
[INFO] [stdout] test extensions::simple::tests::test_compound_name_with_signature ... ok
[INFO] [stdout] test extensions::simple::tests::test_find_by_name ... ok
[INFO] [stdout] test extensions::simple::tests::test_from_extensions_basic ... ok
[INFO] [stdout] test extensions::registry::tests::test_namespace_separation ... ok
[INFO] [stdout] test extensions::simple::tests::test_display_extension_lookup_empty ... ok
[INFO] [stdout] test extensions::simple::tests::test_from_extensions_duplicates ... ok
[INFO] [stdout] test extensions::simple::tests::test_display_extension_lookup_with_content ... ok
[INFO] [stdout] test extensions::simple::tests::test_lookup_function_different_base_names_each_unique ... ok
[INFO] [stdout] test extensions::simple::tests::test_extension_lookup_empty ... ok
[INFO] [stdout] test extensions::simple::tests::test_extensions_output ... ok
[INFO] [stdout] test extensions::simple::tests::test_from_extensions_invalid_mapping_type ... ok
[INFO] [stdout] test extensions::registry::tests::test_extension_error_cases ... ok
[INFO] [stdout] test extensions::registry::tests::test_extension_registry_basic ... ok
[INFO] [stdout] test extensions::simple::tests::test_compound_name_plain ... ok
[INFO] [stdout] test extensions::simple::tests::test_lookup_function_plain_name_overloaded_across_urns ... ok
[INFO] [stdout] test cli::tests::test_validate_with_extensions ... ok
[INFO] [stdout] test extensions::simple::tests::test_lookup_function_uniqueness_flags ... ok
[INFO] [stdout] test extensions::simple::tests::test_resolve_function_not_found ... ok
[INFO] [stdout] test extensions::simple::tests::test_resolve_function_plain_stored_name ... ok
[INFO] [stdout] test extensions::simple::tests::test_resolve_function_with_anchor ... ok
[INFO] [stdout] test parser::expressions::tests::test_compound_name_stops_at_opening_paren ... ok
[INFO] [stdout] test parser::expressions::tests::test_if_then_preserves_clause_order ... ok
[INFO] [stdout] test parser::expressions::tests::test_compound_name_with_signature ... ok
[INFO] [stdout] test parser::expressions::tests::test_if_clause_structure ... ok
[INFO] [stdout] test parser::expressions::tests::test_compound_name_plain ... ok
[INFO] [stdout] test extensions::simple::tests::test_lookup_function_missing_anchor ... ok
[INFO] [stdout] test extensions::simple::tests::test_resolve_function_without_anchor ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_boolean_false_literal ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_boolean_true_literal ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_cast_expression_basic ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_cast_expression_nested ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_cast_expression_with_boolean ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_cast_expression_with_whitespace ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_cast_expression_via_expression_rule ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_cast_return_null_failure_behavior ... ok
[INFO] [stdout] test parser::expressions::tests::test_if_then_structure ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_cast_throw_exception_failure_behavior ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_cast_unspecified_failure_behavior ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_date_literal ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_float_literal ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_if_then_with_date_literals ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_float_literal_with_fp32_type ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_integer_literal ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_negative_float_literal ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_nullable_boolean_literal ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_if_then_with_time_literals ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_if_then ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_nullable_integer_literal ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_time_literal ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_if_then_mixed_types_in_conditions ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_field_reference ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_if_then_single_clause ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_if_then_with_timestamp_literals ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_if_then_with_typed_literals ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_if_clause_with_whitespace_variations ... ok
[INFO] [stdout] test parser::expressions::tests::test_scalar_function_compound_name_with_anchor ... ok
[INFO] [stdout] test parser::extensions::tests::test_parse_simple_extension_declaration_compound_name ... ok
[INFO] [stdout] test parser::expressions::tests::test_scalar_function_second_overload ... ok
[INFO] [stdout] test parser::extensions::tests::test_extensions_round_trip_plan_with_compound_names ... ok
[INFO] [stdout] test parser::expressions::tests::test_scalar_function_wrong_name_for_anchor_fails ... ok
[INFO] [stdout] test parser::expressions::tests::test_scalar_function_full_compound_name ... ok
[INFO] [stdout] test parser::extensions::tests::test_parse_urn_extension_declaration ... ok
[INFO] [stdout] test parser::extensions::tests::test_parse_urn_extension_declaration_str ... ok
[INFO] [stdout] test parser::relations::tests::test_fetch_relation_negative_offset_rejected ... ok
[INFO] [stdout] test parser::relations::tests::test_fetch_relation_negative_limit_rejected ... ok
[INFO] [stdout] test parser::relations::tests::test_fetch_relation_positive_values ... ok
[INFO] [stdout] test parser::expressions::tests::test_scalar_function_base_name_ambiguous_fails ... ok
[INFO] [stdout] test parser::relations::tests::test_parse_aggregate_relation_global_aggregate ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_nullable_float_literal ... ok
[INFO] [stdout] test parser::expressions::tests::test_scalar_function_base_name_unique_overload ... ok
[INFO] [stdout] test parser::relations::tests::test_parse_aggregate_relation_simple ... ok
[INFO] [stdout] test parser::relations::tests::test_parse_aggregate_relation_maintain_column_order ... ok
[INFO] [stdout] test parser::relations::tests::test_parse_aggregate_relation_grouping_sets ... ok
[INFO] [stdout] test parser::relations::tests::test_parse_filter_relation ... ok
[INFO] [stdout] test parser::extensions::tests::test_parse_simple_extension_declaration ... ok
[INFO] [stdout] test parser::extensions::tests::test_parse_simple_extension_declaration_compound_name_multi_segment ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_timestamp_literal_with_space ... ok
[INFO] [stdout] test parser::relations::tests::test_parse_join_relation_requires_two_children ... ok
[INFO] [stdout] test parser::expressions::tests::test_parse_timestamp_literal_with_t ... ok
[INFO] [stdout] test parser::expressions::tests::test_scalar_function_base_name_with_anchor ... ok
[INFO] [stdout] test parser::relations::tests::test_parse_aggregate_relation ... ok
[INFO] [stdout] test parser::extensions::tests::test_extensions_round_trip_plan ... ok
[INFO] [stdout] test parser::relations::tests::test_parse_join_relation ... ok
[INFO] [stdout] test parser::relations::tests::test_parse_join_relation_left_outer ... ok
[INFO] [stdout] test parser::structural::tests::test_parse_full_plan ... ok
[INFO] [stdout] test parser::relations::tests::test_parse_project_relation ... ok
[INFO] [stdout] test parser::relations::tests::test_parse_project_relation_complex ... ok
[INFO] [stdout] test parser::relations::tests::test_parse_relation ... ok
[INFO] [stdout] test parser::structural::tests::test_parse_basic_block ... ok
[INFO] [stdout] test parser::structural::tests::test_parse_complete_extension_block ... ok
[INFO] [stdout] test parser::relations::tests::test_parse_join_relation_left_semi ... ok
[INFO] [stdout] test parser::relations::tests::test_parse_read_relation ... ok
[INFO] [stdout] test parser::types::tests::test_parse_simple_type ... ok
[INFO] [stdout] test parser::types::tests::test_parse_type ... ok
[INFO] [stdout] test parser::types::tests::test_udts ... ok
[INFO] [stdout] test parser::structural::tests::test_parse_root_relation ... ok
[INFO] [stdout] test textify::expressions::tests::test_cast_textify ... ok
[INFO] [stdout] test textify::expressions::tests::test_cast_textify_missing_input ... ok
[INFO] [stdout] test textify::expressions::tests::test_cast_textify_nested ... ok
[INFO] [stdout] test textify::expressions::tests::test_cast_textify_via_rextype ... ok
[INFO] [stdout] test textify::expressions::tests::test_expression_textify ... ok
[INFO] [stdout] test parser::structural::tests::test_parse_root_relation_no_names ... ok
[INFO] [stdout] test textify::expressions::tests::test_ifthen_textify ... ok
[INFO] [stdout] test parser::types::tests::test_parse_list_type ... ok
[INFO] [stdout] test parser::types::tests::test_parse_parameters ... ok
[INFO] [stdout] test textify::expressions::tests::test_cast_textify_missing_type ... ok
[INFO] [stdout] test parser::structural::tests::test_parse_relation_tree ... ok
[INFO] [stdout] test textify::expressions::tests::test_cast_textify_throw_exception ... ok
[INFO] [stdout] test textify::expressions::tests::test_cast_textify_invalid_failure_behavior ... ok
[INFO] [stdout] test textify::expressions::tests::test_cast_textify_return_null ... ok
[INFO] [stdout] test textify::expressions::tests::test_literal_textify ... ok
[INFO] [stdout] test textify::expressions::tests::test_rextype_textify ... ok
[INFO] [stdout] test textify::plan::tests::test_plan_writer ... ok
[INFO] [stdout] test textify::expressions::tests::test_nullable_integer_literal_textify ... ok
[INFO] [stdout] test textify::rels::tests::test_arguments_textify_positional_only ... ok
[INFO] [stdout] test textify::expressions::tests::test_nullable_boolean_literal_textify ... ok
[INFO] [stdout] test textify::rels::tests::test_arguments_textify_both ... ok
[INFO] [stdout] test textify::rels::tests::test_join_type_enum_textify ... ok
[INFO] [stdout] test textify::rels::tests::test_multiple_groupings_on_aggregate ... ok
[INFO] [stdout] test textify::rels::tests::test_arguments_textify_empty ... ok
[INFO] [stdout] test textify::rels::tests::test_filter_rel ... ok
[INFO] [stdout] test textify::rels::tests::test_aggregate_function_textify ... ok
[INFO] [stdout] test textify::expressions::tests::test_nullable_float_literal_textify ... ok
[INFO] [stdout] test textify::rels::tests::test_named_arg_textify_error_token ... ok
[INFO] [stdout] test textify::types::tests::named_anchor_compact_overloaded_shows_signature ... ok
[INFO] [stdout] test textify::rels::tests::test_arguments_textify_named_only ... ok
[INFO] [stdout] test textify::rels::tests::test_read_rel ... ok
[INFO] [stdout] test textify::rels::tests::test_multiple_groupings_with_measure_deprecated ... ok
[INFO] [stdout] test textify::rels::tests::test_join_output_columns ... ok
[INFO] [stdout] test textify::rels::tests::test_aggregate_relation_textify ... ok
[INFO] [stdout] test textify::types::tests::named_anchor_verbose_unique_base_name_shows_signature_and_anchor ... ok
[INFO] [stdout] test textify::types::tests::named_anchor_compact_same_compound_name_two_urns_shows_anchor ... ok
[INFO] [stdout] test textify::types::tests::named_anchor_verbose_overloaded_shows_signature_and_anchor ... ok
[INFO] [stdout] test textify::types::tests::struct_display ... ok
[INFO] [stdout] test textify::types::tests::names_display ... ok
[INFO] [stdout] test textify::types::tests::type_display ... ok
[INFO] [stdout] test textify::rels::tests::test_unsupported_rel_type_produces_failure_token ... ok
[INFO] [stdout] test textify::types::tests::named_anchor_compact_plain_name_unique_no_signature_no_anchor ... ok
[INFO] [stdout] test textify::rels::tests::test_join_relation_unknown_type ... ok
[INFO] [stdout] test textify::types::tests::named_anchor_compact_unique_base_name_no_signature ... ok
[INFO] [stdout] test textify::rels::tests::test_multiple_groupings_on_aggregate_deprecated ... ok
[INFO] [stdout] test textify::types::tests::named_anchor_compact_plain_name_non_unique_shows_anchor ... ok
[INFO] [stdout] test textify::types::tests::type_display_with_errors ... ok
[INFO] [stdout] test textify::expressions::tests::test_ifthen_textify_missing_else ... ok
[INFO] [stdout] test cli::tests::test_convert_json_to_text ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 176 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.12s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/substrait_explain-b342dafc65f225db)
[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/adv_extension_roundtrip.rs (/opt/rustwide/target/debug/deps/adv_extension_roundtrip-4f6a8a60386cdbd4)
[INFO] [stdout] 
[INFO] [stdout] running 31 tests
[INFO] [stdout] test test_adv_extension_as_standalone_root_fails_with_error ... ok
[INFO] [stdout] test test_adv_ext_output_columns_produces_failure_token ... ok
[INFO] [stdout] test test_adv_extension_as_roots_only_child_fails_with_error ... ok
[INFO] [stdout] test test_enhancement_and_optimization_on_same_relation ... ok
[INFO] [stdout] test test_enhancement_and_optimization_on_nested_relation_roundtrip ... ok
[INFO] [stdout] test test_enhancement_on_aggregate_roundtrip ... ok
[INFO] [stdout] test test_enhancement_attaches_to_filter_not_read ... ok
[INFO] [stdout] test test_enhancement_on_filter_roundtrip ... ok
[INFO] [stdout] test test_enhancement_on_fetch_roundtrip ... ok
[INFO] [stdout] test test_enhancement_depth_three_nesting_roundtrip ... ok
[INFO] [stdout] test test_enhancement_on_nested_filter_roundtrip ... ok
[INFO] [stdout] test test_enhancement_on_nested_read_roundtrip ... ok
[INFO] [stdout] test test_enhancement_with_child_relation ... ok
[INFO] [stdout] test test_partition_hint_all_strategies ... ok
[INFO] [stdout] test test_enhancement_on_project_roundtrip ... ok
[INFO] [stdout] test test_multiple_enhancements_fails_to_parse ... ok
[INFO] [stdout] test test_project_over_extension_leaf_emit_mapping ... ok
[INFO] [stdout] test test_unknown_enhancement_url_textify_is_lenient ... ok
[INFO] [stdout] test test_multiple_optimizations_on_nested_read_roundtrip ... ok
[INFO] [stdout] test test_enhancement_on_join_roundtrip ... ok
[INFO] [stdout] test test_partition_hint_empty ... ok
[INFO] [stdout] test test_partition_hint_with_count ... ok
[INFO] [stdout] test test_partition_hint_roundtrip ... ok
[INFO] [stdout] test test_unregistered_enhancement_fails_to_parse ... ok
[INFO] [stdout] test test_unregistered_enhancement_produces_failure_token_at_textify_time ... ok
[INFO] [stdout] test test_partition_strategy_str_names_roundtrip ... ok
[INFO] [stdout] test test_wrong_argument_type_for_enhancement_fails ... ok
[INFO] [stdout] test test_unregistered_optimization_fails_to_parse ... ok
[INFO] [stdout] test test_multiple_optimizations_roundtrip ... ok
[INFO] [stdout] test test_optimization_on_nested_read_roundtrip ... ok
[INFO] [stderr]      Running tests/extension_roundtrip.rs (/opt/rustwide/target/debug/deps/extension_roundtrip-22718d744c836f84)
[INFO] [stdout] test test_enhancement_on_sort_roundtrip ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test test_extension_without_registry ... ok
[INFO] [stdout] test test_extension_unknown_arguments ... ok
[INFO] [stdout] test test_extension_string_escaping_roundtrip ... ok
[INFO] [stdout] test test_extension_leaf_unknown_type_url_textify_is_lenient ... ok
[INFO] [stdout] test test_enhancement_on_read_under_extension_single ... ok
[INFO] [stdout] test test_extension_multi_roundtrip ... ok
[INFO] [stdout] test test_extension_single_over_read_roundtrip ... ok
[INFO] [stdout] test test_multiple_extensions_in_plan ... ok
[INFO] [stdout] test test_extension_leaf_roundtrip ... ok
[INFO] [stdout] test test_extension_literal_roundtrip ... ok
[INFO] [stderr]      Running tests/json_parsing.rs (/opt/rustwide/target/debug/deps/json_parsing-e2f4f468698aee58)
[INFO] [stdout] test test_extension_empty_args_roundtrip ... 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] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test test_text_path ... ok
[INFO] [stdout] test test_gojson_parsing ... ok
[INFO] [stdout] test test_cli_parses_standard_plan_json ... ok
[INFO] [stdout] test test_cli_parses_rustjson ... ok
[INFO] [stdout] test test_failed_parse_without_schema_on_gojson ... ok
[INFO] [stdout] test test_protojson_fixture_matches_text_plan ... ok
[INFO] [stdout] test test_parse_rustjson ... ok
[INFO] [stdout] test test_cli_parses_gojson ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.24s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/literal_roundtrip.rs (/opt/rustwide/target/debug/deps/literal_roundtrip-866df97b38035932)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test test_boolean_literal_roundtrip ... ok
[INFO] [stdout] test test_float_literal_roundtrip ... ok
[INFO] [stdout] test test_negative_literals_roundtrip ... ok
[INFO] [stdout] test test_date_literal_roundtrip ... ok
[INFO] [stdout] test test_mixed_literal_roundtrip ... ok
[INFO] [stdout] test test_nullable_boolean_literal_roundtrip ... ok
[INFO] [stdout] test test_nullable_float_literal_roundtrip ... ok
[INFO] [stdout] test test_time_literal_roundtrip ... ok
[INFO] [stdout] test test_nullable_integer_literal_roundtrip ... ok
[INFO] [stdout] test test_if_then_expression_roundtrip ... ok
[INFO] [stdout] test test_timestamp_literal_roundtrip ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running tests/plan_roundtrip.rs (/opt/rustwide/target/debug/deps/plan_roundtrip-00435130701bef1a)
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 21 tests
[INFO] [stdout] test test_malformed_input_error_handling ... ok
[INFO] [stdout] test test_aggregate_multiple_grouping_sets_roundtrip ... ok
[INFO] [stdout] test test_join_relation_roundtrip ... ok
[INFO] [stdout] test test_global_aggregate_relation_roundtrip ... ok
[INFO] [stdout] test test_multiple_relations_roundtrip ... ok
[INFO] [stdout] test test_join_relation_right_mark_roundtrip ... ok
[INFO] [stdout] test test_complex_plan_roundtrip ... ok
[INFO] [stdout] test test_overloaded_functions_verbose_shows_signature_and_anchor ... ok
[INFO] [stdout] test test_plan_with_fetch_and_sort_roundtrip ... ok
[INFO] [stdout] test test_plan_with_extensions_roundtrip ... ok
[INFO] [stdout] test test_mixed_unique_and_overloaded_functions ... ok
[INFO] [stdout] test test_same_compound_name_two_urns_requires_anchor ... ok
[INFO] [stdout] test test_plan_with_extension_leaf_roundtrip ... ok
[INFO] [stdout] test test_simple_plan_roundtrip ... ok
[INFO] [stdout] test test_sort_relation_roundtrip ... ok
[INFO] [stdout] test test_unregistered_extension_error ... ok
[INFO] [stdout] test test_unique_function_compact_omits_signature ... ok
[INFO] [stdout] test test_aggregate_relation_roundtrip ... ok
[INFO] [stdout] test test_fetch_relation_roundtrip ... ok
[INFO] [stdout] test test_join_relation_semi_types_roundtrip ... ok
[INFO] [stdout] test test_plan_with_verbose_and_simple_output ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/types.rs (/opt/rustwide/target/debug/deps/types-872add8d1265d3ac)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test test_verbose_and_simple_output ... ok
[INFO] [stdout] test test_types ... ok
[INFO] [stdout] test test_expression ... 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]    Doc-tests substrait_explain
[INFO] [stdout] 
[INFO] [stdout] running 33 tests
[INFO] [stdout] test src/../API.md - (line 54) ... ok
[INFO] [stdout] test src/../API.md - (line 133) - compile ... ok
[INFO] [stdout] test src/../GRAMMAR.md - grammar (line 351) ... ok
[INFO] [stdout] test src/../GRAMMAR.md - grammar (line 128) ... ok
[INFO] [stdout] test src/../API.md - (line 80) ... ok
[INFO] [stdout] test src/cli.rs - cli::Cli::run_with_extensions (line 46) ... ignored
[INFO] [stdout] test src/../GRAMMAR.md - grammar (line 304) ... ok
[INFO] [stdout] test src/../API.md - (line 222) ... ok
[INFO] [stdout] test src/json.rs - json (line 17) ... ignored
[INFO] [stdout] test src/../GRAMMAR.md - grammar (line 576) ... ok
[INFO] [stdout] test src/../GRAMMAR.md - grammar (line 486) ... ok
[INFO] [stdout] test src/../GRAMMAR.md - grammar (line 66) ... ok
[INFO] [stdout] test src/lib.rs - format_with_registry (line 152) ... ignored
[INFO] [stdout] test src/../GRAMMAR.md - grammar (line 667) ... ok
[INFO] [stdout] test src/lib.rs - parse (line 51) ... ok
[INFO] [stdout] test src/../GRAMMAR.md - grammar (line 788) ... ok
[INFO] [stdout] test src/lib.rs - format_with_options (line 113) ... ok
[INFO] [stdout] test src/parser/structural.rs - parser::structural::Parser (line 712) ... ok
[INFO] [stdout] test src/textify/foundation.rs - textify::foundation::Scope::separated (line 501) ... ignored
[INFO] [stdout] test src/../API.md - (line 24) ... ok
[INFO] [stdout] test src/../GRAMMAR.md - grammar (line 407) ... ok
[INFO] [stdout] test src/../GRAMMAR.md - grammar (line 513) ... ok
[INFO] [stdout] test src/lib.rs - format (line 78) ... ok
[INFO] [stdout] test src/parser/structural.rs - parser::structural::Parser<'a>::parse (line 837) ... ok
[INFO] [stdout] test src/lib.rs - parse (line 32) ... ok
[INFO] [stdout] test src/../GRAMMAR.md - grammar (line 252) ... ok
[INFO] [stdout] test src/../GRAMMAR.md - grammar (line 543) ... ok
[INFO] [stdout] test src/parser/structural.rs - parser::structural::Parser (line 781) ... ok
[INFO] [stdout] test src/../GRAMMAR.md - grammar (line 606) ... ok
[INFO] [stdout] test src/extensions/examples.rs - extensions::examples::PartitionHint (line 70) ... ok
[INFO] [stdout] test src/parser/structural.rs - parser::structural::Parser (line 751) ... ok
[INFO] [stdout] test src/extensions/registry.rs - extensions::registry (line 25) ... ok
[INFO] [stdout] test src/../GRAMMAR.md - grammar (line 858) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 29 passed; 0 failed; 4 ignored; 0 measured; 0 filtered out; finished in 0.20s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 2.04s; merged doctests compilation took 1.80s
[INFO] running `Command { std: "docker" "inspect" "397170fd0973dc5bb9984025ddc24383ce2513587c1bc990f67504294a534f95", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "397170fd0973dc5bb9984025ddc24383ce2513587c1bc990f67504294a534f95", kill_on_drop: false }`
[INFO] [stdout] 397170fd0973dc5bb9984025ddc24383ce2513587c1bc990f67504294a534f95