[INFO] fetching crate spg-storage 9.1.0...
[INFO] testing spg-storage-9.1.0 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate spg-storage 9.1.0 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate spg-storage 9.1.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate spg-storage 9.1.0
[INFO] tweaked toml for crates.io crate spg-storage 9.1.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate spg-storage 9.1.0 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 spg-storage 9.1.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.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 spg-crypto v9.1.0
[INFO] [stderr]   Downloaded spg-sql v9.1.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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] 9711510679a656acac7000b80f2e6f11065e1c9e2893e7669939d107b85de5fc
[INFO] running `Command { std: "docker" "start" "9711510679a656acac7000b80f2e6f11065e1c9e2893e7669939d107b85de5fc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9711510679a656acac7000b80f2e6f11065e1c9e2893e7669939d107b85de5fc", 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" "9711510679a656acac7000b80f2e6f11065e1c9e2893e7669939d107b85de5fc" "/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" "9711510679a656acac7000b80f2e6f11065e1c9e2893e7669939d107b85de5fc", 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" "9711510679a656acac7000b80f2e6f11065e1c9e2893e7669939d107b85de5fc" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling spg-crypto v9.1.0
[INFO] [stderr]    Compiling bumpalo v3.20.3
[INFO] [stderr]    Compiling spg-sql v9.1.0
[INFO] [stderr]    Compiling spg-storage v9.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 54.68s
[INFO] running `Command { std: "docker" "inspect" "9711510679a656acac7000b80f2e6f11065e1c9e2893e7669939d107b85de5fc", 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" "9711510679a656acac7000b80f2e6f11065e1c9e2893e7669939d107b85de5fc" "/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 syn v2.0.118
[INFO] [stderr]    Compiling zerocopy v0.8.54
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling regex-automata v0.4.15
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling serde_json v1.0.150
[INFO] [stderr]    Compiling is-terminal v0.4.17
[INFO] [stderr]    Compiling criterion-plot v0.5.0
[INFO] [stderr]    Compiling clap v4.6.1
[INFO] [stderr]    Compiling regex v1.13.0
[INFO] [stderr]    Compiling zerocopy-derive v0.8.54
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling criterion v0.5.1
[INFO] [stderr]    Compiling spg-storage v9.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1m 06s
[INFO] running `Command { std: "docker" "inspect" "9711510679a656acac7000b80f2e6f11065e1c9e2893e7669939d107b85de5fc", 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" "9711510679a656acac7000b80f2e6f11065e1c9e2893e7669939d107b85de5fc" "/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.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/spg_storage-5e42d9111fe0824d)
[INFO] [stdout] 
[INFO] [stdout] running 331 tests
[INFO] [stdout] test bignum::tests::i128_bridge_round_trips ... ok
[INFO] [stdout] test bloom::tests::from_bytes_rejects_truncated_input ... ok
[INFO] [stdout] test bloom::tests::from_bytes_rejects_bad_magic ... ok
[INFO] [stdout] test bloom::tests::libm_ln_matches_known_values ... ok
[INFO] [stdout] test bloom::tests::from_bytes_rejects_zero_num_hashes ... ok
[INFO] [stdout] test bignum::tests::sqrt_scale_and_rounding ... ok
[INFO] [stdout] test bloom::tests::from_bytes_rejects_bad_crc ... ok
[INFO] [stdout] test fts_simple::tests::collapses_runs_of_separators ... ok
[INFO] [stdout] test bloom::tests::num_bits_is_always_64_aligned ... ok
[INFO] [stdout] test bloom::tests::with_target_fp_rate_sizes_match_spec ... ok
[INFO] [stdout] test bloom::tests::insert_then_contains_returns_true_for_inserted_keys ... ok
[INFO] [stdout] test fts_simple::tests::empty_input_yields_empty ... ok
[INFO] [stdout] test fts_simple::tests::keeps_underscore_inside_word ... ok
[INFO] [stdout] test fts_simple::tests::lowercase_ascii_words ... ok
[INFO] [stdout] test halfvec::tests::f16_codec_roundtrip_finite_normals_bounded_error ... ok
[INFO] [stdout] test bignum::tests::isqrt_exact_and_floor ... ok
[INFO] [stdout] test bignum::tests::overflow_stays_big ... ok
[INFO] [stdout] test halfvec::tests::f16_overflow_saturates_to_inf ... ok
[INFO] [stdout] test jsonb_gin::tests::array_emits_array_path_tokens ... ok
[INFO] [stdout] test halfvec::tests::f16_roundtrip_inf_and_nan ... ok
[INFO] [stdout] test halfvec::tests::f16_roundtrip_representable_values ... ok
[INFO] [stdout] test jsonb_gin::tests::flat_object_emits_key_value_tokens ... ok
[INFO] [stdout] test halfvec::tests::half_vector_empty ... ok
[INFO] [stdout] test bignum::tests::fuzz_div_int_vs_i128 ... ok
[INFO] [stdout] test halfvec::tests::f16_underflow_flushes_to_zero ... ok
[INFO] [stdout] test bignum::tests::scale_align_add ... ok
[INFO] [stdout] test bignum::tests::decimal_str_round_trips ... ok
[INFO] [stdout] test halfvec::tests::half_vector_from_to_f32_slice ... ok
[INFO] [stdout] test bignum::tests::div_multi_limb ... ok
[INFO] [stdout] test jsonb_gin::tests::leaf_value_kinds_canonicalise ... ok
[INFO] [stdout] test bignum::tests::div_fixed_point ... ok
[INFO] [stdout] test persistent::tests::empty_vec_is_empty ... ok
[INFO] [stdout] test bloom::tests::to_bytes_then_from_bytes_roundtrip ... ok
[INFO] [stdout] test persistent::tests::clone_then_push_preserves_original ... ok
[INFO] [stdout] test jsonb_gin::tests::malformed_text_returns_empty ... ok
[INFO] [stdout] test jsonb_gin::tests::nested_object_uses_dotted_path ... ok
[INFO] [stdout] test persistent::tests::push_crosses_root_overflow_boundary ... ok
[INFO] [stdout] test persistent::tests::fuzz_oracle_clone_isolation ... ok
[INFO] [stdout] test persistent::tests::push_single_fits_in_tail ... ok
[INFO] [stdout] test persistent::tests::push_mut_does_not_disturb_cloned_handle ... ok
[INFO] [stdout] test persistent::tests::iter_size_hint_exact ... ok
[INFO] [stdout] test persistent::tests::set_out_of_bounds_is_none ... ok
[INFO] [stdout] test persistent::tests::push_fills_tail_then_incorporates ... ok
[INFO] [stdout] test persistent::tests::set_rewrites_element_in_tail ... ok
[INFO] [stdout] test persistent::tests::push_clone_arc_count_stays_constant_in_old_handle ... ok
[INFO] [stdout] test persistent::tests::iter_sees_its_own_handles_contents ... ok
[INFO] [stdout] test persistent::tests::iter_resumes_across_a_leaf_boundary ... ok
[INFO] [stdout] test persistent_btree::tests::empty_map_is_empty ... ok
[INFO] [stdout] test persistent_btree::tests::insert_crosses_leaf_split_boundary ... ok
[INFO] [stdout] test persistent::tests::set_rewrites_element_in_trie ... ok
[INFO] [stdout] test persistent_btree::tests::clone_then_insert_preserves_original ... ok
[INFO] [stdout] test persistent_btree::tests::iter_handles_taller_tree ... ok
[INFO] [stdout] test persistent_btree::tests::insert_single_into_empty_works ... ok
[INFO] [stdout] test persistent_btree::tests::insert_grows_through_multiple_internal_splits ... ok
[INFO] [stdout] test persistent_btree::tests::iter_rev_empty_map_returns_nothing ... ok
[INFO] [stdout] test persistent_btree::tests::insert_replace_returns_prev_keeps_len ... ok
[INFO] [stdout] test persistent_btree::tests::fuzz_oracle_clone_isolation ... ok
[INFO] [stdout] test persistent::tests::push_crosses_second_grow_boundary ... ok
[INFO] [stdout] test persistent::tests::iter_agrees_with_get_at_every_boundary ... ok
[INFO] [stdout] test persistent::tests::iter_matches_get_for_full_walk ... ok
[INFO] [stdout] test bignum::tests::fuzz_vs_i128 ... ok
[INFO] [stdout] test persistent_btree::tests::partial_eq_compares_by_elements ... ok
[INFO] [stdout] test persistent_btree::tests::iter_rev_yields_descending ... ok
[INFO] [stdout] test persistent_btree::tests::iter_yields_sorted_order ... ok
[INFO] [stdout] test persistent_btree::tests::round465_immutable_remove_does_not_touch_the_receiver ... ok
[INFO] [stdout] test persistent_btree::tests::iter_rev_handles_taller_tree ... ok
[INFO] [stdout] test persistent_btree::tests::fuzz_predecessor_against_btreemap ... ok
[INFO] [stdout] test persistent_btree::tests::range_rev_by_over_an_absent_group_is_empty ... ok
[INFO] [stdout] test persistent_btree::tests::range_basic_bounds ... ok
[INFO] [stdout] test persistent_btree::tests::round465_remove_leaves_a_shared_snapshot_untouched ... ok
[INFO] [stdout] test posting::tests::a_clone_does_not_see_later_appends ... ok
[INFO] [stdout] test posting::tests::empty_list_allocates_nothing_and_reads_empty ... ok
[INFO] [stdout] test persistent_btree::tests::round465_remove_in_reverse_order_empties_the_map ... ok
[INFO] [stdout] test persistent_btree::tests::round465_remove_absent_key_is_a_no_op ... ok
[INFO] [stdout] test posting::tests::retain_keeping_everything_leaves_the_list_alone ... ok
[INFO] [stdout] test posting::tests::retain_rebuilds_across_blocks ... ok
[INFO] [stdout] test quantize::tests::quantize_constant_vector_roundtrips_exactly ... ok
[INFO] [stdout] test posting::tests::order_and_length_survive_block_boundaries ... ok
[INFO] [stdout] test posting::tests::retain_can_empty_the_list ... ok
[INFO] [stdout] test persistent_btree::tests::range_rev_by_walks_one_group_from_its_top ... ok
[INFO] [stdout] test posting::tests::length_is_exact_at_a_block_boundary ... ok
[INFO] [stdout] test quantize::tests::quantize_empty_vector_is_zero_dim ... ok
[INFO] [stdout] test persistent_btree::tests::round465_matches_btreemap_under_mixed_traffic ... ok
[INFO] [stdout] test quantize::tests::quantize_min_and_max_endpoints_reconstruct_exactly ... ok
[INFO] [stdout] test quantize::tests::quantize_single_element_roundtrips_exactly ... ok
[INFO] [stdout] test persistent_btree::tests::round465_range_and_predecessor_still_work_after_removals ... ok
[INFO] [stdout] test persistent_btree::tests::round465_remove_every_key_empties_the_map ... ok
[INFO] [stdout] test quantize::tests::quantize_dequantize_roundtrip_bounded_error_uniform ... ok
[INFO] [stdout] test quantize::tests::sq8_distance_handles_dim_mismatch_with_infinity ... ok
[INFO] [stdout] test quantize::tests::sq8_from_bytes_rejects_truncated_header ... ok
[INFO] [stdout] test quantize::tests::sq8_from_bytes_rejects_dim_mismatch ... ok
[INFO] [stdout] test persistent::tests::fuzz_oracle_push_mut_against_vec_u64 ... ok
[INFO] [stdout] test quantize::tests::sq8_cosine_handles_zero_norm_with_infinity ... ok
[INFO] [stdout] test row_header::tests::deleted_row_header_reports_deletion ... ok
[INFO] [stdout] test row_header::tests::frozen_header_is_all_visible ... ok
[INFO] [stdout] test row_header::tests::observe_persisted_version_advances_cursor_past_restored_rows ... ok
[INFO] [stdout] test row_header::tests::version_counter_is_monotonic ... ok
[INFO] [stdout] test row_header::tests::version_counter_starts_above_frozen ... ok
[INFO] [stdout] test row_locator::tests::cold_constructs_and_inspects ... ok
[INFO] [stdout] test row_locator::tests::encoded_len_is_constant ... ok
[INFO] [stdout] test row_locator::tests::from_legacy_v8_u64_wraps_as_hot ... ok
[INFO] [stdout] test row_locator::tests::hot_constructs_and_inspects ... ok
[INFO] [stdout] test row_locator::tests::mixed_concat_decodes_in_sequence ... ok
[INFO] [stdout] test persistent_btree::tests::range_rev_by_is_lazy ... ok
[INFO] [stdout] test row_locator::tests::read_le_rejects_bad_tag ... ok
[INFO] [stdout] test row_header::tests::alive_header_is_not_fast_visible_until_frozen ... ok
[INFO] [stdout] test row_locator::tests::read_le_rejects_truncated_cold ... ok
[INFO] [stdout] test row_locator::tests::read_le_rejects_empty_input ... ok
[INFO] [stdout] test row_locator::tests::roundtrip_cold_via_write_le_read_le ... ok
[INFO] [stdout] test row_locator::tests::read_le_rejects_truncated_hot ... ok
[INFO] [stdout] test row_locator::tests::roundtrip_hot_via_write_le_read_le ... ok
[INFO] [stdout] test segment::tests::brin_summaries_derive_matches_per_page_pk_ranges ... ok
[INFO] [stdout] test segment::tests::encode_rejects_bad_page_size ... ok
[INFO] [stdout] test segment::tests::encode_rejects_empty_input ... ok
[INFO] [stdout] test segment::tests::encode_rejects_unsorted_keys ... ok
[INFO] [stdout] test row_locator::tests::size_is_16_bytes ... ok
[INFO] [stdout] test segment::tests::encode_then_open_roundtrips_meta ... ok
[INFO] [stdout] test segment::tests::legacy_v1_segments_still_load_via_from_bytes ... ok
[INFO] [stdout] test segment::tests::lookup_finds_every_inserted_key ... ok
[INFO] [stdout] test segment::tests::large_payload_becomes_a_jumbo_page_and_reads_back ... ok
[INFO] [stdout] test segment::tests::lookup_returns_none_for_unknown_key ... ok
[INFO] [stdout] test segment::tests::might_contain_short_circuits_out_of_range ... ok
[INFO] [stdout] test segment::tests::open_rejects_bad_crc ... ok
[INFO] [stdout] test segment::tests::open_rejects_bad_magic ... ok
[INFO] [stdout] test segment::tests::owned_segment_lookup_returns_none_for_missing_key ... ok
[INFO] [stdout] test segment::tests::owned_segment_lookup_matches_reader_for_every_key ... ok
[INFO] [stdout] test segment::tests::owned_segment_might_contain_matches_reader ... ok
[INFO] [stdout] test segment::tests::owned_segment_rejects_bad_bytes_at_construction ... ok
[INFO] [stdout] test segment::tests::scan_yields_rows_in_key_order ... ok
[INFO] [stdout] test segment::tests::v2_envelope_invalid_algo_byte_errors_loudly ... ok
[INFO] [stdout] test segment::tests::segment_without_brin_sidecar_returns_empty_summaries ... ok
[INFO] [stdout] test segment::tests::v2_envelope_with_compress_false_is_v1_passthrough ... ok
[INFO] [stdout] test snapshot::tests::aborted_xmax_revives_the_row ... ok
[INFO] [stdout] test snapshot::tests::aborted_xmin_hides_the_row ... ok
[INFO] [stdout] test snapshot::tests::all_committed_oracle_matches_plain_visible ... ok
[INFO] [stdout] test snapshot::tests::frozen_row_skips_the_oracle ... ok
[INFO] [stdout] test snapshot::tests::in_progress_set_binary_search_correctness ... ok
[INFO] [stdout] test snapshot::tests::reader_sees_its_own_insert_but_not_its_own_delete ... ok
[INFO] [stdout] test persistent_btree::tests::iter_rev_lazy_stops_at_take ... ok
[INFO] [stdout] test snapshot::tests::snapshot_hides_future_deletion_done_by_in_flight_tx ... ok
[INFO] [stdout] test snapshot::tests::snapshot_hides_future_writes ... ok
[INFO] [stdout] test snapshot::tests::snapshot_hides_committed_deletions ... ok
[INFO] [stdout] test snapshot::tests::snapshot_keeps_pending_deletions_visible ... ok
[INFO] [stdout] test persistent_btree::tests::fuzz_range_against_btreemap ... ok
[INFO] [stdout] test tests::a_catalog_clone_shares_its_tables_until_one_is_written ... ok
[INFO] [stdout] test snapshot::tests::snapshot_hides_in_progress_writes ... ok
[INFO] [stdout] test snapshot::tests::unbounded_snapshot_sees_everything ... ok
[INFO] [stdout] test tests::a_pre_v97_catalog_has_its_timetz_index_rebuilt_on_load ... ok
[INFO] [stdout] test tests::add_index_dup_name_rejected ... ok
[INFO] [stdout] test tests::add_index_builds_from_existing_rows ... ok
[INFO] [stdout] test tests::arena_clone_into_round_trip_copy_and_nested_variants ... ok
[INFO] [stdout] test tests::add_index_unknown_column_rejected ... ok
[INFO] [stdout] test tests::a_numeric_column_leads_a_composite ... ok
[INFO] [stdout] test tests::arena_clone_into_round_trip_heap_variants ... ok
[INFO] [stdout] test tests::catalog_create_table_then_lookup ... ok
[INFO] [stdout] test tests::catalog_drain_redo_replays_multi_table ... ok
[INFO] [stdout] test tests::catalog_duplicate_table_is_rejected ... ok
[INFO] [stdout] test tests::catalog_get_mut_independent_per_table ... ok
[INFO] [stdout] test tests::check_validated_flag_round_trips ... ok
[INFO] [stdout] test tests::commit_freeze_slices_empty_is_noop ... ok
[INFO] [stdout] test quantize::tests::sq8_serde_roundtrip_preserves_all_fields ... ok
[INFO] [stdout] test tests::check_constraint_size_is_pinned ... ok
[INFO] [stdout] test tests::commit_freeze_slices_rejects_gap ... ok
[INFO] [stdout] test tests::commit_freeze_slices_single_slice_matches_freeze_oldest ... ok
[INFO] [stdout] test tests::arena_row_clone_into_then_into_owned_round_trip ... ok
[INFO] [stdout] test tests::commit_freeze_slices_two_slices_match_single_slice ... ok
[INFO] [stdout] test tests::compact_is_noop_below_two_candidates ... ok
[INFO] [stdout] test tests::compact_swap_survives_catalog_roundtrip_via_load_at ... ok
[INFO] [stdout] test tests::compact_merges_small_segments_storage_unit ... ok
[INFO] [stdout] test segment::tests::brin_sidecar_round_trips_through_v2_envelope ... ok
[INFO] [stdout] test tests::composite_btree_tracks_every_mutation_and_survives_a_snapshot ... ok
[INFO] [stdout] test tests::composite_conversion_and_drop_column_extras_shift ... ok
[INFO] [stdout] test tests::cross_checkpoint_tombstone_resolves_after_snapshot_restore ... ok
[INFO] [stdout] test tests::compact_drops_shadowed_cold_rows ... ok
[INFO] [stdout] test tests::datatype_display_matches_pg_keyword ... ok
[INFO] [stdout] test tests::deserialize_rejects_bad_magic ... ok
[INFO] [stdout] test tests::deserialize_rejects_trailing_garbage ... ok
[INFO] [stdout] test tests::deserialize_rejects_truncated_file ... ok
[INFO] [stdout] test tests::freeze_keeps_remaining_hot_rows_addressable_via_secondary_index ... ok
[INFO] [stdout] test tests::freeze_oldest_to_cold_rejects_invalid_input ... ok
[INFO] [stdout] test tests::freeze_oldest_to_cold_rejects_non_integer_pk ... ok
[INFO] [stdout] test tests::concurrent_clones_mint_disjoint_rowids ... ok
[INFO] [stdout] test tests::freeze_oldest_to_cold_moves_rows_and_keeps_lookups_working ... ok
[INFO] [stdout] test tests::escaped_string_codec_round_trips_large_text ... ok
[INFO] [stdout] test tests::deserialize_rejects_unsupported_version ... ok
[INFO] [stdout] test tests::freeze_twice_preserves_prior_cold_locators ... ok
[INFO] [stdout] test tests::half_catalog_serialise_roundtrip_preserves_cells_and_index ... ok
[INFO] [stdout] test tests::hnsw_level_assignment_is_deterministic ... ok
[INFO] [stdout] test tests::hnsw_search_matches_brute_force_for_l2_top1 ... ok
[INFO] [stdout] test tests::hot_bytes_grows_on_insert_and_matches_encoded_sum ... ok
[INFO] [stdout] test tests::hot_bytes_round_trips_through_serialize_deserialize ... ok
[INFO] [stdout] test tests::hot_bytes_shrinks_on_delete ... ok
[INFO] [stdout] test tests::index_key_round_trips_large_text ... ok
[INFO] [stdout] test tests::index_survives_serialize_deserialize_round_trip ... ok
[INFO] [stdout] test tests::insert_after_create_index_updates_it ... ok
[INFO] [stdout] test tests::load_segment_bytes_at_pads_and_rejects_collision ... ok
[INFO] [stdout] test tests::load_segment_bytes_rejects_garbage ... ok
[INFO] [stdout] test tests::load_segment_bytes_returns_sequential_ids ... ok
[INFO] [stdout] test tests::lookup_by_pk_finds_row_via_hot_index ... ok
[INFO] [stdout] test tests::lookup_by_pk_mixes_hot_and_cold_tiers ... ok
[INFO] [stdout] test tests::lookup_by_pk_resolves_cold_locator_via_loaded_segment ... ok
[INFO] [stdout] test tests::lookup_by_pk_returns_none_when_key_missing ... ok
[INFO] [stdout] test tests::mysql_ci_fold_tests::accents_strip_to_the_base ... ok
[INFO] [stdout] test tests::mysql_ci_fold_tests::ascii_and_unknown_scripts_pass_through ... ok
[INFO] [stdout] test tests::hnsw_layer_0_dominates_population ... ok
[INFO] [stdout] test tests::mysql_ci_fold_tests::case_folds ... ok
[INFO] [stdout] test tests::mysql_ci_fold_tests::ligatures_expand ... ok
[INFO] [stdout] test tests::hot_bytes_diffs_on_update_for_variable_width_columns ... ok
[INFO] [stdout] test tests::mysql_ci_fold_tests::words_measured_on_mariadb ... ok
[INFO] [stdout] test tests::nsw_index_topology_persists_through_round_trip ... ok
[INFO] [stdout] test tests::null_or_float_values_are_not_indexed ... ok
[INFO] [stdout] test tests::numeric_index_key::bytea_orders_bytewise ... ok
[INFO] [stdout] test tests::numeric_index_key::distinct_values_stay_distinct ... ok
[INFO] [stdout] test tests::numeric_index_key::a_column_typed_key_lands_in_the_columns_space ... ok
[INFO] [stdout] test tests::nsw_clone_is_o1 ... ok
[INFO] [stdout] test tests::numeric_index_key::one_value_at_several_scales_is_one_key ... ok
[INFO] [stdout] test tests::numeric_index_key::pg18_ordering ... ok
[INFO] [stdout] test tests::numeric_index_key::the_codec_round_trips_and_refuses_non_canonical ... ok
[INFO] [stdout] test tests::partition_bound_minvalue_maxvalue_round_trip ... ok
[INFO] [stdout] test persistent::tests::fuzz_oracle_against_vec_u64 ... ok
[INFO] [stdout] test tests::partition_role_all_three_variants_round_trip ... ok
[INFO] [stdout] test tests::partition_role_none_round_trips ... ok
[INFO] [stdout] test tests::plain_u16_bytea_len_ffff_decodes_under_v46_rules ... ok
[INFO] [stdout] test tests::numeric_index_key::equal_keys_compare_equal_and_unequal_ones_do_not ... ok
[INFO] [stdout] test tests::plain_u16_len_ffff_decodes_under_old_rules ... ok
[INFO] [stdout] test tests::promote_and_shadow_reject_invalid_inputs ... ok
[INFO] [stdout] test tests::promote_cold_row_pulls_frozen_row_back_to_hot_tier ... ok
[INFO] [stdout] test tests::promote_cold_row_returns_none_when_key_is_not_cold ... ok
[INFO] [stdout] test tests::pruned_decode_agrees_with_the_full_decode_and_ends_in_the_same_place ... ok
[INFO] [stdout] test tests::rederive_loses_nothing ... ok
[INFO] [stdout] test tests::redo_apply_matches_direct_position_ops ... ok
[INFO] [stdout] test tests::redo_capture_replays_to_identical_state ... ok
[INFO] [stdout] test tests::redo_log_codec_round_trips ... ok
[INFO] [stdout] test tests::redo_log_old_format_decodes_and_replays_identically ... ok
[INFO] [stdout] test tests::redo_tombstone_survives_replay_hidden_from_snapshot ... ok
[INFO] [stdout] test tests::redo_update_tombstone_plus_insert_survives_replay ... ok
[INFO] [stdout] test tests::register_cold_locators_rejects_nsw_index ... ok
[INFO] [stdout] test tests::relid_assigned_monotonic_by_create_table ... ok
[INFO] [stdout] test tests::restored_rows_are_visible_to_a_fresh_snapshot ... ok
[INFO] [stdout] test tests::rls_policies_round_trip ... ok
[INFO] [stdout] test tests::row_body_encoded_len_matches_actual_encode_for_all_types ... ok
[INFO] [stdout] test tests::row_len_and_emptiness ... ok
[INFO] [stdout] test tests::promote_then_refreeze_does_not_leave_orphan_locators ... ok
[INFO] [stdout] test tests::rowid_monotonic_survives_delete_and_never_reused ... ok
[INFO] [stdout] test tests::serialize_empty_catalog_round_trips ... ok
[INFO] [stdout] test tests::serialize_single_empty_table_round_trips ... ok
[INFO] [stdout] test tests::serialize_table_with_rows_round_trips ... ok
[INFO] [stdout] test tests::shadow_cold_row_removes_cold_locators_and_drops_lookup ... ok
[INFO] [stdout] test tests::shadow_cold_row_returns_zero_when_key_is_not_cold ... ok
[INFO] [stdout] test tests::serialize_multiple_tables_round_trips ... ok
[INFO] [stdout] test tests::snapshot_round_trips_large_bytea_and_text_array_element ... ok
[INFO] [stdout] test tests::segment_v3_round_trips_large_text_rows ... ok
[INFO] [stdout] test tests::sq8_value_reports_sq8_data_type ... ok
[INFO] [stdout] test tests::sq8_catalog_serialise_roundtrip_preserves_cells_and_index ... ok
[INFO] [stdout] test tests::table_insert_happy_path_appends_row ... ok
[INFO] [stdout] test tests::table_insert_null_into_not_null_rejected ... ok
[INFO] [stdout] test tests::table_insert_null_into_nullable_ok ... ok
[INFO] [stdout] test tests::table_insert_type_mismatch_reports_column ... ok
[INFO] [stdout] test tests::table_schema_column_position ... ok
[INFO] [stdout] test tests::the_five_new_arrays_survive_a_catalog_round_trip ... ok
[INFO] [stdout] test tests::table_insert_arity_mismatch ... ok
[INFO] [stdout] test tests::truncated_mvcc_appendix_errors_cleanly ... ok
[INFO] [stdout] test tests::tx_writeset::extract_and_replay_round_trip_onto_fresher_clone ... ok
[INFO] [stdout] test tests::tx_writeset::replay_reports_conflicts_and_is_idempotent ... ok
[INFO] [stdout] test tests::tx_writeset::replay_tombstone_survives_slot_shift ... ok
[INFO] [stdout] test tests::numeric_index_key::the_big_representation_lands_on_the_same_key ... ok
[INFO] [stdout] test tests::tx_writeset::rowid_lookup_survives_out_of_order_tail ... ok
[INFO] [stdout] test tests::snapshot_round_trips_megabyte_text_row ... ok
[INFO] [stdout] test tests::update_row_duplicate_key_moves_only_target_position ... ok
[INFO] [stdout] test tests::update_row_indexed_column_moves_entry ... ok
[INFO] [stdout] test tests::v52_snapshot_without_mvcc_appendix_loads_frozen_and_dense ... ok
[INFO] [stdout] test tests::update_row_null_transition_on_indexed_nullable_column ... ok
[INFO] [stdout] test tests::v54_snapshot_crc_detects_corruption ... ok
[INFO] [stdout] test tests::v53_roundtrip_preserves_mixed_headers_and_rowids ... ok
[INFO] [stdout] test tests::v66_roundtrip_preserves_sequence_schema_and_database_acls ... ok
[INFO] [stdout] test tests::v63_roundtrip_preserves_user_composite_type_binding ... ok
[INFO] [stdout] test tests::v64_roundtrip_preserves_owner_and_acl ... ok
[INFO] [stdout] test segment::tests::v2_envelope_round_trips_byte_equal ... ok
[INFO] [stdout] test tests::v7_37_15_end_to_end_mvcc_lifecycle ... ok
[INFO] [stdout] test tests::update_row_non_indexed_column_keeps_index_intact ... ok
[INFO] [stdout] test tests::v67_roundtrip_preserves_function_owner_and_acl ... ok
[INFO] [stdout] test tests::v7_37_15_fresh_inserts_default_to_frozen_header ... ok
[INFO] [stdout] test tests::v68_overloads_are_separate_functions_with_separate_acls ... ok
[INFO] [stdout] test persistent_btree::tests::fuzz_oracle_against_std_btreemap ... ok
[INFO] [stdout] test bignum::tests::fuzz_isqrt_vs_i128 ... ok
[INFO] [stdout] test tests::v7_37_15_headers_stay_lock_step_with_rows ... ok
[INFO] [stdout] test tests::v7_37_15_phase_b_scan_visible_filters_correctly ... ok
[INFO] [stdout] test tests::v7_37_15_phase_c_frozen_xmin_short_circuits_to_legacy_insert ... ok
[INFO] [stdout] test tests::v7_37_15_phase_c_insert_with_xmin_stamps_header ... ok
[INFO] [stdout] test tests::v88_a_table_with_no_collation_pays_two_bytes ... ok
[INFO] [stdout] test tests::v88_collation_name_survives_serialize_deserialize ... ok
[INFO] [stdout] test tests::v9_catalog_round_trip_preserves_cold_locators ... ok
[INFO] [stdout] test tests::value_type_tag_matches_variant ... ok
[INFO] [stdout] test tests::vector_column_insert_dim_mismatch_rejected ... ok
[INFO] [stdout] test tests::v7_37_15_phase_d_is_all_visible_tracks_mvcc_writers ... ok
[INFO] [stdout] test tests::v7_37_15_phase_c_mark_row_deleted_writes_xmax ... ok
[INFO] [stdout] test tests::v7_37_15_phase_d_vacuum_reclaims_only_safe_rows ... ok
[INFO] [stdout] test tests::v7_37_15_phase_d_vacuum_all_aggregates_per_table ... ok
[INFO] [stdout] test tests::v7_37_15_phase_c_repeated_delete_preserves_original_xmax ... ok
[INFO] [stdout] test tests::vector_column_insert_matching_dim_ok ... ok
[INFO] [stdout] test tests::v8_catalog_decodes_as_all_hot_under_v9_reader ... ok
[INFO] [stdout] test tests::vector_value_data_type_carries_dim ... ok
[INFO] [stdout] test trgm::tests::like_pattern_splits_at_a_separator ... ok
[INFO] [stdout] test trgm::tests::like_pattern_unanchored_short_run ... ok
[INFO] [stdout] test trgm::tests::multi_word_splits_on_space ... ok
[INFO] [stdout] test trgm::tests::padding_and_lowercase ... ok
[INFO] [stdout] test trgm::tests::similarity_disjoint ... ok
[INFO] [stdout] test trgm::tests::similarity_identical ... ok
[INFO] [stdout] test trgm::tests::similarity_reaches_wide_characters ... ok
[INFO] [stdout] test trgm::tests::wide_characters_are_hashed_the_way_pg_hashes_them ... ok
[INFO] [stdout] test trgm::tests::word_similarity_pays_for_a_gap_inside_the_extent ... ok
[INFO] [stdout] test trgm::tests::word_similarity_scores_the_best_extent ... ok
[INFO] [stdout] test trgm::tests::word_similarity_without_a_match_is_zero ... ok
[INFO] [stdout] test vacuum::tests::alive_row_is_not_reclaimable ... ok
[INFO] [stdout] test vacuum::tests::deleted_row_is_not_reclaimable_while_snapshot_could_still_see_it ... ok
[INFO] [stdout] test vacuum::tests::deleted_row_is_reclaimable_when_xmax_older_than_oldest_active ... ok
[INFO] [stdout] test vacuum::tests::report_merge_aggregates_counters ... ok
[INFO] [stdout] test tests::vector_value_survives_catalog_round_trip ... ok
[INFO] [stdout] test trgm::tests::apostrophe_is_a_separator ... ok
[INFO] [stdout] test trgm::tests::like_pattern_anchored ... ok
[INFO] [stdout] test trgm::tests::like_pattern_no_usable_constraint ... ok
[INFO] [stdout] test trgm::tests::like_pattern_escaped_wildcard_is_still_a_separator ... ok
[INFO] [stdout] test bloom::tests::fuzz_oracle_fp_rate_under_target_x_1_2 ... ok
[INFO] [stdout] test tests::hnsw_sq8_recall_at_10_above_0_95_vs_f32_groundtruth ... ok
[INFO] [stdout] test tests::hnsw_half_recall_at_10_matches_f32_groundtruth ... ok
[INFO] [stdout] test quantize::tests::quantize_dequantize_roundtrip_bounded_error_gaussian ... ok
[INFO] [stdout] test quantize::tests::sq8_recall_at_10_above_0_95_gaussian ... ok
[INFO] [stdout] test quantize::tests::sq8_recall_at_10_above_0_93_uniform_unit_sphere ... ok
[INFO] [stdout] test quantize::tests::sq8_cosine_distance_matches_dequantize_then_f32 ... ok
[INFO] [stdout] test quantize::tests::sq8_inner_product_matches_dequantize_then_f32 ... ok
[INFO] [stdout] test quantize::tests::sq8_l2_distance_matches_dequantize_then_f32 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 331 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.19s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/perf_gate.rs (/opt/rustwide/target/release/deps/perf_gate-a771dbc847044d30)
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test pv_get_random_under_100ns_avg ... FAILED
[INFO] [stdout] test catalog_roundtrip_100rows_under_budget ... ok
[INFO] [stdout] test hnsw_search_under_budget ... ok
[INFO] [stdout] test cosine_dim128_under_50ns ... ok
[INFO] [stdout] test bloom_insert_1m_under_100ms ... ok
[INFO] [stdout] test bloom_fp_rate_under_1pct ... ok
[INFO] [stdout] test gin_trgm_append_does_not_recopy_the_posting_list ... ok
[INFO] [stdout] test segment_lookup_p99_under_500us ... ok
[INFO] [stdout] test inner_product_dim128_under_50ns ... ok
[INFO] [stdout] test pb_insert_mut_100k_under_50ms ... ok
[INFO] [stdout] test pv_push_1m_under_200ms ... FAILED
[INFO] [stdout] test pv_push_mut_1m_under_50ms ... ok
[INFO] [stdout] test segment_write_1m_under_2s ... ok
[INFO] [stdout] test sq8_adc_l2_asymmetric_neon_dim128_under_50ns ... ok
[INFO] [stdout] test sq8_adc_l2_asymmetric_under_200ns_per_pair ... ok
[INFO] [stdout] test sq8_adc_l2_under_200ns_per_pair ... FAILED
[INFO] [stdout] test sq8_quantize_1m_under_500ms ... ok
[INFO] [stdout] test sq8_recall_at_10_above_0_95_perf_gate ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- pv_get_random_under_100ns_avg stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'pv_get_random_under_100ns_avg' (1032) panicked at tests/perf_gate.rs:296:5:
[INFO] [stdout] pv_get_random avg 155 ns exceeds budget 100 ns
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x61e574f76d31 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x61e574f8bdaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x61e574f7b1cc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x61e574f53276 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x61e574f6f3e9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x61e574e5e700 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x61e574f6f5a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x61e574f53322 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x61e574f4c0a9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x61e574f53f1d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x61e574f8c4dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x61e574e3c4e2 - <perf_gate[7c9e26a23a7f0a48]::pv_get_random_under_100ns_avg::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   12:     0x61e574e519eb - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   13:     0x61e574e5f055 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   14:     0x61e574e58914 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   15:     0x61e574e621b2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   16:     0x61e574f76609 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   17:     0x7c86d1571dfa - <unknown>
[INFO] [stdout]   18:     0x7c86d16053d4 - clone
[INFO] [stdout]   19:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- pv_push_1m_under_200ms stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'pv_push_1m_under_200ms' (1033) panicked at tests/perf_gate.rs:206:5:
[INFO] [stdout] pv_push_1m elapsed 226 ms exceeds budget 200 ms
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x61e574f76d31 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x61e574f8bdaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x61e574f7b1cc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x61e574f53276 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x61e574f6f3e9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x61e574e5e700 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x61e574f6f5a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x61e574f53322 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x61e574f4c0a9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x61e574f53f1d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x61e574f8c4dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x61e574e39156 - <perf_gate[7c9e26a23a7f0a48]::pv_push_1m_under_200ms::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   12:     0x61e574e519eb - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   13:     0x61e574e5f055 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   14:     0x61e574e58914 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   15:     0x61e574e621b2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   16:     0x61e574f76609 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   17:     0x7c86d1571dfa - <unknown>
[INFO] [stdout]   18:     0x7c86d16053d4 - clone
[INFO] [stdout]   19:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sq8_adc_l2_under_200ns_per_pair stdout ----
[INFO] [stdout] sq8_adc_l2_dim128: 312 ns/pair (over 1000000 pairs)
[INFO] [stdout] 
[INFO] [stdout] thread 'sq8_adc_l2_under_200ns_per_pair' (1039) panicked at tests/perf_gate.rs:568:5:
[INFO] [stdout] sq8_adc_l2_dim128 per-pair 312 ns exceeds budget 250 ns
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x61e574f76d31 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x61e574f8bdaa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x61e574f7b1cc - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x61e574f53276 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x61e574f6f3e9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x61e574e5e700 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x61e574f6f5a2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x61e574f53322 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x61e574f4c0a9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x61e574f53f1d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x61e574f8c4dc - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x61e574e3d555 - <perf_gate[7c9e26a23a7f0a48]::sq8_adc_l2_under_200ns_per_pair::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   12:     0x61e574e519eb - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   13:     0x61e574e5f055 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   14:     0x61e574e58914 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   15:     0x61e574e621b2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   16:     0x61e574f76609 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   17:     0x7c86d1571dfa - <unknown>
[INFO] [stdout]   18:     0x7c86d16053d4 - clone
[INFO] [stdout]   19:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     pv_get_random_under_100ns_avg
[INFO] [stdout]     pv_push_1m_under_200ms
[INFO] [stdout]     sq8_adc_l2_under_200ns_per_pair
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 15 passed; 3 failed; 0 ignored; 0 measured; 0 filtered out; finished in 14.52s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test perf_gate`
[INFO] running `Command { std: "docker" "inspect" "9711510679a656acac7000b80f2e6f11065e1c9e2893e7669939d107b85de5fc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9711510679a656acac7000b80f2e6f11065e1c9e2893e7669939d107b85de5fc", kill_on_drop: false }`
[INFO] [stdout] 9711510679a656acac7000b80f2e6f11065e1c9e2893e7669939d107b85de5fc
