[INFO] fetching crate sylvester 0.4.0...
[INFO] testing sylvester-0.4.0 against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate sylvester 0.4.0 into /workspace/builds/worker-3-tc2/source
[INFO] removed /workspace/builds/worker-3-tc2/source/rust-toolchain.toml
[INFO] started tweaking crates.io crate sylvester 0.4.0
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate sylvester 0.4.0
[INFO] tweaked toml for crates.io crate sylvester 0.4.0 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate sylvester 0.4.0 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate sylvester 0.4.0 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.100.0-beta.1" "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/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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] d1bd0296698f304ce9449abbd31279c96b5e95da577cc82f79e07b69c601dfc8
[INFO] running `Command { std: "docker" "start" "d1bd0296698f304ce9449abbd31279c96b5e95da577cc82f79e07b69c601dfc8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d1bd0296698f304ce9449abbd31279c96b5e95da577cc82f79e07b69c601dfc8", 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" "d1bd0296698f304ce9449abbd31279c96b5e95da577cc82f79e07b69c601dfc8" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d1bd0296698f304ce9449abbd31279c96b5e95da577cc82f79e07b69c601dfc8", 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" "d1bd0296698f304ce9449abbd31279c96b5e95da577cc82f79e07b69c601dfc8" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling crossbeam-utils v0.8.22
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.20
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling crossbeam-deque v0.8.7
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling num-integer v0.1.47
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling either v1.16.0
[INFO] [stderr]    Compiling allocator-api2 v0.2.21
[INFO] [stderr]    Compiling memchr v2.8.3
[INFO] [stderr]    Compiling foldhash v0.1.5
[INFO] [stderr]    Compiling num-bigint v0.4.8
[INFO] [stderr]    Compiling hashbrown v0.15.5
[INFO] [stderr]    Compiling syn v3.0.3
[INFO] [stderr]    Compiling rayon-core v1.13.0
[INFO] [stderr]    Compiling rayon v1.12.0
[INFO] [stderr]    Compiling num-rational v0.4.2
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling sylvester v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1m 12s
[INFO] running `Command { std: "docker" "inspect" "d1bd0296698f304ce9449abbd31279c96b5e95da577cc82f79e07b69c601dfc8", 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" "d1bd0296698f304ce9449abbd31279c96b5e95da577cc82f79e07b69c601dfc8" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling zerocopy v0.8.55
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling either v1.16.0
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling bitflags v2.13.1
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling plotters-backend v0.3.7
[INFO] [stderr]    Compiling ciborium-io v0.2.2
[INFO] [stderr]    Compiling clap_builder v4.6.2
[INFO] [stderr]    Compiling rayon v1.12.0
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling regex-automata v0.4.16
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling plotters-svg v0.3.7
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]    Compiling syn v3.0.3
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling bit-vec v0.8.0
[INFO] [stderr]    Compiling quick-error v1.2.3
[INFO] [stderr]    Compiling cast v0.3.0
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling criterion-plot v0.5.0
[INFO] [stderr]    Compiling bit-set v0.8.0
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling walkdir v2.5.0
[INFO] [stderr]    Compiling regex v1.13.1
[INFO] [stderr]    Compiling clap v4.6.4
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling rand v0.9.5
[INFO] [stderr]    Compiling is-terminal v0.4.17
[INFO] [stderr]    Compiling anes v0.1.6
[INFO] [stderr]    Compiling unarray v0.1.4
[INFO] [stderr]    Compiling oorandom v11.1.5
[INFO] [stderr]    Compiling zerocopy-derive v0.8.55
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling sylvester v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling proptest v1.11.0
[INFO] [stderr]    Compiling criterion v0.5.1
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 4m 45s
[INFO] running `Command { std: "docker" "inspect" "d1bd0296698f304ce9449abbd31279c96b5e95da577cc82f79e07b69c601dfc8", 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" "d1bd0296698f304ce9449abbd31279c96b5e95da577cc82f79e07b69c601dfc8" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.22s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/build/sylvester/9287db547870678a/out/sylvester-9287db547870678a)
[INFO] [stdout] 
[INFO] [stdout] running 247 tests
[INFO] [stdout] test cert::origin::tests::a_unit_origin_reproduces_its_input_polynomial ... ok
[INFO] [stdout] test cert::tests::a_basis_that_is_not_groebner_is_a_typed_defect ... ok
[INFO] [stdout] test cert::origin::tests::making_a_polynomial_monic_keeps_the_identity ... ok
[INFO] [stdout] test cert::origin::tests::a_wrong_cofactor_fails_the_identity ... ok
[INFO] [stdout] test cert::origin::tests::a_subtraction_step_keeps_the_identity ... ok
[INFO] [stdout] test cert::tests::an_input_that_does_not_reduce_is_a_typed_defect ... ok
[INFO] [stdout] test cert::tests::a_count_that_does_not_match_is_a_typed_defect ... ok
[INFO] [stdout] test cert::tests::a_cancelled_run_stops_the_emitter ... ok
[INFO] [stdout] test cert::origin::tests::a_combination_step_keeps_the_identity ... ok
[INFO] [stdout] test cert::tests::division_records_quotients_that_rebuild_the_dividend ... ok
[INFO] [stdout] test cert::tests::emits_a_certificate_without_variables ... ok
[INFO] [stdout] test cert::tests::emits_the_unit_ideal_certificate ... ok
[INFO] [stdout] test cert::tests::emits_a_two_element_basis_with_hand_derived_origins ... ok
[INFO] [stdout] test cert::tests::emits_the_spair_entries_of_a_three_element_basis ... ok
[INFO] [stdout] test cert::tests::emits_the_single_generator_certificate ... ok
[INFO] [stdout] test cert::tests::emits_the_zero_ideal_certificate ... ok
[INFO] [stdout] test cert::tests::leaves_out_the_pair_with_coprime_leading_monomials ... ok
[INFO] [stdout] test cert::v2::tests::a_restart_releases_what_the_dropped_nodes_held ... ok
[INFO] [stdout] test cert::tests::a_limit_that_holds_the_emission_changes_no_byte ... ok
[INFO] [stdout] test cert::v2::tests::the_cost_of_recording ... ignored, a measurement, not a check
[INFO] [stdout] test cert::v2::tests::the_empty_fixture_is_written_byte_for_byte ... ok
[INFO] [stdout] test cert::v2::tests::the_kept_node_count_comes_before_the_pruned_trace ... ok
[INFO] [stdout] test cert::tests::a_passed_deadline_stops_the_emitter ... ok
[INFO] [stdout] test cert::tests::a_tight_memory_limit_stops_the_emitter ... ok
[INFO] [stdout] test cert::tests::a_wrong_origin_cofactor_reaches_the_verifier ... ok
[INFO] [stdout] test cert::v2::tests::the_square_fixture_is_written_byte_for_byte ... ok
[INFO] [stdout] test cert::v2::tests::the_tiny_system_writes_the_header_of_the_listing ... ok
[INFO] [stdout] test cert::v2::tests::the_unit_fixture_is_written_byte_for_byte ... ok
[INFO] [stdout] test cert::v2::tests::the_zero_fixture_is_written_byte_for_byte ... ok
[INFO] [stdout] test certificate::tests::an_exhausted_engine_keeps_its_value ... ok
[INFO] [stdout] test compute::classic::tests::f5_reduction_respects_signature_strictness ... ok
[INFO] [stdout] test cert::tests::sorts_the_basis_and_carries_the_origins_with_it ... ok
[INFO] [stdout] test compute::classic::tests::solve_handles_a_monomial_ideal ... ok
[INFO] [stdout] test compute::classic::tests::spolynomial_cancels_the_lcm_term ... ok
[INFO] [stdout] test compute::f4::basis::tests::a_new_element_under_a_live_lead_retires_itself ... ok
[INFO] [stdout] test cert::tests::two_assemblies_of_one_system_give_the_same_bytes ... ok
[INFO] [stdout] test certificate::tests::an_exhausted_verifier_is_not_a_rejection ... ok
[INFO] [stdout] test compute::classic::tests::a_pair_past_the_degree_limit_is_a_typed_error ... ok
[INFO] [stdout] test compute::f4::basis::tests::a_constant_generator_gives_the_unit_basis ... ok
[INFO] [stdout] test compute::f4::basis::tests::every_pair_the_update_drops_stays_covered ... ok
[INFO] [stdout] test compute::f4::basis::tests::pairs_are_generated_before_the_retirement_they_justify ... ok
[INFO] [stdout] test compute::f4::basis::tests::seeding_drops_zero_and_duplicate_generators ... ok
[INFO] [stdout] test compute::f4::field::tests::mulhi_matches_the_u128_product ... ok
[INFO] [stdout] test compute::f4::basis::tests::seeding_makes_every_generator_monic ... ok
[INFO] [stdout] test compute::f4::field::tests::the_shoup_product_stays_below_two_p ... ok
[INFO] [stdout] test compute::f4::basis::tests::the_shortest_reducer_has_the_fewest_terms ... ok
[INFO] [stdout] test compute::f4::basis::tests::two_live_elements_never_share_a_lead ... ok
[INFO] [stdout] test compute::f4::field::tests::barrett_multiplier_is_the_floor_of_two_to_the_64 ... ok
[INFO] [stdout] test compute::f4::basis::tests::the_lead_index_finds_the_same_divisor_as_a_linear_scan ... ok
[INFO] [stdout] test compute::f4::field::tests::reduce_acc_covers_the_boundary_values ... ok
[INFO] [stdout] test compute::f4::field::tests::shoup_precomputation_is_the_floor_of_the_scaled_quotient ... ok
[INFO] [stdout] test compute::f4::kernel::tests::a_constant_pivot_stops_the_batch ... ok
[INFO] [stdout] test compute::f4::kernel::tests::a_lane_holding_a_multiple_of_p_is_cleared ... ok
[INFO] [stdout] test compute::f4::field::tests::the_sweep_bound_is_above_two_to_the_thirty_two ... ok
[INFO] [stdout] test compute::f4::field::tests::the_sweep_bound_is_exact ... ok
[INFO] [stdout] test compute::f4::kernel::tests::a_long_chain_of_applications_stays_inside_the_lane ... ok
[INFO] [stdout] test compute::f4::kernel::tests::a_reused_workspace_leaves_no_stale_lane ... ok
[INFO] [stdout] test compute::f4::kernel::tests::interreduction_reduces_every_tail ... ok
[INFO] [stdout] test compute::f4::kernel::tests::a_pivot_never_writes_its_leading_coefficient_back ... ok
[INFO] [stdout] test compute::f4::matrix::tests::a_second_build_keeps_the_arenas ... ok
[INFO] [stdout] test compute::f4::kernel::tests::a_passed_deadline_stops_the_walk_inside_one_row ... ok
[INFO] [stdout] test compute::f4::matrix::tests::columns_descend_and_row_supports_ascend ... ok
[INFO] [stdout] test compute::f4::monomial::tests::an_exponent_past_the_lane_bound_restarts_the_run ... ok
[INFO] [stdout] test compute::f4::monomial::tests::an_exponent_past_the_contract_has_no_width ... ok
[INFO] [stdout] test compute::f4::monomial::tests::clear_keeps_the_identity_only ... ok
[INFO] [stdout] test compute::f4::kernel::tests::the_trace_sees_every_row ... ok
[INFO] [stdout] test compute::f4::matrix::tests::the_reducer_row_of_a_column_is_the_one_symbolic_named ... ok
[INFO] [stdout] test compute::f4::monomial::tests::cross_store_operations_match_one_table ... ok
[INFO] [stdout] test compute::f4::monomial::tests::intern_and_compare_throughput ... ignored, timing study: cargo test --release --lib -- --ignored --nocapture
[INFO] [stdout] test compute::f4::monomial::tests::hash_consing_returns_one_id ... ok
[INFO] [stdout] test compute::f4::kernel::tests::two_runs_agree ... ok
[INFO] [stdout] test compute::f4::monomial::tests::identity_is_the_first_id ... ok
[INFO] [stdout] test compute::f4::monomial::tests::ids_repeat_for_the_same_insertion_sequence ... ok
[INFO] [stdout] test compute::f4::kernel::tests::a_passed_deadline_stops_the_parallel_phase_inside_one_batch ... ok
[INFO] [stdout] test compute::f4::monomial::tests::padding_lanes_stay_zero ... ok
[INFO] [stdout] test compute::f4::kernel::tests::random_batches_match_the_reference_at_the_benchmark_modulus ... ok
[INFO] [stdout] test compute::f4::kernel::tests::random_batches_match_the_dense_reference ... ok
[INFO] [stdout] test compute::f4::monomial::tests::mul_external_survives_a_slab_reallocation ... ok
[INFO] [stdout] test compute::f4::pairs::tests::an_empty_queue_yields_no_batch ... ok
[INFO] [stdout] test compute::f4::monomial::tests::no_variables_gives_one_monomial ... ok
[INFO] [stdout] test compute::f4::pairs::tests::criterion_b_deletes_a_covered_pair ... ok
[INFO] [stdout] test compute::f4::monomial::tests::word_boundaries_compare_like_the_reference ... ok
[INFO] [stdout] test compute::f4::pairs::tests::the_coverage_guard_keeps_a_pair_with_a_retired_endpoint ... ok
[INFO] [stdout] test compute::f4::pairs::tests::criterion_f_keeps_the_smallest_index ... ok
[INFO] [stdout] test compute::f4::pairs::tests::the_product_criterion_drops_coprime_candidates ... ok
[INFO] [stdout] test compute::f4::pairs::tests::criterion_m_keeps_the_dividing_lcm ... ok
[INFO] [stdout] test compute::f4::pairs::tests::take_lowest_degree_returns_one_degree_class_in_order ... ok
[INFO] [stdout] test compute::f4::pairs::tests::the_batch_cap_defers_the_rest_of_the_degree_class ... ok
[INFO] [stdout] test compute::f4::pairs::tests::the_update_clears_the_workspace ... ok
[INFO] [stdout] test compute::f4::symbolic::tests::one_pair_gives_two_rows_and_one_pivot_column ... ok
[INFO] [stdout] test compute::f4::symbolic::tests::the_m1_baseline_is_first_and_smallest_source ... ok
[INFO] [stdout] test compute::f4::symbolic::tests::the_shortest_upper_row_rule_picks_the_shorter_source ... ok
[INFO] [stdout] test compute::f4::symbolic::tests::two_runs_give_the_same_rows_and_columns ... ok
[INFO] [stdout] test compute::f4::symbolic::tests::two_sources_with_one_leading_monomial_both_emit_a_row ... ok
[INFO] [stdout] test compute::f4::tests::the_run_counters_report_the_work ... ok
[INFO] [stdout] test compute::f4::tests::the_starting_width_follows_the_input_exponents ... ok
[INFO] [stdout] test compute::interreduce::tests::interreduction_drops_a_redundant_leading_term ... ok
[INFO] [stdout] test compute::interreduce::tests::the_classic_backend_reduces_a_small_system ... ok
[INFO] [stdout] test compute::interreduce::tests::the_classic_backend_reduces_cyclic_3 ... ok
[INFO] [stdout] test compute::interreduce::tests::the_classic_backend_reduces_cyclic_4 ... ok
[INFO] [stdout] test compute::f4::tests::a_wide_exponent_restarts_the_run_at_the_next_lane_width ... ok
[INFO] [stdout] test compute::f4::tests::an_external_cancellation_flag_reaches_every_f4_deadline ... ok
[INFO] [stdout] test compute::modular::crt::tests::a_fold_checks_limits_at_its_first_term ... ok
[INFO] [stdout] test compute::interreduce::tests::an_exhausted_deadline_stops_the_interreduction ... ok
[INFO] [stdout] test compute::modular::crt::tests::a_monomial_of_a_later_run_starts_at_zero ... ok
[INFO] [stdout] test compute::f4::symbolic::tests::a_tail_monomial_with_a_divisor_gets_a_reducer_row ... ok
[INFO] [stdout] test compute::modular::primes::tests::the_search_stops_on_an_exhausted_deadline ... ok
[INFO] [stdout] test compute::interreduce::tests::the_classic_backend_reduces_katsura_4 ... ok
[INFO] [stdout] test compute::interreduce::tests::the_memory_meter_counts_the_spilled_exponents ... ok
[INFO] [stdout] test compute::modular::crt::tests::folding_agrees_with_a_direct_solve ... ok
[INFO] [stdout] test compute::modular::primes::tests::one_index_always_reads_one_prime ... ok
[INFO] [stdout] test compute::modular::primes::tests::the_sequence_starts_at_the_largest_modulus_and_descends ... ok
[INFO] [stdout] test compute::modular::primes::tests::a_rejected_prime_counts_and_leaves_the_sequence ... ok
[INFO] [stdout] test compute::modular::reconstruct::tests::a_modulus_below_three_lifts_nothing ... ok
[INFO] [stdout] test compute::modular::reconstruct::tests::a_lift_meets_the_contract ... ok
[INFO] [stdout] test compute::modular::reconstruct::tests::a_lift_stops_on_an_exhausted_deadline ... ok
[INFO] [stdout] test compute::modular::reconstruct::tests::a_negative_numerator_lifts_as_itself ... ok
[INFO] [stdout] test compute::tests::a_cancelled_classic_run_stops_at_the_flag ... ok
[INFO] [stdout] test compute::modular::reconstruct::tests::a_fraction_inside_the_bounds_comes_back ... ok
[INFO] [stdout] test compute::modular::reconstruct::tests::an_integer_lifts_with_a_denominator_of_one ... ok
[INFO] [stdout] test compute::tests::a_thread_count_of_zero_means_the_default_pool ... ok
[INFO] [stdout] test compute::tests::a_cancelled_parallel_f4_run_stops_at_the_flag ... ok
[INFO] [stdout] test compute::tests::a_timeout_too_large_to_add_to_now_leaves_no_deadline ... ok
[INFO] [stdout] test compute::tests::an_ordinary_timeout_still_sets_a_deadline ... ok
[INFO] [stdout] test compute::tests::periodic_checks_read_cancellation_at_the_next_tick ... ok
[INFO] [stdout] test compute::modular::reconstruct::tests::a_residue_of_zero_lifts_to_zero ... ok
[INFO] [stdout] test compute::modular::reconstruct::tests::a_value_outside_the_bounds_does_not_lift_to_itself ... ok
[INFO] [stdout] test compute::signature::tests::signature_ordering_is_pot ... ok
[INFO] [stdout] test compute::tests::a_cancelled_f4_run_stops_at_the_flag ... ok
[INFO] [stdout] test compute::tests::the_verifier_limits_come_from_what_is_left_of_the_budget ... ok
[INFO] [stdout] test poly::tests::an_s_polynomial_cancels_the_lcm_term ... ok
[INFO] [stdout] test poly::tests::construction_sorts_and_merges ... ok
[INFO] [stdout] test poly::tests::grevlex_orders_by_degree_then_reverse_lex ... ok
[INFO] [stdout] test poly::tests::display_writes_the_parse_syntax ... ok
[INFO] [stdout] test poly::tests::monomial_division_and_lcm ... ok
[INFO] [stdout] test poly::tests::normal_form_reduces_completely ... ok
[INFO] [stdout] test poly::tests::terms_run_descending ... ok
[INFO] [stdout] test poly::tests::the_memory_meter_counts_the_coefficient_bytes ... ok
[INFO] [stdout] test quotient::linear::tests::rational_matrix_payload_is_reserved_before_cloning ... ok
[INFO] [stdout] test result::io::tests::reader_reports_cancellation_between_chunks ... ok
[INFO] [stdout] test result::io::tests::writer_rejects_a_chunk_before_allocation_at_a_tight_cap ... ok
[INFO] [stdout] test result::io::tests::writer_reports_cancellation_between_chunks ... ok
[INFO] [stdout] test result::io::tests::writer_reserves_a_growing_chunk_before_extending ... ok
[INFO] [stdout] test ring::field::tests::arithmetic_stays_in_the_field ... ok
[INFO] [stdout] test ring::field::tests::new_reduces_into_the_field ... ok
[INFO] [stdout] test ring::field::tests::primality_agrees_with_trial_division_below_ten_thousand ... ok
[INFO] [stdout] test ring::field::tests::primality_decides_large_moduli ... ok
[INFO] [stdout] test poly::tests::subtraction_cancels_the_leading_term ... ok
[INFO] [stdout] test compute::f4::monomial::tests::the_mask_never_rejects_a_true_divisor ... ok
[INFO] [stdout] test poly::tests::a_checked_subtraction_reports_the_tail_that_passes_the_width ... ok
[INFO] [stdout] test ring::rational::tests::a_coefficient_the_prime_divides_leaves_the_image ... ok
[INFO] [stdout] test ring::rational::tests::a_negative_coefficient_writes_the_sign_once ... ok
[INFO] [stdout] test ring::rational::tests::a_content_of_more_than_one_divides_out ... ok
[INFO] [stdout] test ring::rational::tests::clearing_multiplies_by_the_denominators_and_divides_the_content ... ok
[INFO] [stdout] test ring::rational::tests::a_result_of_zero_is_reported_as_none ... ok
[INFO] [stdout] test ring::rational::tests::arithmetic_is_exact ... ok
[INFO] [stdout] test ring::rational::tests::clearing_stops_on_an_exhausted_deadline ... ok
[INFO] [stdout] test ring::rational::tests::conversion_reduces_and_puts_the_sign_in_the_numerator ... ok
[INFO] [stdout] test ring::rational::tests::the_heap_estimate_grows_with_the_value ... ok
[INFO] [stdout] test ring::rational::tests::the_zero_polynomial_clears_to_no_term ... ok
[INFO] [stdout] test ring::tests::a_fraction_is_reduced_before_the_field_reads_it ... ok
[INFO] [stdout] test ring::tests::a_denominator_the_field_cannot_invert_is_an_error ... ok
[INFO] [stdout] test ring::tests::a_denominator_the_field_cannot_invert_stops_a_parse ... ok
[INFO] [stdout] test poly::tests::a_checked_multiply_reports_an_exponent_past_the_width ... ok
[INFO] [stdout] test ring::tests::a_modulus_above_the_bound_has_no_ring ... ok
[INFO] [stdout] test ring::tests::a_non_prime_modulus_has_no_ring ... ok
[INFO] [stdout] test ring::tests::a_rational_coefficient_holds_every_width ... ok
[INFO] [stdout] test ring::tests::a_ring_with_no_variables_holds_the_field ... ok
[INFO] [stdout] test ring::rational::tests::every_integer_width_is_a_coefficient ... ok
[INFO] [stdout] test ring::tests::a_long_coefficient_parses_without_overflow ... ok
[INFO] [stdout] test ring::tests::a_term_that_reduces_to_zero_drops_out ... ok
[INFO] [stdout] test ring::tests::a_variable_count_above_the_bound_has_no_ring ... ok
[INFO] [stdout] test ring::tests::an_exponent_vector_must_match_the_variable_count ... ok
[INFO] [stdout] test ring::tests::an_ideal_takes_only_polynomials_of_its_ring ... ok
[INFO] [stdout] test ring::tests::every_integer_width_is_a_coefficient ... ok
[INFO] [stdout] test ring::tests::parsing_ignores_whitespace_and_reads_a_leading_sign ... ok
[INFO] [stdout] test ring::tests::parsing_reads_a_fraction_over_the_rationals ... ok
[INFO] [stdout] test ring::tests::parsing_reads_the_documented_grammar ... ok
[INFO] [stdout] test ring::tests::rings_with_the_same_shape_are_the_same_ring ... ok
[INFO] [stdout] test ring::tests::parsing_reports_where_it_stops ... ok
[INFO] [stdout] test ring::tests::the_fraction_bar_takes_no_whitespace ... ok
[INFO] [stdout] test verify::algebra::tests::a_merge_tail_observes_its_deadline ... ok
[INFO] [stdout] test verify::algebra::tests::a_product_above_the_budget_is_rejected_before_it_allocates ... ok
[INFO] [stdout] test ring::tests::parsing_adds_repeated_variables_and_monomials ... ok
[INFO] [stdout] test verify::algebra::tests::a_product_the_caller_cannot_hold_beside_its_own_buffers_is_rejected ... ok
[INFO] [stdout] test verify::algebra::tests::a_sum_above_the_budget_is_rejected_before_it_allocates ... ok
[INFO] [stdout] test verify::algebra::tests::a_sum_is_charged_for_its_arguments_as_well_as_for_itself ... ok
[INFO] [stdout] test ring::tests::variable_names_must_be_distinct_and_well_formed ... ok
[INFO] [stdout] test verify::algebra::tests::a_product_that_collapses_gives_back_the_buffer_it_reserved ... ok
[INFO] [stdout] test verify::algebra::tests::grevlex_prefers_degree ... ok
[INFO] [stdout] test verify::algebra::tests::inverse_returns_the_field_inverse ... ok
[INFO] [stdout] test verify::algebra::tests::primality_matches_trial_division ... ok
[INFO] [stdout] test verify::algebra::tests::product_merges_and_drops_cancelling_terms ... ok
[INFO] [stdout] test verify::algebra::tests::product_of_a_polynomial_with_its_negative_is_zero ... ok
[INFO] [stdout] test verify::algebra::tests::grevlex_puts_the_last_variable_last ... ok
[INFO] [stdout] test ring::tests::a_normalized_fraction_carries_the_sign_in_its_numerator ... ok
[INFO] [stdout] test ring::tests::a_zero_denominator_in_text_stops_the_parser ... ok
[INFO] [stdout] test verify::algebra::tests::spoly_of_a_pair_with_equal_multiples_is_zero ... ok
[INFO] [stdout] test verify::algebra::tests::grevlex_breaks_ties_by_reversed_scan ... ok
[INFO] [stdout] test verify::checks::tests::a_composite_modulus_is_named_composite ... ok
[INFO] [stdout] test verify::checks::tests::a_duplicate_monomial_is_rejected ... ok
[INFO] [stdout] test verify::algebra::tests::spoly_cancels_the_leading_terms ... ok
[INFO] [stdout] test verify::checks::tests::a_reducible_tail_is_rejected ... ok
[INFO] [stdout] test verify::checks::tests::a_redundant_leading_monomial_is_rejected ... ok
[INFO] [stdout] test verify::checks::tests::a_non_monic_element_is_rejected ... ok
[INFO] [stdout] test verify::json::tests::decodes_a_canonical_object ... ok
[INFO] [stdout] test verify::json::tests::rejects_a_leading_zero ... ok
[INFO] [stdout] test verify::checks::tests::an_unsorted_basis_is_rejected ... ok
[INFO] [stdout] test verify::checks::tests::nvars_above_the_range_is_rejected ... ok
[INFO] [stdout] test verify::json::tests::rejects_a_float ... ok
[INFO] [stdout] test verify::json::tests::rejects_a_sign ... ok
[INFO] [stdout] test verify::json::tests::rejects_an_exponent_part ... ok
[INFO] [stdout] test verify::json::tests::rejects_empty_bytes ... ok
[INFO] [stdout] test verify::json::tests::rejects_an_exponent_above_the_contract_range ... ok
[INFO] [stdout] test verify::json::tests::reports_the_offset_of_the_fault ... ok
[INFO] [stdout] test verify::limits::tests::a_size_that_overflows_is_above_every_budget ... ok
[INFO] [stdout] test verify::limits::tests::a_ticker_polls_the_deadline_once_every_stride ... ok
[INFO] [stdout] test verify::json::tests::rejects_whitespace ... ok
[INFO] [stdout] test verify::limits::tests::a_passed_deadline_stops_the_work ... ok
[INFO] [stdout] test verify::limits::tests::a_wider_ring_prices_the_same_term_count_higher ... ok
[INFO] [stdout] test verify::limits::tests::no_deadline_never_stops_the_work ... ok
[INFO] [stdout] test verify::limits::tests::the_budget_admits_buffers_up_to_its_cap ... ok
[INFO] [stdout] test verify::tests::a_deadline_passed_during_the_last_check_still_stops_acceptance ... ok
[INFO] [stdout] test verify::tests::v2_conversion_checks_cancellation_after_the_obligations ... ok
[INFO] [stdout] test verify::tests::verify_accepts_the_unit_ideal_certificate ... ok
[INFO] [stdout] test verify::tests::verify_names_the_basis_element_of_a_failed_origin_identity ... ok
[INFO] [stdout] test verify::v2::arith::tests::a_product_match_checks_overflow_after_a_mismatch ... ok
[INFO] [stdout] test verify::v2::arith::tests::a_product_match_reports_the_product ... ok
[INFO] [stdout] test verify::v2::arith::tests::a_product_past_the_exponent_bound_is_a_rejection ... ok
[INFO] [stdout] test verify::json::tests::rejects_an_integer_above_64_bits ... ok
[INFO] [stdout] test verify::v2::arith::tests::divisibility_reads_the_sparse_support ... ok
[INFO] [stdout] test verify::v2::arith::tests::grevlex_prefers_the_larger_degree ... ok
[INFO] [stdout] test verify::v2::arith::tests::grevlex_puts_the_first_variable_above_the_last ... ok
[INFO] [stdout] test verify::v2::arith::tests::owned_add_matches_the_borrowed_merge ... ok
[INFO] [stdout] test verify::v2::arith::tests::owned_sub_matches_the_borrowed_subtraction ... ok
[INFO] [stdout] test verify::tests::verify_reports_exhaustion_apart_from_invalidity ... ok
[INFO] [stdout] test verify::limits::tests::the_budget_rejects_buffers_above_its_cap ... ok
[INFO] [stdout] test verify::v2::arith::tests::primality_matches_trial_division ... ok
[INFO] [stdout] test verify::v2::arith::tests::subtraction_cancels_equal_polynomials ... ok
[INFO] [stdout] test verify::v2::arith::tests::lcm_and_divide_invert_each_other ... ok
[INFO] [stdout] test verify::v2::arith::tests::the_identity_monomial_is_below_every_other ... ok
[INFO] [stdout] test verify::v2::arith::tests::scaled_owned_add_matches_scale_then_add ... ok
[INFO] [stdout] test verify::v2::arith::tests::shared_variables_decide_the_product_criterion ... ok
[INFO] [stdout] test compute::tests::the_limits_of_a_call_give_the_basis_the_options_give ... ok
[INFO] [stdout] test verify::limits::tests::live_storage_overflow_reports_the_live_cap ... ok
[INFO] [stdout] test compute::tests::one_deadline_covers_the_engine_the_writer_and_the_verifier ... FAILED
[INFO] [stdout] test compute::f4::monomial::tests::matches_the_reference_at_every_width ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- compute::tests::one_deadline_covers_the_engine_the_writer_and_the_verifier stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'compute::tests::one_deadline_covers_the_engine_the_writer_and_the_verifier' (2601) panicked at src/compute/mod.rs:1230:21:
[INFO] [stdout] the whole call stops at one deadline: 40.871183ms against 25.175942ms
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f79e3cd8c11 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5f79e3cee0ea - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    2:     0x5f79e3cdd3dc - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5f79e3cb3896 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5f79e3cd0f79 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]    5:     0x5f79e3c3cff0 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]    6:     0x5f79e3cd12a2 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5f79e3cb3942 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5f79e3cac509 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5f79e3cb454d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]   10:     0x5f79e3cee84c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5f79e3b350d5 - <sylvester[c75fd17400341629]::compute::tests::one_deadline_covers_the_engine_the_writer_and_the_verifier::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   12:     0x5f79e3c3043b - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]   13:     0x5f79e3c3d615 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]   14:     0x5f79e3c36f04 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]   15:     0x5f79e3c406a2 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   16:     0x5f79e3cd845f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   17:     0x7115bf29bdfa - <unknown>
[INFO] [stdout]   18:     0x7115bf32f3d4 - clone
[INFO] [stdout]   19:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     compute::tests::one_deadline_covers_the_engine_the_writer_and_the_verifier
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 244 passed; 1 failed; 2 ignored; 0 measured; 0 filtered out; finished in 0.18s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "d1bd0296698f304ce9449abbd31279c96b5e95da577cc82f79e07b69c601dfc8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d1bd0296698f304ce9449abbd31279c96b5e95da577cc82f79e07b69c601dfc8", kill_on_drop: false }`
[INFO] [stdout] d1bd0296698f304ce9449abbd31279c96b5e95da577cc82f79e07b69c601dfc8
