[INFO] fetching crate datalogic-rs 5.8.1...
[INFO] testing datalogic-rs-5.8.1 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate datalogic-rs 5.8.1 into /workspace/builds/worker-4-tc1/source
[INFO] started tweaking crates.io crate datalogic-rs 5.8.1
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate datalogic-rs 5.8.1
[INFO] tweaked toml for crates.io crate datalogic-rs 5.8.1 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate datalogic-rs 5.8.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 datalogic-rs 5.8.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 fast-float2 v0.2.4
[INFO] [stderr]   Downloaded datavalue-rs v0.3.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] c801e4fda8b5e8a322f6362f11ae8096035b2d9349ea4f1224c4e3d8ee924431
[INFO] running `Command { std: "docker" "start" "c801e4fda8b5e8a322f6362f11ae8096035b2d9349ea4f1224c4e3d8ee924431", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c801e4fda8b5e8a322f6362f11ae8096035b2d9349ea4f1224c4e3d8ee924431", 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" "c801e4fda8b5e8a322f6362f11ae8096035b2d9349ea4f1224c4e3d8ee924431" "/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" "c801e4fda8b5e8a322f6362f11ae8096035b2d9349ea4f1224c4e3d8ee924431", 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" "c801e4fda8b5e8a322f6362f11ae8096035b2d9349ea4f1224c4e3d8ee924431" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling fast-float2 v0.2.4
[INFO] [stderr]    Compiling bumpalo v3.20.3
[INFO] [stderr]    Compiling self_cell v1.3.0
[INFO] [stderr]    Compiling smallvec v1.16.2
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling syn v3.0.6
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling datavalue-rs v0.3.1
[INFO] [stderr]    Compiling datalogic-rs v5.8.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 52.88s
[INFO] running `Command { std: "docker" "inspect" "c801e4fda8b5e8a322f6362f11ae8096035b2d9349ea4f1224c4e3d8ee924431", 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" "c801e4fda8b5e8a322f6362f11ae8096035b2d9349ea4f1224c4e3d8ee924431" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.190
[INFO] [stderr]    Compiling futures-sink v0.3.34
[INFO] [stderr]    Compiling futures-core v0.3.34
[INFO] [stderr]    Compiling zerocopy v0.8.60
[INFO] [stderr]    Compiling futures-task v0.3.34
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling futures-io v0.3.34
[INFO] [stderr]    Compiling syn v3.0.6
[INFO] [stderr]    Compiling futures-channel v0.3.34
[INFO] [stderr]    Compiling futures-util v0.3.34
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling rand v0.9.5
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling futures v0.3.34
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling tokio-macros v2.7.2
[INFO] [stderr]    Compiling tokio v1.53.2
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling proptest v1.11.0
[INFO] [stderr]    Compiling datavalue-rs v0.3.1
[INFO] [stderr]    Compiling datalogic-rs v5.8.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 3m 44s
[INFO] running `Command { std: "docker" "inspect" "c801e4fda8b5e8a322f6362f11ae8096035b2d9349ea4f1224c4e3d8ee924431", 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" "c801e4fda8b5e8a322f6362f11ae8096035b2d9349ea4f1224c4e3d8ee924431" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.12s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/datalogic_rs-87b0b4de721cb614)
[INFO] [stdout] 
[INFO] [stdout] running 96 tests
[INFO] [stdout] test check::tests::counts ... ok
[INFO] [stdout] test arena::value::lookup::tests::wide_sorted_adjacent_duplicates_return_first ... ok
[INFO] [stdout] test check::tests::distances ... ok
[INFO] [stdout] test compile::optimize::constant_fold::tests::numeric_strings_are_not_precoerced ... ok
[INFO] [stdout] test arena::value::lookup::tests::wide_unsorted_scattered_duplicates_stay_key_correct ... ok
[INFO] [stdout] test arena::value::lookup::tests::wide_unsorted_hits_and_misses ... ok
[INFO] [stdout] test arena::value::lookup::tests::key_cmp_orders_bytewise ... ok
[INFO] [stdout] test compile::optimize::constant_fold::tests::partial_folds_that_could_change_the_result_are_left_alone ... ok
[INFO] [stdout] test compile::optimize::constant_fold::tests::test_fold_cat_adjacent ... ok
[INFO] [stdout] test arena::value::lookup::tests::threshold_boundary_unsorted ... ok
[INFO] [stdout] test compile::optimize::cse::tests::custom_truthy_evaluator_disables_the_pass ... ok
[INFO] [stdout] test arena::value::lookup::tests::empty_key_on_wide_object ... ok
[INFO] [stdout] test arena::value::lookup::tests::wide_sorted_hits_and_misses ... ok
[INFO] [stdout] test compile::optimize::constant_fold::tests::test_partial_fold_add ... ok
[INFO] [stdout] test compile::optimize::cse::tests::integer_and_float_near_twins_do_not_share ... ok
[INFO] [stdout] test compile::optimize::cse::tests::memo_does_not_leak_across_evaluations ... ok
[INFO] [stdout] test compile::optimize::cse::tests::integer_and_float_values_are_distinct ... ok
[INFO] [stdout] test compile::optimize::cse::tests::iterator_body_occurrences_neither_count_nor_wrap ... ok
[INFO] [stdout] test compile::optimize::cse::tests::exclusive_arms_still_share_with_a_root_occurrence ... ok
[INFO] [stdout] test compile::optimize::cse::tests::nested_classes_get_their_own_slots ... ok
[INFO] [stdout] test compile::optimize::cse::tests::if_condition_co_occurs_with_taken_arm ... ok
[INFO] [stdout] test compile::optimize::cse::tests::no_cse_node_sits_under_a_pushed_frame ... ok
[INFO] [stdout] test compile::optimize::cse::tests::small_scalar_repeats_get_no_slot ... ok
[INFO] [stdout] test compile::optimize::cse::tests::serialization_is_wrapper_transparent ... ok
[INFO] [stdout] test compile::optimize::cse::tests::mutually_exclusive_if_arms_get_no_slot ... ok
[INFO] [stdout] test compile::optimize::cse::tests::object_literals_compare_order_sensitively ... ok
[INFO] [stdout] test compile::optimize::cse::tests::repeated_aggregate_shares_one_slot ... ok
[INFO] [stdout] test compile::optimize::cse::tests::impure_subtrees_are_not_candidates ... ok
[INFO] [stdout] test compile::optimize::cse::tests::single_occurrence_gets_no_slot ... ok
[INFO] [stdout] test compile::optimize::strength::tests::test_double_negation ... ok
[INFO] [stdout] test compile::optimize::strength::tests::test_idempotent_double_not ... ok
[INFO] [stdout] test compile::optimize::strength::tests::test_unchanged_when_no_pattern ... ok
[INFO] [stdout] test compile::optimize::strength::tests::truth_compositions_collapse ... ok
[INFO] [stdout] test compile::optimize::strength::tests::truth_with_other_arities_is_unchanged ... ok
[INFO] [stdout] test compile::scope::tests::metadata_climb_can_need_ancestors_when_data_does_not ... ok
[INFO] [stdout] test compile::scope::tests::iterator_bodies_push_one_frame ... ok
[INFO] [stdout] test compile::scope::tests::every_frame_is_addressable ... ok
[INFO] [stdout] test compile::scope::tests::bodyless_iterators_push_nothing ... ok
[INFO] [stdout] test compile::scope::tests::plain_operators_push_nothing ... ok
[INFO] [stdout] test compile::scope::tests::reduce_initial_accumulator_is_frameless ... ok
[INFO] [stdout] test compile::scope::tests::resolution_table ... ok
[INFO] [stdout] test error::tests::error_path_default_is_empty ... ok
[INFO] [stdout] test compile::optimize::cse::tests::no_fold_compile_produces_no_slots ... ok
[INFO] [stdout] test error::tests::error_path_from_vec_round_trips ... ok
[INFO] [stdout] test error::tests::with_node_ids_round_trips ... ok
[INFO] [stdout] test error::tests::wrap_of_existing_error_is_noop ... ok
[INFO] [stdout] test error::tests::wrap_preserves_source_chain ... ok
[INFO] [stdout] test node::layout_tests::compiled_node_stays_small ... ok
[INFO] [stdout] test error::tests::wrap_renders_via_display ... ok
[INFO] [stdout] test node::prelit::tests::flat_array_prebuilds_and_borrows ... ok
[INFO] [stdout] test node::logic::tests::is_constant_tracks_folding ... ok
[INFO] [stdout] test node::prelit::tests::nested_composites_round_trip ... ok
[INFO] [stdout] test error::tests::wrap_threads_through_question_mark ... ok
[INFO] [stdout] test operators::extract::tests::strict_num_takes_numbers_and_numeric_strings_only ... ok
[INFO] [stdout] test node::logic::tests::cloned_logic_keeps_prebuilt_composite_literals ... ok
[INFO] [stdout] test operators::extract::tests::truthy_follows_the_engine_rule ... ok
[INFO] [stdout] test operators::missing::tests::a_minimum_past_usize_saturates ... ok
[INFO] [stdout] test operators::table_tests::algebra_is_pinned ... ok
[INFO] [stdout] test operators::table_tests::arity_is_derived_from_the_signature ... ok
[INFO] [stdout] test operators::table_tests::combinator_predicates_take_the_fast_path ... ok
[INFO] [stdout] test operators::table_tests::comparison_predicates_take_the_fast_path ... ok
[INFO] [stdout] test node::prelit::tests::prelit_is_send_and_sync ... ok
[INFO] [stdout] test node::prelit::tests::string_literal_prebuilds ... ok
[INFO] [stdout] test node::prelit::tests::trivial_shapes_are_rejected ... ok
[INFO] [stdout] test operators::array::nesting::tests::a_remembered_part_still_counts_toward_the_cap ... ok
[INFO] [stdout] test operators::array::nesting::tests::the_cap_is_inclusive ... ok
[INFO] [stdout] test operators::extract::tests::nullable_obj_admits_objects_and_null_only ... ok
[INFO] [stdout] test operators::array::nesting::tests::an_empty_container_at_the_cap_counts ... ok
[INFO] [stdout] test operators::table_tests::declared_arity_is_pinned ... ok
[INFO] [stdout] test operators::table_tests::iterators_are_iter_rows ... ok
[INFO] [stdout] test operators::table_tests::names_are_unique_and_canonical_first ... ok
[INFO] [stdout] test operators::array::nesting::tests::scalars_and_shallow_values_pass ... ok
[INFO] [stdout] test operators::table_tests::catalogue_agrees_with_the_build ... ok
[INFO] [stdout] test node::prelit::tests::clone_rebuilds_and_survives_the_original ... ok
[INFO] [stdout] test operators::table_tests::all_is_indexed_by_discriminant ... ok
[INFO] [stdout] test operators::table_tests::derived_classification_decisions ... ok
[INFO] [stdout] test operators::table_tests::each_rows_are_pinned ... ok
[INFO] [stdout] test parsed_data::tests::malformed_json_is_a_parse_error ... ok
[INFO] [stdout] test operators::table_tests::each_rows_short_circuit_empty_sources ... ok
[INFO] [stdout] test parsed_data::tests::outlives_short_lived_eval_arenas ... ok
[INFO] [stdout] test path::tests::pointers_escape_and_follow_the_traced_compile ... ok
[INFO] [stdout] test operators::table_tests::scoped_arguments_resolve_against_the_pushed_frame ... ok
[INFO] [stdout] test path::tests::resolve_root_only ... ok
[INFO] [stdout] test operators::table_tests::names_round_trip ... ok
[INFO] [stdout] test path::tests::resolve_empty_path_returns_empty ... ok
[INFO] [stdout] test operators::table_tests::raw_rows_are_pinned ... ok
[INFO] [stdout] test operators::table_tests::rows_honour_their_arity_policy ... ok
[INFO] [stdout] test path::tests::resolve_unknown_ids_are_skipped ... ok
[INFO] [stdout] test parsed_data::tests::handle_is_send ... ok
[INFO] [stdout] test path::tests::resolve_via_evaluation_error ... ok
[INFO] [stdout] test parsed_data::tests::parses_and_exposes_value ... ok
[INFO] [stdout] test path::tests::var_default_is_item_one ... ok
[INFO] [stdout] test operators::array::nesting::tests::far_deeper_values_error_without_deep_recursion ... ok
[INFO] [stdout] test parsed_data::tests::evaluates_through_engine_and_session ... ok
[INFO] [stdout] test arena::value::strings::tests::integer_display_parity ... ok
[INFO] [stdout] test arena::value::strings::tests::float_display_parity ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 96 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.22s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/compiled_on_test.rs (/opt/rustwide/target/release/deps/compiled_on_test-c04091a0c3f733bd)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test a_shared_session_sees_its_engine ... ok
[INFO] [stdout] test not_on_another_engine_built_alike ... ok
[INFO] [stdout] test a_clone_keeps_its_engine ... ok
[INFO] [stdout] test not_on_a_rebuilt_engine ... ok
[INFO] [stdout] test a_rule_was_compiled_on_its_own_engine ... ok
[INFO] [stdout] test an_unfolded_compile_records_it_too ... ok
[INFO] [stdout] test the_top_level_compile_belongs_to_no_user_engine ... ok
[INFO] [stdout] test every_compile_entry_point_records_its_engine ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/cross_engine_fold_test.rs (/opt/rustwide/target/release/deps/cross_engine_fold_test-48116f14de38636a)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test a_constant_folded_under_lenient_coercion_follows_a_stricter_engine ... ok
[INFO] [stdout] test a_dead_branch_follows_the_evaluating_engines_truthiness ... ok
[INFO] [stdout] test a_constant_folded_under_lenient_nan_handling_still_errors_on_a_strict_engine ... ok
[INFO] [stdout] test a_folded_branch_inside_a_dynamic_rule_follows_the_evaluating_engine ... ok
[INFO] [stdout] test several_differently_configured_engines_each_get_their_own_answer ... ok
[INFO] [stdout] test every_evaluation_and_thread_sees_its_own_engines_answer ... ok
[INFO] [stdout] test a_folded_division_follows_the_evaluating_engine ... ok
[INFO] [stdout] test an_engine_with_the_same_settings_runs_the_rule_as_compiled ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/custom_operator_check_test.rs (/opt/rustwide/target/release/deps/custom_operator_check_test-cee64ae6b908644a)
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test a_pointer_escapes_the_operator_name ... ok
[INFO] [stdout] test a_known_value_passes ... ok
[INFO] [stdout] test a_problem_with_the_whole_call_points_at_the_call ... ok
[INFO] [stdout] test nested_calls_are_still_checked ... ok
[INFO] [stdout] test an_error_blocks_compile_checked_but_not_compile ... ok
[INFO] [stdout] test a_rejected_argument_is_an_error_at_that_argument ... ok
[INFO] [stdout] test arguments_arrive_as_written ... ok
[INFO] [stdout] test a_wrong_count_skips_the_operator_check ... ok
[INFO] [stdout] test every_problem_is_reported_in_rule_order ... ok
[INFO] [stdout] test the_default_check_accepts_anything ... ok
[INFO] [stdout] test box_and_arc_forward_the_check ... ok
[INFO] [stdout] test a_warning_does_not_block_compile_checked ... ok
[INFO] [stdout] test a_single_argument_is_argument_zero ... ok
[INFO] [stdout] test the_constructors_describe_the_problem ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/custom_operator_shadow_test.rs (/opt/rustwide/target/release/deps/custom_operator_shadow_test-85c16b36609861e6)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test a_free_name_registers ... ok
[INFO] [stdout] test add_operator_is_unchanged ... ok
[INFO] [stdout] test a_family_not_compiled_in_does_not_shadow ... ok
[INFO] [stdout] test message_names_the_builtin ... ok
[INFO] [stdout] test every_builtin_name_is_refused ... 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/custom_operator_slot_test.rs (/opt/rustwide/target/release/deps/custom_operator_slot_test-39aa357792f83ad4)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test an_engine_without_the_operator_names_it_in_the_error ... ok
[INFO] [stdout] test another_engine_checks_its_own_operators_argument_count ... ok
[INFO] [stdout] test many_operators_each_resolve ... ok
[INFO] [stdout] test another_engine_runs_its_own_operator_of_that_name ... ok
[INFO] [stdout] test a_replaced_registration_runs_the_last_one ... ok
[INFO] [stdout] test an_operator_unknown_at_compile_time_is_found_by_name ... ok
[INFO] [stdout] test each_operator_runs_on_its_own_engine ... ok
[INFO] [stdout] test engines_built_alike_are_still_different_engines ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/engine_settings_test.rs (/opt/rustwide/target/release/deps/engine_settings_test-41d2bd84ad98bc23)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test debug_shows_every_setting ... ok
[INFO] [stdout] test to_builder_keeps_every_setting ... ok
[INFO] [stdout] test try_build_refuses_a_zero_recursion_depth ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/error_kind_test.rs (/opt/rustwide/target/release/deps/error_kind_test-d274a32f8fd7770e)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test codes_are_distinct_values ... ok
[INFO] [stdout] test a_code_names_the_kind_as_tag_does ... ok
[INFO] [stdout] test an_evaluation_error_carries_its_code ... ok
[INFO] [stdout] test every_kind_has_its_own_code ... ok
[INFO] [stdout] test budget_exceeded_exists_in_every_build ... ok
[INFO] [stdout] test a_code_parses_back_from_its_name ... 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/facts_test.rs (/opt/rustwide/target/release/deps/facts_test-608b9e5b539c27f7)
[INFO] [stdout] 
[INFO] [stdout] running 27 tests
[INFO] [stdout] test computed_path_in_iterator_body ... ok
[INFO] [stdout] test folded_operators_are_not_reported ... ok
[INFO] [stdout] test invalid_arguments_name_the_operator ... ok
[INFO] [stdout] test custom_operators_are_opaque ... ok
[INFO] [stdout] test level_marker_at_root ... ok
[INFO] [stdout] test covered_reads_are_dropped ... ok
[INFO] [stdout] test level_markers_in_nested_iterators ... ok
[INFO] [stdout] test literal_rule ... ok
[INFO] [stdout] test iterator_body_reads_are_not_root_reads ... ok
[INFO] [stdout] test metadata_reads_are_not_data_reads ... ok
[INFO] [stdout] test reads_are_sorted_and_deduplicated ... ok
[INFO] [stdout] test dead_branches_are_not_reported ... ok
[INFO] [stdout] test shared_subexpressions_are_read_once ... ok
[INFO] [stdout] test level_marker_climbing_to_root ... ok
[INFO] [stdout] test current_at_root_is_a_field ... ok
[INFO] [stdout] test missing_some_paths ... ok
[INFO] [stdout] test path_computed_from_literals_stays_computed ... ok
[INFO] [stdout] test missing_paths ... ok
[INFO] [stdout] test numeric_var_path ... ok
[INFO] [stdout] test computed_var_path ... ok
[INFO] [stdout] test operators_are_canonical_sorted_and_unique ... ok
[INFO] [stdout] test reduce_reads_source_and_initial_value ... ok
[INFO] [stdout] test whole_context_read ... ok
[INFO] [stdout] test specialised_nodes_report_their_operator ... ok
[INFO] [stdout] test val_segments_are_not_split ... ok
[INFO] [stdout] test var_default_is_read_too ... ok
[INFO] [stdout] test var_path_splits_on_dots ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/layout_test.rs (/opt/rustwide/target/release/deps/layout_test-c514199e4bf2c847)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stderr]      Running tests/operator_names_test.rs (/opt/rustwide/target/release/deps/operator_names_test-1d930345b8666721)
[INFO] [stdout] test data_value_stays_small ... ok
[INFO] [stdout] test error_stays_thin ... ok
[INFO] [stdout] test owned_data_value_stays_small ... 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] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test catalogue_gates_match_cargo_features ... ok
[INFO] [stdout] test builtin_and_custom_sets_are_disjoint ... ok
[INFO] [stdout] test baseline_names_are_always_present ... ok
[INFO] [stdout] test compiled_families_are_reported_and_gated_ones_are_not ... ok
[INFO] [stdout] test canonical_name_precedes_its_alias ... ok
[INFO] [stdout] test iterator_does_not_borrow_the_engine ... ok
[INFO] [stdout] test representative_names_follow_their_feature ... ok
[INFO] [stdout] test operators_describe_every_named_builtin ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/operator_table_rule_test.rs (/opt/rustwide/target/release/deps/operator_table_rule_test-651b758d354a7cae)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test per_operator_facts_live_in_the_table ... ok
[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] [stderr]      Running tests/reduce_depth_test.rs (/opt/rustwide/target/release/deps/reduce_depth_test-34925148d8f357a1)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test a_body_calling_a_custom_operator_is_measured_every_step ... ok
[INFO] [stdout] test reducing_an_object_is_capped_too ... ok
[INFO] [stdout] test a_body_that_wraps_deeply_every_step_is_capped ... ok
[INFO] [stdout] test nesting_up_to_the_cap_still_works ... ok
[INFO] [stdout] test a_long_wrapping_reduce_is_an_error_not_an_abort ... ok
[INFO] [stdout] test shallow_accumulators_are_unaffected ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.51s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/roots_owned_test.rs (/opt/rustwide/target/release/deps/roots_owned_test-36a8b9f101244ee7)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test owned_and_parsed_roots ... ok
[INFO] [stdout] test truthy_of_owned_and_parsed ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/shared_operator_test.rs (/opt/rustwide/target/release/deps/shared_operator_test-abd4ad886995c7b5)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test try_add_operator_takes_an_arc ... ok
[INFO] [stdout] test shared_trait_objects ... ok
[INFO] [stdout] test one_instance_on_two_engines ... 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/shared_session_test.rs (/opt/rustwide/target/release/deps/shared_session_test-14032b3dffc18248)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test the_borrowed_session_type_is_unchanged ... ok
[INFO] [stdout] test a_shared_session_is_static_and_send ... ok
[INFO] [stdout] test it_keeps_the_engine_alive ... ok
[INFO] [stdout] test it_evaluates_like_a_borrowed_session ... ok
[INFO] [stdout] test borrowed_results_and_arena_controls_work ... ok
[INFO] [stdout] test it_moves_to_another_thread ... ok
[INFO] [stdout] test it_runs_in_an_async_task ... ok
[INFO] [stdout] test it_lives_in_a_struct_without_a_lifetime ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/to_builder_test.rs (/opt/rustwide/target/release/deps/to_builder_test-780b3d6b25d0d540)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test settings_can_be_changed_on_the_rebuild ... ok
[INFO] [stdout] test the_rebuilt_engine_outlives_the_original ... ok
[INFO] [stdout] test the_folding_setting_carries_over ... ok
[INFO] [stdout] test the_rebuilt_engine_shares_each_operator_instance ... ok
[INFO] [stdout] test operators_added_to_the_rebuild_leave_the_original_alone ... ok
[INFO] [stdout] test a_rule_compiled_elsewhere_runs_on_the_rebuild ... ok
[INFO] [stdout] test an_arc_operator_is_shared_with_the_host ... ok
[INFO] [stdout] test the_declared_info_carries_over ... ok
[INFO] [stdout] test the_config_carries_over ... ok
[INFO] [stdout] test a_plain_engine_rebuilds_to_a_plain_engine ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/v5_api_test.rs (/opt/rustwide/target/release/deps/v5_api_test-d0efb1ef73493820)
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test engine_and_session_are_debug_printable ... ok
[INFO] [stdout] test compile_then_evaluate_str_round_trip ... ok
[INFO] [stdout] test datavalue_object_returned_as_json_string ... ok
[INFO] [stdout] test evaluate_str_one_shot_with_variable ... ok
[INFO] [stdout] test logic_to_json_round_trip_evaluates_identically ... ok
[INFO] [stdout] test logic_to_json_handles_constant_folded_subtree ... ok
[INFO] [stdout] test logic_clone_evaluates_independently ... ok
[INFO] [stdout] test builtin_shadows_custom_operator_with_same_name ... ok
[INFO] [stdout] test compile_once_evaluate_many_arena_reuse ... ok
[INFO] [stdout] test evaluate_arena_path ... ok
[INFO] [stdout] test max_recursion_depth_catches_custom_operator_reentry ... ok
[INFO] [stdout] test to_json_round_trips_one_argument_calls ... ok
[INFO] [stdout] test with_constant_folding_off_preserves_operators ... ok
[INFO] [stdout] test builder_default_engine ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests datalogic_rs
[INFO] [stdout] 
[INFO] [stdout] running 52 tests
[INFO] [stdout] test src/arena_ext.rs - arena_ext (line 6) ... ignored
[INFO] [stdout] test src/builder.rs - builder::EngineBuilder::add_operator (line 222) ... ignored
[INFO] [stdout] test src/config.rs - config::TruthyEvaluator::custom (line 267) ... ok
[INFO] [stdout] test src/builder.rs - builder::EngineBuilder::with_families (line 358) ... ok
[INFO] [stdout] test src/engine/mod.rs - engine::Engine::check (line 684) ... ok
[INFO] [stdout] test src/builder.rs - builder::EngineBuilder::try_add_operator (line 261) ... ok
[INFO] [stdout] test src/builder.rs - builder::EngineBuilder::try_build (line 395) ... ok
[INFO] [stdout] test src/engine/mod.rs - engine::Engine::eval (line 1148) ... ok
[INFO] [stdout] test src/builder.rs - builder::EngineBuilder::with_template_key_escape (line 171) ... ok
[INFO] [stdout] test src/engine/mod.rs - engine::Engine::compile_strict (line 778) ... ok
[INFO] [stdout] test src/engine/mod.rs - engine::Engine::builtin_operator_names (line 588) ... ok
[INFO] [stdout] test src/engine/mod.rs - engine::Engine::compile (line 654) ... ok
[INFO] [stdout] test src/arena_ext.rs - arena_ext::ArenaExt (line 33) ... ok
[INFO] [stdout] test src/builder.rs - builder::EngineBuilder::check_operator_name (line 305) ... ok
[INFO] [stdout] test src/builder.rs - builder::EngineBuilder (line 17) ... ok
[INFO] [stdout] test src/config.rs - config::EvaluationConfig (line 27) ... ok
[INFO] [stdout] test src/engine/mod.rs - engine::Engine::eval_as (line 1229) ... ok
[INFO] [stdout] test src/engine/mod.rs - engine::Engine (line 110) ... ok
[INFO] [stdout] test src/error/mod.rs - error::Error::wrap (line 234) ... ignored
[INFO] [stdout] test src/engine/mod.rs - engine::Engine::new (line 474) ... ok
[INFO] [stdout] test src/lib.rs - (line 73) ... ok
[INFO] [stdout] test src/lib.rs - (line 31) ... ok
[INFO] [stdout] test src/lib.rs - CustomOperator (line 264) ... ok
[INFO] [stdout] test src/node/logic.rs - node::logic::Logic::compiled_on (line 224) ... ok
[INFO] [stdout] test src/lib.rs - (line 48) ... ok
[INFO] [stdout] test src/engine/mod.rs - engine::Engine::evaluate (line 851) ... ok
[INFO] [stdout] test src/lib.rs - CustomOperator::check (line 369) ... ok
[INFO] [stdout] test src/operators/eager.rs - operators::eager (line 8) ... ignored
[INFO] [stdout] test src/node/logic.rs - node::logic::Logic::facts (line 339) ... ok
[INFO] [stdout] test src/node/logic.rs - node::logic::Logic (line 22) ... ok
[INFO] [stdout] test src/operator.rs - operator::EvalContext<'ctx,'a>::charge (line 70) ... ok
[INFO] [stdout] test src/node/logic.rs - node::logic::Logic::cse_slot_count (line 375) ... ok
[INFO] [stdout] test src/node/logic.rs - node::logic::Logic::to_json (line 402) ... ok
[INFO] [stdout] test src/session.rs - session::Session<'engine,E>::eval_as (line 229) ... ok
[INFO] [stdout] test src/roots.rs - roots::Roots (line 34) ... ok
[INFO] [stdout] test src/session.rs - session::Session<'engine,E>::eval_borrowed (line 344) ... ok
[INFO] [stdout] test src/node/logic.rs - node::logic::Logic::is_constant (line 312) ... ok
[INFO] [stdout] test src/error/serde.rs - error::serde::Error::source (line 71) ... ok
[INFO] [stdout] test src/top_level.rs - top_level::eval (line 51) ... ok
[INFO] [stdout] test src/top_level.rs - top_level::eval_str (line 70) ... ok
[INFO] [stdout] test src/session.rs - session::SharedSession (line 88) ... ok
[INFO] [stdout] test src/parsed_data.rs - parsed_data::ParsedData (line 48) ... ok
[INFO] [stdout] test src/top_level.rs - top_level::compile (line 39) ... ok
[INFO] [stdout] test src/engine/mod.rs - engine::Engine::to_builder (line 402) ... ok
[INFO] [stdout] test src/engine/mod.rs - engine::Engine::operators (line 613) ... ok
[INFO] [stdout] test src/lib.rs - CustomOperatorInfo (line 411) ... ok
[INFO] [stdout] test src/engine/mod.rs - engine::Engine::truthy (line 1095) ... ok
[INFO] [stdout] test src/engine/mod.rs - engine::Engine::eval_str (line 1170) ... ok
[INFO] [stdout] test src/session.rs - session::Session (line 54) ... ok
[INFO] [stdout] test src/engine/mod.rs - engine::Engine::session (line 433) ... ok
[INFO] [stdout] test src/engine/mod.rs - engine::Engine::truthy_of (line 1121) ... ok
[INFO] [stdout] test src/session.rs - session::Session<'engine,E>::eval (line 204) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 48 passed; 0 failed; 4 ignored; 0 measured; 0 filtered out; finished in 0.12s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 3.85s; merged doctests compilation took 3.72s
[INFO] running `Command { std: "docker" "inspect" "c801e4fda8b5e8a322f6362f11ae8096035b2d9349ea4f1224c4e3d8ee924431", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c801e4fda8b5e8a322f6362f11ae8096035b2d9349ea4f1224c4e3d8ee924431", kill_on_drop: false }`
[INFO] [stdout] c801e4fda8b5e8a322f6362f11ae8096035b2d9349ea4f1224c4e3d8ee924431