[INFO] fetching crate fgumi-sort 0.7.0...
[INFO] testing fgumi-sort-0.7.0 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate fgumi-sort 0.7.0 into /workspace/builds/worker-3-tc2/source
[INFO] started tweaking crates.io crate fgumi-sort 0.7.0
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate fgumi-sort 0.7.0
[INFO] tweaked toml for crates.io crate fgumi-sort 0.7.0 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate fgumi-sort 0.7.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 fgumi-sort 0.7.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:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 8f60c1337141d421b9e2c1ef40c76c053f0c24b1db20b8cea2945a5b3c0f696e
[INFO] running `Command { std: "docker" "start" "8f60c1337141d421b9e2c1ef40c76c053f0c24b1db20b8cea2945a5b3c0f696e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8f60c1337141d421b9e2c1ef40c76c053f0c24b1db20b8cea2945a5b3c0f696e", 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" "8f60c1337141d421b9e2c1ef40c76c053f0c24b1db20b8cea2945a5b3c0f696e" "/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" "8f60c1337141d421b9e2c1ef40c76c053f0c24b1db20b8cea2945a5b3c0f696e", 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" "8f60c1337141d421b9e2c1ef40c76c053f0c24b1db20b8cea2945a5b3c0f696e" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling find-msvc-tools v0.1.11
[INFO] [stderr]    Compiling crossbeam-utils v0.8.22
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.20
[INFO] [stderr]    Compiling crossbeam-deque v0.8.7
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling zlib-rs v0.6.7
[INFO] [stderr]    Compiling regex-automata v0.4.18
[INFO] [stderr]    Compiling either v1.18.0
[INFO] [stderr]    Compiling lexical-util v1.0.7
[INFO] [stderr]    Compiling bitflags v2.13.1
[INFO] [stderr]    Compiling bit-vec v0.10.1
[INFO] [stderr]    Compiling crossbeam-channel v0.5.16
[INFO] [stderr]    Compiling lexical-write-integer v1.0.6
[INFO] [stderr]    Compiling lexical-parse-integer v1.0.6
[INFO] [stderr]    Compiling bstr v1.13.1
[INFO] [stderr]    Compiling lexical-parse-float v1.0.6
[INFO] [stderr]    Compiling rayon-core v1.13.0
[INFO] [stderr]    Compiling lexical-write-float v1.0.6
[INFO] [stderr]    Compiling syn v3.0.4
[INFO] [stderr]    Compiling pkg-config v0.3.34
[INFO] [stderr]    Compiling jobserver v0.1.35
[INFO] [stderr]    Compiling lexical-core v1.0.6
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]    Compiling cc v1.4.4
[INFO] [stderr]    Compiling rayon v1.12.0
[INFO] [stderr]    Compiling noodles-core v0.20.0
[INFO] [stderr]    Compiling anyhow v1.0.104
[INFO] [stderr]    Compiling crc32fast v1.5.1
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling cfg_aliases v0.2.2
[INFO] [stderr]    Compiling nix v0.31.3
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling zerocopy v0.8.56
[INFO] [stderr]    Compiling fgumi-dna v0.7.0
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling libdeflate-sys v1.26.0
[INFO] [stderr]    Compiling bytemuck_derive v1.12.0
[INFO] [stderr]    Compiling zstd-sys v2.0.16+zstd.1.5.7
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling libmimalloc-sys v0.1.49
[INFO] [stderr]    Compiling flate2 v1.1.9
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling bytemuck v1.25.2
[INFO] [stderr]    Compiling safe_arch v1.2.0
[INFO] [stderr]    Compiling log v0.4.34
[INFO] [stderr]    Compiling cty v0.2.2
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling fastrand v2.5.0
[INFO] [stderr]    Compiling fs4 v1.1.0
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling wide v1.6.1
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling crossbeam-queue v0.3.13
[INFO] [stderr]    Compiling bytesize v2.7.0
[INFO] [stderr]    Compiling ahash v0.8.12
[INFO] [stderr]    Compiling libdeflater v1.26.0
[INFO] [stderr]    Compiling noodles-bgzf v0.51.0
[INFO] [stderr]    Compiling bgzf v0.5.0
[INFO] [stderr]    Compiling fgumi-bgzf v0.7.0
[INFO] [stderr]    Compiling noodles-csi v0.60.0
[INFO] [stderr]    Compiling noodles-fasta v0.66.0
[INFO] [stderr]    Compiling noodles-tabix v0.66.0
[INFO] [stderr]    Compiling noodles-sam v0.89.0
[INFO] [stderr]    Compiling noodles-vcf v0.92.0
[INFO] [stderr]    Compiling zstd-safe v7.2.4
[INFO] [stderr]    Compiling zstd v0.13.3
[INFO] [stderr]    Compiling noodles-bam v0.94.0
[INFO] [stderr]    Compiling noodles v0.115.0
[INFO] [stderr]    Compiling fgumi-tag v0.7.0
[INFO] [stderr]    Compiling fgumi-raw-bam v0.7.0
[INFO] [stderr]    Compiling fgumi-bam-io v0.7.0
[INFO] [stderr]    Compiling fgumi-sort v0.7.0 (/opt/rustwide/workdir)
[INFO] [stderr] warning: unused dependency `parking_lot`
[INFO] [stderr]   --> Cargo.toml:67:15
[INFO] [stderr]    |
[INFO] [stderr] 67 | [dependencies.parking_lot]
[INFO] [stderr]    |               ^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::unused_dependencies` is set to `warn` by default
[INFO] [stderr] help: consider removing the dependency on `parking_lot`
[INFO] [stderr] warning: `fgumi-sort` (manifest) generated 1 warning
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 17s
[INFO] running `Command { std: "docker" "inspect" "8f60c1337141d421b9e2c1ef40c76c053f0c24b1db20b8cea2945a5b3c0f696e", 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" "8f60c1337141d421b9e2c1ef40c76c053f0c24b1db20b8cea2945a5b3c0f696e" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling either v1.18.0
[INFO] [stderr]    Compiling regex-automata v0.4.18
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]    Compiling syn v3.0.4
[INFO] [stderr]    Compiling zerocopy v0.8.56
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling rayon v1.12.0
[INFO] [stderr]    Compiling anstyle-parse v1.0.0
[INFO] [stderr]    Compiling colorchoice v1.0.5
[INFO] [stderr]    Compiling winnow v1.0.4
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling memchr v2.8.3
[INFO] [stderr]    Compiling anstream v1.0.0
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling aho-corasick v1.1.5
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling toml_parser v1.1.3+spec-1.1.0
[INFO] [stderr]    Compiling toml_datetime v1.1.1+spec-1.1.0
[INFO] [stderr]    Compiling bstr v1.13.1
[INFO] [stderr]    Compiling noodles-bgzf v0.51.0
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling clap_builder v4.6.6
[INFO] [stderr]    Compiling toml_edit v0.25.13+spec-1.1.0
[INFO] [stderr]    Compiling noodles-core v0.20.0
[INFO] [stderr]    Compiling rstest_macros v0.26.1
[INFO] [stderr]    Compiling noodles-csi v0.60.0
[INFO] [stderr]    Compiling noodles-fasta v0.66.0
[INFO] [stderr]    Compiling noodles-tabix v0.66.0
[INFO] [stderr]    Compiling noodles-sam v0.89.0
[INFO] [stderr]    Compiling noodles-vcf v0.92.0
[INFO] [stderr]    Compiling alloca v0.4.0
[INFO] [stderr]    Compiling regex v1.13.1
[INFO] [stderr]    Compiling bytemuck_derive v1.12.0
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling noodles-bam v0.94.0
[INFO] [stderr]    Compiling zerocopy-derive v0.8.56
[INFO] [stderr]    Compiling bytemuck v1.25.2
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling safe_arch v1.2.0
[INFO] [stderr]    Compiling noodles v0.115.0
[INFO] [stderr]    Compiling fgumi-tag v0.7.0
[INFO] [stderr]    Compiling wide v1.6.1
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling bgzf v0.5.0
[INFO] [stderr]    Compiling clap_derive v4.6.4
[INFO] [stderr]    Compiling futures-macro v0.3.34
[INFO] [stderr]    Compiling proc-macro-crate v3.5.0
[INFO] [stderr]    Compiling fgumi-bgzf v0.7.0
[INFO] [stderr]    Compiling itertools v0.13.0
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling relative-path v1.9.3
[INFO] [stderr]    Compiling bit-vec v0.8.0
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling futures-core v0.3.34
[INFO] [stderr]    Compiling quick-error v1.2.3
[INFO] [stderr]    Compiling glob v0.3.4
[INFO] [stderr]    Compiling futures-task v0.3.34
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling futures-util v0.3.34
[INFO] [stderr]    Compiling bit-set v0.8.0
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling clap v4.6.6
[INFO] [stderr]    Compiling criterion-plot v0.8.2
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling rand v0.9.5
[INFO] [stderr]    Compiling page_size v0.6.0
[INFO] [stderr]    Compiling futures-timer v3.0.4
[INFO] [stderr]    Compiling unarray v0.1.4
[INFO] [stderr]    Compiling rstest v0.26.1
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling ahash v0.8.12
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling proptest v1.11.0
[INFO] [stderr]    Compiling criterion v0.8.2
[INFO] [stderr]    Compiling fgumi-raw-bam v0.7.0
[INFO] [stderr]    Compiling fgumi-bam-io v0.7.0
[INFO] [stderr]    Compiling fgumi-sam v0.7.0
[INFO] [stderr]    Compiling fgumi-sort v0.7.0 (/opt/rustwide/workdir)
[INFO] [stderr] warning: unused dependency `parking_lot`
[INFO] [stderr]   --> Cargo.toml:67:15
[INFO] [stderr]    |
[INFO] [stderr] 67 | [dependencies.parking_lot]
[INFO] [stderr]    |               ^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::unused_dependencies` is set to `warn` by default
[INFO] [stderr] help: consider removing the dependency on `parking_lot`
[INFO] [stderr] warning: `fgumi-sort` (manifest) generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 27.84s
[INFO] running `Command { std: "docker" "inspect" "8f60c1337141d421b9e2c1ef40c76c053f0c24b1db20b8cea2945a5b3c0f696e", 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" "8f60c1337141d421b9e2c1ef40c76c053f0c24b1db20b8cea2945a5b3c0f696e" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] warning: unused dependency `parking_lot`
[INFO] [stderr]   --> Cargo.toml:67:15
[INFO] [stderr]    |
[INFO] [stderr] 67 | [dependencies.parking_lot]
[INFO] [stderr]    |               ^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `cargo::unused_dependencies` is set to `warn` by default
[INFO] [stderr] help: consider removing the dependency on `parking_lot`
[INFO] [stderr] warning: `fgumi-sort` (manifest) generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.21s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/fgumi-sort/95d18dce3366eed2/out/fgumi_sort-95d18dce3366eed2)
[INFO] [stdout] 
[INFO] [stdout] running 970 tests
[INFO] [stdout] test bgzf_io::tests::test_default_frame_size_preserves_the_original_decompress_cap ... ok
[INFO] [stdout] test bgzf_io::tests::test_frame_caps_admit_the_largest_frame_the_writer_emits ... ok
[INFO] [stdout] test bgzf_io::tests::test_only_zstd_spill_frames_escape_the_bgzf_block_ceiling ... ok
[INFO] [stdout] test bgzf_io::tests::test_roundtrip_small_data::case_1 ... ok
[INFO] [stdout] test bgzf_io::tests::test_spill_writer_pre_flushes_at_the_staging_frame_size::case_2 ... ok
[INFO] [stdout] test bgzf_io::tests::test_roundtrip_empty_data::case_1 ... ok
[INFO] [stdout] test bgzf_io::tests::test_staging_buffer_flush_empty_is_noop::case_1 ... ok
[INFO] [stdout] test bgzf_io::tests::test_spill_writer_pre_flushes_at_the_staging_frame_size::case_1 ... ok
[INFO] [stdout] test bgzf_io::tests::test_io_writer_loop_reorders_out_of_order_blocks::case_1 ... ok
[INFO] [stdout] test bgzf_io::tests::test_roundtrip_empty_data::case_2 ... ok
[INFO] [stdout] test bgzf_io::tests::test_staging_buffer_flush_empty_is_noop::case_2 ... ok
[INFO] [stdout] test bgzf_io::tests::test_roundtrip_small_data::case_2 ... ok
[INFO] [stdout] test bgzf_io::tests::test_staging_buffer_is_full::case_1 ... ok
[INFO] [stdout] test bgzf_io::tests::test_io_writer_loop_reorders_out_of_order_blocks::case_2 ... ok
[INFO] [stdout] test bgzf_io::tests::test_staging_buffer_is_full::case_2 ... ok
[INFO] [stdout] test external::tests::auto_drops_constant_single_library_lane ... ok
[INFO] [stdout] test external::tests::auto_cb_only_when_first_record_has_cb ... ok
[INFO] [stdout] test external::tests::auto_keeps_tertiary_for_mi_even_with_constant_library ... ok
[INFO] [stdout] test external::tests::auto_full_when_both_present ... ok
[INFO] [stdout] test external::tests::auto_keeps_tertiary_when_header_library_varies ... ok
[INFO] [stdout] test external::tests::auto_tertiary_only_when_first_record_has_mi_or_library ... ok
[INFO] [stdout] test external::tests::auto_lite_when_no_cb_no_tertiary ... ok
[INFO] [stdout] test external::tests::block_lifecycle_gate_covers_every_report::case_1_nothing_recorded_stays_silent ... ok
[INFO] [stdout] test bgzf_io::tests::test_staging_buffer_write_chunked_large_data::case_2 ... ok
[INFO] [stdout] test bgzf_io::tests::test_staging_buffer_write_chunked_large_data::case_1 ... ok
[INFO] [stdout] test external::tests::block_lifecycle_gate_covers_every_report::case_3_refill_cycle_alone_speaks ... ok
[INFO] [stdout] test external::tests::block_lifecycle_gate_covers_every_report::case_4_consumer_trace_alone_speaks ... ok
[INFO] [stdout] test external::tests::block_lifecycle_gate_covers_every_report::case_5_fruitless_scans_alone_speak ... ok
[INFO] [stdout] test external::tests::estimator_bytes_per_record_matches_ref_size ... ok
[INFO] [stdout] test external::tests::cluster_barcodes_have_distinct_cb_hashes ... ok
[INFO] [stdout] test external::tests::block_lifecycle_gate_covers_every_report::case_2_block_lifecycle_alone_speaks ... ok
[INFO] [stdout] test external::tests::empty_input_defaults_to_lite ... ok
[INFO] [stdout] test external::tests::explicit_spec_passthrough ... ok
[INFO] [stdout] test external::tests::full_forces_all_lanes ... ok
[INFO] [stdout] test external::tests::matching_record_counts_leave_the_output_alone ... ok
[INFO] [stdout] test external::tests::merge_stall_gate_covers_every_report::case_2_consumer_stalls_alone_speak ... ok
[INFO] [stdout] test external::tests::merge_stall_gate_covers_every_report::case_3_fruitless_scans_alone_speak ... ok
[INFO] [stdout] test external::tests::merge_stall_gate_covers_every_report::case_4_wake_latency_alone_speaks ... ok
[INFO] [stdout] test external::tests::auto_single_library_unmapped_read_sorts_without_false_violation ... ok
[INFO] [stdout] test external::tests::merge_stall_gate_covers_every_report::case_1_nothing_recorded_stays_silent ... ok
[INFO] [stdout] test external::tests::lite_sort_hard_errors_when_library_differs ... ok
[INFO] [stdout] test external::tests::lite_sort_hard_errors_when_mi_appears ... ok
[INFO] [stdout] test external::tests::lite_sort_hard_errors_when_cb_appears ... ok
[INFO] [stdout] test external::tests::auto_single_library_multi_readgroup_sorts_without_false_violation ... ok
[INFO] [stdout] test external::tests::narrow_key_sort_byte_identical_to_full::case_1_bulk ... ok
[INFO] [stdout] test external::tests::auto_drops_constant_library_lane_byte_identical ... ok
[INFO] [stdout] test external::tests::narrow_key_sort_byte_identical_to_full::case_2_single_cell ... ok
[INFO] [stdout] test external::tests::narrow_key_sort_byte_identical_to_full::case_5_full ... ok
[INFO] [stdout] test external::tests::narrow_key_sort_byte_identical_to_full::case_4_multi_lib ... ok
[INFO] [stdout] test external::tests::narrow_key_sort_byte_identical_to_full::case_3_post_group ... ok
[INFO] [stdout] test external::tests::narrow_key_sort_byte_identical_when_spilling ... ok
[INFO] [stdout] test external::tests::none_forces_lite ... ok
[INFO] [stdout] test external::tests::narrow_sort_output_passes_full_width_verify ... ok
[INFO] [stdout] test external::tests::record_count_mismatch_never_unlinks_stdout::case_1_dash ... ok
[INFO] [stdout] test external::tests::record_count_mismatch_never_unlinks_stdout::case_2_dev_stdout ... ok
[INFO] [stdout] test external::tests::record_count_mismatch_removes_the_output::case_1_index_written ... ok
[INFO] [stdout] test external::tests::record_count_mismatch_removes_the_output::case_2_no_index ... ok
[INFO] [stdout] test external::tests::record_count_mismatch_removes_the_symlink_target ... ok
[INFO] [stdout] test external::tests::record_count_mismatch_tolerates_a_missing_output ... ok
[INFO] [stdout] test external::tests::silent_stall_gate_does_not_silence_the_lifecycle_gate ... ok
[INFO] [stdout] test external::tests::record_count_mismatch_leaves_a_non_regular_output_alone ... ok
[INFO] [stdout] test external::tests::template_sort_empty_input_writes_header_only_bam ... ok
[INFO] [stdout] test external::tests::narrow_key_spill_merge_byte_identical_all_widths::case_1_bulk ... ok
[INFO] [stdout] test external::tests::template_sort_auto_lite_roundtrips_record_count ... ok
[INFO] [stdout] test external::tests::narrow_key_spill_merge_byte_identical_all_widths::case_4_multi_lib ... ok
[INFO] [stdout] test external::tests::narrow_key_spill_merge_byte_identical_all_widths::case_5_full ... ok
[INFO] [stdout] test external::tests::narrow_key_spill_merge_byte_identical_all_widths::case_3_post_group ... ok
[INFO] [stdout] test external::tests::narrow_key_spill_merge_byte_identical_all_widths::case_2_single_cell ... ok
[INFO] [stdout] test external::tests::test_append_across_spill_codecs::case_1_bgzf ... ok
[INFO] [stdout] test external::tests::mode_inputs_realize_claimed_lanes ... ok
[INFO] [stdout] test external::tests::test_create_output_header_coordinate ... ok
[INFO] [stdout] test external::tests::test_create_output_header_queryname ... ok
[INFO] [stdout] test external::tests::test_create_output_header_template_coordinate ... ok
[INFO] [stdout] test external::tests::test_distinct_header_ordinals ... ok
[INFO] [stdout] test external::tests::test_extract_template_key_cb_absent_has_zero_hash ... ok
[INFO] [stdout] test external::tests::test_extract_template_key_cb_hash_is_deterministic ... ok
[INFO] [stdout] test external::tests::test_extract_template_key_cb_present_has_nonzero_hash ... ok
[INFO] [stdout] test external::tests::test_extract_template_key_cell_tag_none_has_zero_hash ... ok
[INFO] [stdout] test external::tests::test_extract_template_key_different_cb_values_differ ... ok
[INFO] [stdout] test external::tests::test_extract_template_key_mate_lane_comes_from_mc ... ok
[INFO] [stdout] test external::tests::test_extract_template_key_mate_lane_parses_a_non_utf8_mc_prefix ... ok
[INFO] [stdout] test external::tests::test_extract_template_key_secondary_supplementary_matches_primary_via_tc::case_1_secondary ... ok
[INFO] [stdout] test external::tests::test_extract_template_key_secondary_supplementary_matches_primary_via_tc::case_2_supplementary ... ok
[INFO] [stdout] test external::tests::test_extract_template_key_secondary_supplementary_uses_tc_tag::case_1_secondary ... ok
[INFO] [stdout] test external::tests::test_extract_template_key_secondary_supplementary_uses_tc_tag::case_2_supplementary ... ok
[INFO] [stdout] test external::tests::test_extract_template_key_secondary_supplementary_without_tc_falls_back::case_1_secondary ... ok
[INFO] [stdout] test external::tests::test_extract_template_key_secondary_supplementary_without_tc_falls_back::case_2_supplementary ... ok
[INFO] [stdout] test external::tests::test_extract_template_key_unmapped_with_cb ... ok
[INFO] [stdout] test external::tests::test_fd_budget_warning_names_the_width_and_the_lever::case_1_ordinary_merge_fits ... ok
[INFO] [stdout] test external::tests::test_fd_budget_warning_names_the_width_and_the_lever::case_2_exactly_at_the_budget ... ok
[INFO] [stdout] test external::tests::test_fd_budget_warning_names_the_width_and_the_lever::case_3_one_past_the_budget ... ok
[INFO] [stdout] test external::tests::test_fd_budget_warning_names_the_width_and_the_lever::case_4_budget_below_the_reserve ... ok
[INFO] [stdout] test external::tests::test_fd_budget_warning_names_the_width_and_the_lever::case_5_unreadable_budget_never_warns ... ok
[INFO] [stdout] test external::tests::test_fd_budget_warning_reads_the_process_budget ... ok
[INFO] [stdout] test external::tests::test_appending_run_with_write_index ... ok
[INFO] [stdout] test external::tests::test_find_rg_tag::case_1_present ... ok
[INFO] [stdout] test external::tests::test_find_rg_tag::case_2_absent ... ok
[INFO] [stdout] test external::tests::test_find_rg_tag_after_other_tags ... ok
[INFO] [stdout] test external::tests::test_library_lookup_empty_header ... ok
[INFO] [stdout] test external::tests::test_library_lookup_multiple_libraries ... ok
[INFO] [stdout] test external::tests::test_library_lookup_single_rg ... ok
[INFO] [stdout] test external::tests::test_library_lookup_unknown_rg_returns_zero ... ok
[INFO] [stdout] test external::tests::test_log_consumer_stalls_renders_every_shape::case_2_contended ... ok
[INFO] [stdout] test external::tests::test_log_consumer_stalls_renders_every_shape::case_1_not_stalled ... ok
[INFO] [stdout] test external::tests::test_log_consumer_stalls_renders_every_shape::case_3_pool_saturated ... ok
[INFO] [stdout] test external::tests::test_log_consumer_stalls_renders_every_shape::case_4_head_of_line ... ok
[INFO] [stdout] test external::tests::test_log_consumer_stalls_renders_every_shape::case_5_work_unclaimed ... ok
[INFO] [stdout] test external::tests::test_log_consumer_stalls_renders_every_shape::case_6_decompress_latency ... ok
[INFO] [stdout] test external::tests::test_log_consumer_stalls_renders_every_shape::case_7_mixed ... ok
[INFO] [stdout] test external::tests::test_max_chunk_records_keeps_ingest_positions_in_u32 ... ok
[INFO] [stdout] test external::tests::test_merge_bams_coordinate_sort ... ok
[INFO] [stdout] test external::tests::test_append_across_spill_codecs::case_2_zstd ... ok
[INFO] [stdout] test external::tests::test_merge_bams_preserves_all_records ... ok
[INFO] [stdout] test external::tests::test_consolidation_while_a_run_is_open::case_2_queryname_lex ... ok
[INFO] [stdout] test external::tests::test_merge_bams_single_input ... ok
[INFO] [stdout] test external::tests::test_merge_bams_queryname_natural_sort ... ok
[INFO] [stdout] test external::tests::test_descent_opens_exactly_one_more_run ... ok
[INFO] [stdout] test external::tests::test_consolidation_while_a_run_is_open::case_3_queryname_natural ... ok
[INFO] [stdout] test external::tests::test_merge_bams_queryname_sort ... ok
[INFO] [stdout] test external::tests::test_merge_chunks_generic_with_only_empty_sources ... ok
[INFO] [stdout] test external::tests::test_merge_chunks_with_index_with_only_empty_sources ... ok
[INFO] [stdout] test external::tests::test_merge_bams_many_inputs ... ok
[INFO] [stdout] test external::tests::test_merge_bams_template_coordinate_sort ... ok
[INFO] [stdout] test external::tests::test_oversized_record_survives_spill_and_pool_merge::case_1_coordinate ... ok
[INFO] [stdout] test external::tests::test_oversized_record_survives_spill_and_pool_merge::case_2_template_coordinate ... ok
[INFO] [stdout] test external::tests::test_consolidation_while_a_run_is_open::case_1_coordinate ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_1_narrow_sort_wide_merge::write_index_1_false::memory_limit_2_64_1024_1024 ... ok
[INFO] [stdout] test external::tests::test_consolidation_while_a_run_is_open::case_4_template_coordinate ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_1_narrow_sort_wide_merge::write_index_1_false::memory_limit_1_16_1024 ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_1_narrow_sort_wide_merge::write_index_2_true::memory_limit_1_16_1024 ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_1_narrow_sort_wide_merge::write_index_2_true::memory_limit_2_64_1024_1024 ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_2_wide_sort_narrow_merge::write_index_1_false::memory_limit_2_64_1024_1024 ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_2_wide_sort_narrow_merge::write_index_2_true::memory_limit_1_16_1024 ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_2_wide_sort_narrow_merge::write_index_1_false::memory_limit_1_16_1024 ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_2_wide_sort_narrow_merge::write_index_2_true::memory_limit_2_64_1024_1024 ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_3_both_narrow::write_index_1_false::memory_limit_2_64_1024_1024 ... ok
[INFO] [stdout] test external::tests::test_phase2_guard_finish_output_resets_phase_on_error ... ok
[INFO] [stdout] test external::tests::test_phase2_guard_releases_sources_before_finalizing_output ... ok
[INFO] [stdout] test external::tests::test_phase_thread_defaults::case_1_neither_set ... ok
[INFO] [stdout] test external::tests::test_phase_thread_defaults::case_2_sort_only ... ok
[INFO] [stdout] test external::tests::test_phase_thread_defaults::case_3_merge_only ... ok
[INFO] [stdout] test external::tests::test_phase_thread_defaults::case_4_both_set ... ok
[INFO] [stdout] test external::tests::test_phase_thread_defaults::case_5_zero_clamps_to_one ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_3_both_narrow::write_index_1_false::memory_limit_1_16_1024 ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_4_both_wide::write_index_1_false::memory_limit_2_64_1024_1024 ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_4_both_wide::write_index_1_false::memory_limit_1_16_1024 ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_3_both_narrow::write_index_2_true::memory_limit_2_64_1024_1024 ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_3_both_narrow::write_index_2_true::memory_limit_1_16_1024 ... ok
[INFO] [stdout] test external::tests::test_raw_sorter_builder_chain ... ok
[INFO] [stdout] test external::tests::test_raw_sorter_cell_tag_builder ... ok
[INFO] [stdout] test external::tests::test_raw_sorter_cell_tag_default_is_none ... ok
[INFO] [stdout] test external::tests::test_raw_sorter_defaults ... ok
[INFO] [stdout] test external::tests::test_raw_sorter_max_temp_files ... ok
[INFO] [stdout] test external::tests::test_raw_sorter_memory_limit ... ok
[INFO] [stdout] test external::tests::test_process_umask_is_concurrency_safe ... ok
[INFO] [stdout] test external::tests::test_raw_sorter_sort_rejects_temp_compression_zero_with_zstd ... ok
[INFO] [stdout] test external::tests::test_raw_sorter_temp_compression ... ok
[INFO] [stdout] test external::tests::test_read_exact_or_eof_clean_eof ... ok
[INFO] [stdout] test external::tests::test_raw_sorter_sort_stats_default_off_and_builder ... ok
[INFO] [stdout] test external::tests::test_read_exact_or_eof_full_read ... ok
[INFO] [stdout] test external::tests::test_read_exact_or_eof_short_reads_fill_buffer ... ok
[INFO] [stdout] test external::tests::test_read_exact_or_eof_truncated_is_error ... ok
[INFO] [stdout] test external::tests::test_resolve_symlink_output_detects_cycle ... ok
[INFO] [stdout] test external::tests::test_resolve_symlink_output_follows_relative_target ... ok
[INFO] [stdout] test external::tests::test_presorted_input_collapses_to_one_run::case_1_coordinate ... ok
[INFO] [stdout] test external::tests::test_resolve_symlink_output_passthrough_for_nonexistent ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_4_both_wide::write_index_2_true::memory_limit_2_64_1024_1024 ... ok
[INFO] [stdout] test external::tests::test_per_phase_threads_produce_identical_output::case_4_both_wide::write_index_2_true::memory_limit_1_16_1024 ... ok
[INFO] [stdout] test external::tests::test_should_spill_chunk::case_1_empty ... ok
[INFO] [stdout] test external::tests::test_should_spill_chunk::case_2_under_both ... ok
[INFO] [stdout] test external::tests::test_should_spill_chunk::case_3_at_memory_limit ... ok
[INFO] [stdout] test external::tests::test_should_spill_chunk::case_4_over_memory_limit ... ok
[INFO] [stdout] test external::tests::test_should_spill_chunk::case_5_one_under_record_cap ... ok
[INFO] [stdout] test external::tests::test_should_spill_chunk::case_6_at_record_cap ... ok
[INFO] [stdout] test external::tests::test_should_spill_chunk::case_7_over_record_cap ... ok
[INFO] [stdout] test external::tests::test_presorted_input_collapses_to_one_run::case_2_queryname_lex ... ok
[INFO] [stdout] test external::tests::test_sort_coordinate_with_index_in_memory_writes_sidecar::case_1_dot_bam_output ... ok
[INFO] [stdout] test external::tests::test_presorted_input_collapses_to_one_run::case_3_queryname_natural ... ok
[INFO] [stdout] test external::tests::test_sort_coordinate_with_index_in_memory_writes_sidecar::case_2_non_bam_output ... ok
[INFO] [stdout] test external::tests::test_presorted_input_collapses_to_one_run::case_4_template_coordinate ... ok
[INFO] [stdout] test external::tests::test_run_formation_output_is_byte_identical::case_3_queryname_natural ... ok
[INFO] [stdout] test external::tests::test_run_formation_output_is_byte_identical::case_1_coordinate ... ok
[INFO] [stdout] test external::tests::test_run_formation_output_is_byte_identical::case_2_queryname_lex ... ok
[INFO] [stdout] test external::tests::test_run_formation_output_is_byte_identical::case_4_template_coordinate ... ok
[INFO] [stdout] test external::tests::test_sort_many_chunks_with_semaphore::case_1_coordinate ... ok
[INFO] [stdout] test external::tests::test_sort_coordinate_with_index_spilled_preserves_records::case_2_non_bam_output ... ok
[INFO] [stdout] test external::tests::test_sort_queryname_output_identity_matches_stable_baseline::case_1_lexicographic::threads_1_1::memory_limit_1_IN_MEMORY_MEMORY_LIMIT ... ok
[INFO] [stdout] test external::tests::test_sort_phase_timer_all_methods ... ok
[INFO] [stdout] test external::tests::test_sort_many_chunks_with_semaphore::case_2_queryname ... ok
[INFO] [stdout] test external::tests::test_sort_coordinate_with_index_spilled_preserves_records::case_1_dot_bam_output ... ok
[INFO] [stdout] test external::tests::test_sort_many_chunks_with_semaphore::case_3_queryname_natural ... ok
[INFO] [stdout] test external::tests::test_sort_queryname_output_identity_matches_stable_baseline::case_1_lexicographic::threads_2_4::memory_limit_1_IN_MEMORY_MEMORY_LIMIT ... ok
[INFO] [stdout] test external::tests::test_sort_queryname_output_identity_matches_stable_baseline::case_2_natural::threads_1_1::memory_limit_1_IN_MEMORY_MEMORY_LIMIT ... ok
[INFO] [stdout] test external::tests::test_sort_queryname_output_identity_matches_stable_baseline::case_1_lexicographic::threads_2_4::memory_limit_2_SPILLING_MEMORY_LIMIT ... ok
[INFO] [stdout] test external::tests::test_sort_many_chunks_with_semaphore::case_4_template_coordinate ... ok
[INFO] [stdout] test external::tests::test_sort_queryname_output_identity_matches_stable_baseline::case_1_lexicographic::threads_1_1::memory_limit_2_SPILLING_MEMORY_LIMIT ... ok
[INFO] [stdout] test external::tests::test_sort_queryname_output_identity_matches_stable_baseline::case_2_natural::threads_2_4::memory_limit_1_IN_MEMORY_MEMORY_LIMIT ... ok
[INFO] [stdout] test external::tests::test_sort_queryname_output_identity_matches_stable_baseline::case_2_natural::threads_2_4::memory_limit_2_SPILLING_MEMORY_LIMIT ... ok
[INFO] [stdout] test external::tests::test_sort_queryname_preserves_exact_tie_input_order::case_1_single_threaded_in_memory ... ok
[INFO] [stdout] test external::tests::test_sort_queryname_preserves_exact_tie_input_order::case_2_multi_threaded_in_memory ... ok
[INFO] [stdout] test external::tests::test_sort_records_error_on_first_record_aborts ... ok
[INFO] [stdout] test external::tests::test_sort_records_empty_stream_writes_header_only ... ok
[INFO] [stdout] test external::tests::test_sort_queryname_output_identity_matches_stable_baseline::case_2_natural::threads_1_1::memory_limit_2_SPILLING_MEMORY_LIMIT ... ok
[INFO] [stdout] test external::tests::test_sort_coordinate_with_index_spilled_preserves_records::case_3_no_extension_output ... ok
[INFO] [stdout] test external::tests::test_sort_records_matches_sort_from_file::sort_order_1_SortOrder__Coordinate::memory_limit_1_8_1024_1024 ... ok
[INFO] [stdout] test external::tests::test_sort_queryname_preserves_exact_tie_input_order::case_4_multi_threaded_spill ... ok
[INFO] [stdout] test external::tests::test_sort_records_matches_sort_from_file::sort_order_2_SortOrder__Queryname_QuerynameComparator__Lexicographic_::memory_limit_1_8_1024_1024 ... ok
[INFO] [stdout] test external::tests::test_sort_records_matches_sort_from_file::sort_order_3_SortOrder__Queryname_QuerynameComparator__Natural_::memory_limit_1_8_1024_1024 ... ok
[INFO] [stdout] test external::tests::test_sort_queryname_preserves_exact_tie_input_order::case_3_single_threaded_spill ... ok
[INFO] [stdout] test external::tests::test_sort_records_matches_sort_from_file::sort_order_2_SortOrder__Queryname_QuerynameComparator__Lexicographic_::memory_limit_2_16_1024 ... ok
[INFO] [stdout] test external::tests::test_sort_records_matches_sort_from_file::sort_order_3_SortOrder__Queryname_QuerynameComparator__Natural_::memory_limit_2_16_1024 ... ok
[INFO] [stdout] test external::tests::test_sort_records_matches_sort_from_file::sort_order_1_SortOrder__Coordinate::memory_limit_2_16_1024 ... ok
[INFO] [stdout] test external::tests::test_sort_sub_arrays_in_memory_only::case_1_coordinate ... ok
[INFO] [stdout] test external::tests::test_sort_records_producer_error_aborts::case_1_before_spill ... ok
[INFO] [stdout] test external::tests::test_sort_records_producer_error_aborts::case_2_after_spill ... ok
[INFO] [stdout] test external::tests::test_sort_records_matches_sort_from_file::sort_order_4_SortOrder__TemplateCoordinate::memory_limit_1_8_1024_1024 ... ok
[INFO] [stdout] test external::tests::test_sort_sub_arrays_in_memory_only::case_2_queryname ... ok
[INFO] [stdout] test external::tests::test_sort_sub_arrays_in_memory_only::case_3_queryname_natural ... ok
[INFO] [stdout] test external::tests::test_sort_records_matches_sort_from_file::sort_order_4_SortOrder__TemplateCoordinate::memory_limit_2_16_1024 ... ok
[INFO] [stdout] test external::tests::test_sort_sub_arrays_in_memory_only::case_4_template_coordinate ... ok
[INFO] [stdout] test external::tests::test_sort_sub_arrays_match_single_thread::case_1_coordinate ... ok
[INFO] [stdout] test external::tests::test_sort_sub_arrays_match_single_thread::case_2_queryname ... ok
[INFO] [stdout] test external::tests::test_sort_sub_arrays_match_single_thread::case_3_queryname_natural ... ok
[INFO] [stdout] test external::tests::test_sort_sub_arrays_match_single_thread::case_4_template_coordinate ... ok
[INFO] [stdout] test external::tests::test_sort_with_consolidation_preserves_all_records::case_02_coordinate_with_index_bgzf ... ok
[INFO] [stdout] test external::tests::test_sort_with_consolidation_preserves_all_records::case_01_coordinate_bgzf ... ok
[INFO] [stdout] test external::tests::test_sort_with_consolidation_preserves_all_records::case_04_queryname_natural_bgzf ... ok
[INFO] [stdout] test external::tests::test_sort_with_consolidation_preserves_all_records::case_03_queryname_bgzf ... ok
[INFO] [stdout] test external::tests::test_sort_with_consolidation_preserves_all_records::case_05_template_coordinate_bgzf ... ok
[INFO] [stdout] test external::tests::test_split_off_aligns_with_par_chunks_mut ... ok
[INFO] [stdout] test external::tests::test_target_file_mode_keeps_existing_file_mode ... ok
[INFO] [stdout] test external::tests::test_target_file_mode_new_file_uses_umask ... ok
[INFO] [stdout] test external::tests::test_sort_with_two_temp_dirs_matches_single_dir ... ok
[INFO] [stdout] test external::tests::test_sort_with_consolidation_preserves_all_records::case_07_coordinate_with_index_zstd ... ok
[INFO] [stdout] test external::tests::test_sort_with_consolidation_preserves_all_records::case_06_coordinate_zstd ... ok
[INFO] [stdout] test external::tests::test_sort_with_consolidation_preserves_all_records::case_08_queryname_zstd ... ok
[INFO] [stdout] test external::tests::test_sort_with_consolidation_preserves_all_records::case_10_template_coordinate_zstd ... ok
[INFO] [stdout] test external::tests::verify_detects_cb_appearing ... ok
[INFO] [stdout] test external::tests::verify_detects_library_change ... ok
[INFO] [stdout] test external::tests::verify_detects_mi_change ... ok
[INFO] [stdout] test external::tests::verify_error_message_names_field_and_token ... ok
[INFO] [stdout] test external::tests::verify_passes_when_dropped_lanes_constant ... ok
[INFO] [stdout] test fd_limit::tests::test_fits_nofile_budget_accepts_an_ordinary_merge_width ... ok
[INFO] [stdout] test fd_limit::tests::test_fits_nofile_budget_admits_everything_without_a_budget ... ok
[INFO] [stdout] test external::tests::test_sort_with_consolidation_preserves_all_records::case_09_queryname_natural_zstd ... ok
[INFO] [stdout] test fd_limit::tests::test_fits_nofile_budget_rejects_an_oversized_explicit_limit ... ok
[INFO] [stdout] test fd_limit::tests::test_resolve_temp_file_limit_is_in_range ... ok
[INFO] [stdout] test fd_limit::tests::test_resolved_limit_fits_unless_budget_is_below_the_floor ... ok
[INFO] [stdout] test fd_limit::tests::test_temp_file_limit_from_nofile_falls_back_without_a_budget ... ok
[INFO] [stdout] test fd_limit::tests::test_temp_file_limit_from_soft_nofile::case_1_zero ... ok
[INFO] [stdout] test fd_limit::tests::test_temp_file_limit_from_soft_nofile::case_2_exactly_reserve ... ok
[INFO] [stdout] test fd_limit::tests::test_temp_file_limit_from_soft_nofile::case_3_at_floor ... ok
[INFO] [stdout] test fd_limit::tests::test_temp_file_limit_from_soft_nofile::case_5_below_legacy_default ... ok
[INFO] [stdout] test fd_limit::tests::test_temp_file_limit_from_soft_nofile::case_6_macos_default ... ok
[INFO] [stdout] test fd_limit::tests::test_temp_file_limit_from_soft_nofile::case_7_linux_container ... ok
[INFO] [stdout] test fd_limit::tests::test_temp_file_limit_from_soft_nofile::case_8_batch_host ... ok
[INFO] [stdout] test fd_limit::tests::test_temp_file_limit_from_soft_nofile::case_9_rlim_infinity ... ok
[INFO] [stdout] test inline::tests::from_full::narrow_ord_matches_full_when_dropped_lanes_constant ... ok
[INFO] [stdout] test inline::tests::from_full::template_key24_from_full_drops_optional_lanes ... ok
[INFO] [stdout] test fd_limit::tests::test_temp_file_limit_from_soft_nofile::case_4_just_above_floor ... ok
[INFO] [stdout] test inline::tests::from_full::template_key32_from_full_cb_uses_cb_hash_as_opt ... ok
[INFO] [stdout] test inline::tests::from_full::template_key32_from_full_tertiary_uses_tertiary_as_opt ... ok
[INFO] [stdout] test external::tests::test_unsorted_input_never_collapses_to_one_run::case_2_queryname_lex ... ok
[INFO] [stdout] test external::tests::test_unsorted_input_never_collapses_to_one_run::case_1_coordinate ... ok
[INFO] [stdout] test external::tests::test_write_index_oversized_record_builds_loadable_bai ... ok
[INFO] [stdout] test inline::tests::radix_sorts_template_key24 ... ok
[INFO] [stdout] test inline::tests::radix_sorts_template_key32 ... ok
[INFO] [stdout] test inline::tests::template_key24::template_key24_core_cmp_ignores_name_hash ... ok
[INFO] [stdout] test inline::tests::template_key24::template_key24_ord_is_lexicographic_over_lanes ... ok
[INFO] [stdout] test inline::tests::template_key32::template_key32_core_cmp_includes_opt_excludes_name_hash ... ok
[INFO] [stdout] test inline::tests::template_key32::template_key32_ord_is_lexicographic_over_lanes ... ok
[INFO] [stdout] test inline::tests::template_key24::template_key24_to_from_bytes_roundtrip ... ok
[INFO] [stdout] test inline::tests::template_key32::template_key32_to_from_bytes_roundtrip ... ok
[INFO] [stdout] test inline::tests::test_deferring_a_key_and_filling_it_matches_pushing_it_outright ... ok
[INFO] [stdout] test inline::tests::test_drain_into_single_chunk_round_trips_record_bytes ... ok
[INFO] [stdout] test inline::tests::radix_sorts_template_key40 ... ok
[INFO] [stdout] test inline::tests::test_fused_bound_matches_externally_supplied_bound::case_1_mixed_with_sentinels ... ok
[INFO] [stdout] test inline::tests::test_fused_bound_matches_externally_supplied_bound::case_3_mostly_sentinels ... ok
[INFO] [stdout] test inline::tests::test_fused_bound_matches_externally_supplied_bound::case_2_no_sentinels ... ok
[INFO] [stdout] test inline::tests::test_in_memory_chunk_empty_default ... ok
[INFO] [stdout] test inline::tests::test_fused_bound_matches_externally_supplied_bound::case_4_just_over_threshold ... ok
[INFO] [stdout] test inline::tests::test_in_memory_chunk_from_parts_reads_records ... ok
[INFO] [stdout] test inline::tests::test_in_memory_chunk_shared_arc_across_sibling_chunks ... ok
[INFO] [stdout] test inline::tests::test_in_memory_chunk_take_key_replaces_with_default ... ok
[INFO] [stdout] test external::tests::test_unsorted_input_never_collapses_to_one_run::case_4_template_coordinate ... ok
[INFO] [stdout] test inline::tests::test_narrowed_radix_separates_all_ones_key_from_sentinel::case_1_one_byte ... ok
[INFO] [stdout] test inline::tests::test_narrowed_radix_separates_all_ones_key_from_sentinel::case_2_two_bytes ... ok
[INFO] [stdout] test inline::tests::test_narrowed_radix_matches_full_width_output_exactly ... ok
[INFO] [stdout] test inline::tests::test_packed_coord_key_ordering ... ok
[INFO] [stdout] test inline::tests::test_par_sort_into_chunks_coordinate::case_1_coordinate_single_threaded ... ok
[INFO] [stdout] test inline::tests::test_narrowed_radix_separates_all_ones_key_from_sentinel::case_3_three_bytes ... ok
[INFO] [stdout] test inline::tests::test_par_sort_into_chunks_handles_unmapped_sentinel::case_1_single_threaded ... ok
[INFO] [stdout] test inline::tests::test_fused_bound_matches_externally_supplied_bound::case_5_wide_keys ... ok
[INFO] [stdout] test inline::tests::test_par_sort_into_chunks_template::case_1_template_single_threaded ... ok
[INFO] [stdout] test inline::tests::test_par_sort_into_chunks_handles_unmapped_sentinel::case_2_parallel ... ok
[INFO] [stdout] test inline::tests::test_par_sort_into_chunks_shares_arc_across_siblings ... ok
[INFO] [stdout] test external::tests::test_unsorted_input_never_collapses_to_one_run::case_3_queryname_natural ... ok
[INFO] [stdout] test inline::tests::test_parallel_radix_sort_single_threaded_fallback_range ... ok
[INFO] [stdout] test inline::tests::test_par_sort_into_chunks_coordinate::case_2_coordinate_parallel ... ok
[INFO] [stdout] test inline::tests::test_par_sort_into_chunks_template::case_2_template_parallel ... ok
[INFO] [stdout] test inline::tests::test_parallel_radix_sort_stability ... ok
[INFO] [stdout] test inline::tests::test_radix_sort_all_zero_keys ... ok
[INFO] [stdout] test inline::tests::test_radix_sort_all_same_keys ... ok
[INFO] [stdout] test inline::tests::test_radix_sort_all_unmapped_records ... ok
[INFO] [stdout] test inline::tests::test_radix_sort_empty ... ok
[INFO] [stdout] test inline::tests::test_radix_sort_large ... ok
[INFO] [stdout] test inline::tests::test_radix_sort_max_key ... ok
[INFO] [stdout] test inline::tests::test_radix_sort_record_refs ... ok
[INFO] [stdout] test inline::tests::test_radix_sort_single ... ok
[INFO] [stdout] test inline::tests::test_radix_sort_zero_keys_mixed_with_unmapped_sentinel ... ok
[INFO] [stdout] test inline::tests::test_radix_sort_template_refs_stability ... ok
[INFO] [stdout] test inline::tests::test_record_buffer_excludes_unmapped_sentinel_and_sorts_correctly ... ok
[INFO] [stdout] test inline::tests::test_template_key_cb_hash_between_secondary_and_tertiary ... ok
[INFO] [stdout] test inline::tests::test_template_key_cb_hash_ordering ... ok
[INFO] [stdout] test inline::tests::test_template_key_cb_hash_zero_sorts_first ... ok
[INFO] [stdout] test inline::tests::test_template_key_core_cmp_includes_cb_hash ... ok
[INFO] [stdout] test inline::tests::test_scanning_radix_entry_points_ignore_unmapped_sentinel::case_1_serial ... ok
[INFO] [stdout] test inline::tests::test_template_key_default_has_zero_cb_hash ... ok
[INFO] [stdout] test inline::tests::test_template_key_ordering ... ok
[INFO] [stdout] test inline::tests::test_template_key_serialization_with_cb_hash ... ok
[INFO] [stdout] test inline::tests::test_template_key_unmapped_packs_library_and_mi ... ok
[INFO] [stdout] test inline::tests::test_template_key_unmapped_with_cb_hash ... ok
[INFO] [stdout] test inline::tests::test_template_key_zeroed_has_zero_cb_hash ... ok
[INFO] [stdout] test inline::tests::test_template_record_buffer_sort_stability ... ok
[INFO] [stdout] test keys::tests::extracted_keys_default_to_position_zero ... ok
[INFO] [stdout] test keys::tests::position_fits_in_existing_key_padding ... ok
[INFO] [stdout] test keys::tests::position_totally_orders_otherwise_equal_lex_keys ... ok
[INFO] [stdout] test keys::tests::position_totally_orders_otherwise_equal_natural_keys ... ok
[INFO] [stdout] test keys::tests::test_extract_queryname_key_matches_oracle_and_is_nul_terminated::case_1_well_formed ... ok
[INFO] [stdout] test inline::tests::test_scanning_radix_entry_points_ignore_unmapped_sentinel::case_2_parallel ... ok
[INFO] [stdout] test keys::tests::test_extract_queryname_key_matches_oracle_and_is_nul_terminated::case_2_empty_name ... ok
[INFO] [stdout] test keys::tests::test_extract_queryname_key_matches_oracle_and_is_nul_terminated::case_3_truncated_name ... ok
[INFO] [stdout] test keys::tests::test_extract_queryname_key_matches_oracle_and_is_nul_terminated::case_5_not_nul_terminated ... ok
[INFO] [stdout] test keys::tests::test_extract_queryname_key_matches_oracle_and_is_nul_terminated::case_6_zero_declared_length ... ok
[INFO] [stdout] test keys::tests::test_extract_queryname_key_matches_oracle_and_is_nul_terminated::case_4_missing_terminator_byte ... ok
[INFO] [stdout] test keys::tests::test_lex_key_empty_names ... ok
[INFO] [stdout] test keys::tests::test_lex_key_flag_tiebreak ... ok
[INFO] [stdout] test keys::tests::test_lex_key_illumina_names ... ok
[INFO] [stdout] test keys::tests::test_lex_key_lexicographic_ordering ... ok
[INFO] [stdout] test keys::tests::test_lex_key_serialization_roundtrip ... ok
[INFO] [stdout] test keys::tests::test_lex_key_srr_names_differ_from_natural ... ok
[INFO] [stdout] test keys::tests::position_only_applies_after_name_and_flags ... ok
[INFO] [stdout] test keys::tests::test_lex_key_variable_length ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_adjacent_numeric_runs ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_all_zeros_tiebreak_by_length ... ok
[INFO] [stdout] test keys::tests::test_lex_vs_natural_ordering_difference ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_alpha_only::case_1 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_alpha_only::case_2 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_alpha_only::case_3 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_alpha_only::case_4 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_alpha_only::case_6 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_alpha_only::case_5 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_digits_before_nondigits::case_2 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_alpha_only::case_7 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_digits_before_nondigits::case_3 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_digits_before_nondigits::case_4 ... ok
[INFO] [stdout] test inline::tests::test_parallel_radix_sort ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_digits_before_nondigits::case_1 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_digits_before_nondigits::case_7 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_empty_and_single::case_1 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_empty_and_single::case_3 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_empty_and_single::case_2 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_empty_and_single::case_5 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_empty_and_single::case_4 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_empty_and_single::case_6 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_digits_before_nondigits::case_5 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_empty_and_single::case_7 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_digits_before_nondigits::case_6 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_high_bytes ... ok
[INFO] [stdout] test inline::tests::test_parallel_radix_sort_template_refs_stability ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_illumina_names::case_2 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_illumina_names::case_3 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_illumina_names::case_1 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_illumina_names::case_4 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_illumina_names::case_5 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_leading_zeros::case_02 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_illumina_names::case_6 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_leading_zeros::case_01 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_leading_zeros::case_03 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_illumina_names::case_7 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_leading_zeros::case_04 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_leading_zeros::case_05 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_leading_zeros::case_06 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_leading_zeros::case_07 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_leading_zeros::case_09 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_leading_zeros::case_08 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_leading_zeros::case_10 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_leading_zeros::case_11 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_long_numeric_runs ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_mixed_alphanumeric::case_01 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_leading_zeros::case_12 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_leading_zeros_tiebreak_by_length ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_mixed_alphanumeric::case_04 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_mixed_alphanumeric::case_05 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_mixed_alphanumeric::case_03 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_mixed_alphanumeric::case_06 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_mixed_alphanumeric::case_02 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_mixed_alphanumeric::case_08 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_mixed_alphanumeric::case_09 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_mixed_alphanumeric::case_10 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_mixed_alphanumeric::case_11 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_multidigit::case_01 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_multidigit::case_05 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_multidigit::case_06 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_multidigit::case_07 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_multidigit::case_08 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_multidigit::case_09 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_mixed_alphanumeric::case_07 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_multidigit::case_02 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_multidigit::case_03 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_multidigit::case_04 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_multidigit::case_10 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_multidigit::case_11 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_numeric_then_suffix::case_4 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_multiple_numeric_segments ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_numeric_then_suffix::case_1 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_prefix_relationships::case_1 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_numeric_then_suffix::case_2 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_numeric_then_suffix::case_3 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_prefix_relationships::case_4 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_prefix_relationships::case_2 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_prefix_relationships::case_6 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_samtools_name2_sort_order ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_samtools_name_sort_order ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_prefix_relationships::case_3 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_single_digit::case_1 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_prefix_relationships::case_5 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_single_digit::case_2 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_single_digit::case_3 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_single_digit::case_4 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_sort_mixed_name_formats ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_srr_names::case_1 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_sort_illumina_batch ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_srr_names::case_4 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_srr_names::case_6 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_srr_names::case_7 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_srr_names::case_2 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_strnum_cmp_compat_numeric_then_string ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_srr_names::case_3 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_strnum_cmp_compat_numeric_vs_alpha_boundary ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_srr_names::case_8 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_srr_names::case_5 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_synthetic_names::case_3 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_synthetic_names::case_1 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_synthetic_names::case_2 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_synthetic_names::case_5 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_synthetic_names::case_4 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_synthetic_names::case_6 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_u64_overflow_boundary ... ok
[INFO] [stdout] test keys::tests::test_natural_key_natural_ordering ... ok
[INFO] [stdout] test keys::tests::test_queryname_comparator_default_is_lexicographic ... ok
[INFO] [stdout] test keys::tests::test_queryname_comparator_display ... ok
[INFO] [stdout] test keys::tests::test_queryname_flag_order_complete_sort_order ... ok
[INFO] [stdout] test keys::tests::test_queryname_flag_order_exact_transformation_values ... ok
[INFO] [stdout] test keys::tests::test_queryname_flag_order_edge_case_both_r1_r2 ... ok
[INFO] [stdout] test keys::tests::test_queryname_flag_order_from_test_data ... ok
[INFO] [stdout] test keys::tests::test_queryname_flag_order_irrelevant_flags_do_not_affect_order ... ok
[INFO] [stdout] test keys::tests::test_queryname_flag_order_is_const ... ok
[INFO] [stdout] test keys::tests::test_queryname_flag_order_primary_before_supplementary_before_secondary ... ok
[INFO] [stdout] test keys::tests::test_queryname_flag_order_none_before_r1_before_r2 ... ok
[INFO] [stdout] test keys::tests::test_queryname_flag_order_r1_before_r2 ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_reflexive ... ok
[INFO] [stdout] test keys::tests::test_queryname_keys_embedded_in_record ... ok
[INFO] [stdout] test keys::tests::test_queryname_flag_order_real_world_flags ... ok
[INFO] [stdout] test keys::tests::test_sort_order_header_go_tag ... ok
[INFO] [stdout] test keys::tests::test_sort_order_is_queryname ... ok
[INFO] [stdout] test keys::tests::test_sort_order_header_so_tag ... ok
[INFO] [stdout] test keys::tests::test_sort_order_header_ss_tag ... ok
[INFO] [stdout] test loser_tree::tests::test_interleaved_merge ... ok
[INFO] [stdout] test keys::tests::test_sort_order_queryname_comparator ... ok
[INFO] [stdout] test loser_tree::tests::test_all_same_keys_stable ... ok
[INFO] [stdout] test loser_tree::tests::test_k_equals_7 ... ok
[INFO] [stdout] test loser_tree::tests::test_large_fan_in ... ok
[INFO] [stdout] test loser_tree::tests::test_many_sources_descending_keys ... ok
[INFO] [stdout] test loser_tree::tests::test_merge_longer_sequences ... ok
[INFO] [stdout] test loser_tree::tests::test_merge_three_sorted_sequences ... ok
[INFO] [stdout] test loser_tree::tests::test_merge_with_duplicates_stable ... ok
[INFO] [stdout] test loser_tree::tests::test_runner_up_follows_the_tree_as_the_winner_advances ... ok
[INFO] [stdout] test loser_tree::tests::test_non_power_of_two ... ok
[INFO] [stdout] test loser_tree::tests::test_runner_up_is_none_with_a_single_source ... ok
[INFO] [stdout] test loser_tree::tests::test_runner_up_is_the_second_smallest_key ... ok
[INFO] [stdout] test loser_tree::tests::test_runner_up_skips_an_exhausted_source ... ok
[INFO] [stdout] test loser_tree::tests::test_single_source ... ok
[INFO] [stdout] test loser_tree::tests::test_two_sources ... ok
[INFO] [stdout] test memory_probe::tests::test_log_snapshot_does_not_panic_without_logger ... ok
[INFO] [stdout] test memory_probe::tests::test_merge_probe_samples_at_interval ... ok
[INFO] [stdout] test memory_probe::tests::test_fmt_bytes_units ... ok
[INFO] [stdout] test loser_tree::tests::test_three_sources ... ok
[INFO] [stdout] test memory_probe::tests::test_process_rss_bytes_returns_plausible_value ... ok
[INFO] [stdout] test memory_probe::tests::test_spill_probe_increments ... ok
[INFO] [stdout] test merge_headroom::tests::test_a_loop_far_above_both_floors_reads_as_coordination ... ok
[INFO] [stdout] test merge_headroom::tests::test_a_saturated_consumer_binds_and_leaves_almost_nothing ... ok
[INFO] [stdout] test merge_headroom::tests::test_advance_separates_the_consumer_working_from_the_consumer_waiting ... ok
[INFO] [stdout] test merge_headroom::tests::test_advance_work_clamps_when_the_sample_lands_below_exact_park ... ok
[INFO] [stdout] test merge_headroom::tests::test_a_floor_above_the_loop_never_reports_negative_headroom ... ok
[INFO] [stdout] test merge_headroom::tests::test_an_incomplete_partition_reports_the_time_it_cannot_account_for ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_symmetry ... ok
[INFO] [stdout] test merge_headroom::tests::test_correction_is_a_no_op_without_a_calibration::case_1_no_samples ... ok
[INFO] [stdout] test merge_headroom::tests::test_correction_is_a_no_op_without_a_calibration::case_2_no_measurable_overhead ... ok
[INFO] [stdout] test merge_headroom::tests::test_correction_removes_one_clock_pair_per_segment_per_sample ... ok
[INFO] [stdout] test merge_headroom::tests::test_degenerate_inputs_are_finite::case_1_no_workers ... ok
[INFO] [stdout] test keys::tests::test_natural_compare_transitivity ... ok
[INFO] [stdout] test merge_headroom::tests::test_degenerate_inputs_are_finite::case_2_empty_loop ... ok
[INFO] [stdout] test merge_headroom::tests::test_over_attribution_stays_negative_instead_of_clamping ... ok
[INFO] [stdout] test merge_headroom::tests::test_a_segment_smaller_than_its_overhead_clamps_to_zero ... ok
[INFO] [stdout] test merge_phases::tests::test_classify_merge::case_1_measured_ebs_merge ... ok
[INFO] [stdout] test merge_phases::tests::test_classify_merge::case_2_measured_local_nvme ... ok
[INFO] [stdout] test merge_headroom::tests::test_worker_capacity_binds_when_it_is_the_larger_floor ... ok
[INFO] [stdout] test merge_headroom::tests::test_clock_calibration_is_plausible ... ok
[INFO] [stdout] test merge_headroom::tests::test_scaling_preserves_the_shape_of_the_sample ... ok
[INFO] [stdout] test merge_phases::tests::test_classify_merge::case_3_idle_pool_busy_consumer ... ok
[INFO] [stdout] test merge_phases::tests::test_classify_merge::case_5_at_saturation_boundary ... ok
[INFO] [stdout] test merge_phases::tests::test_classify_merge::case_4_busy_pool_waiting_consumer ... ok
[INFO] [stdout] test merge_phases::tests::test_classify_merge::case_6_just_below_saturation ... ok
[INFO] [stdout] test merge_phases::tests::test_counter_returns_the_closure_value ... ok
[INFO] [stdout] test merge_phases::tests::test_counter_accumulates_across_threads ... ok
[INFO] [stdout] test merge_phases::tests::test_empty_breakdown_is_reported_as_empty ... ok
[INFO] [stdout] test merge_phases::tests::test_saturation_takes_precedence_over_consumer_wait ... ok
[INFO] [stdout] test merge_stalls::tests::test_a_phase1_wait_recorded_after_the_merge_began_stays_out_of_the_merge ... ok
[INFO] [stdout] test merge_stalls::tests::test_a_sleeper_is_not_masked_by_a_busy_compress_queue ... ok
[INFO] [stdout] test merge_stalls::tests::test_awaited_groups_partition_the_census ... ok
[INFO] [stdout] test merge_stalls::tests::test_awaited_states_are_grouped_by_what_can_be_done_about_them ... ok
[INFO] [stdout] test merge_stalls::tests::test_bucket_table_matches_the_worker_loop_backoff ... ok
[INFO] [stdout] test merge_stalls::tests::test_census_attributes_parks_and_time_by_class ... ok
[INFO] [stdout] test merge_stalls::tests::test_census_sampling_interval ... ok
[INFO] [stdout] test merge_stalls::tests::test_census_shares_use_live_files ... ok
[INFO] [stdout] test merge_stalls::tests::test_census_starts_empty ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_scan::case_1_all_files_at_cap ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_scan::case_2_caps_split_across_both_stages ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_scan::case_3_every_file_fully_buffered ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_scan::case_4_everyone_waiting_on_a_peer_read ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_scan::case_6_no_reason_dominates ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_scan::case_5_quarter_contended_beats_a_larger_io_share ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_scan::case_7_merge_winding_down ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_stall::case_1_measured_disjoint_runs ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_stall::case_2_measured_interleaved_saturated ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_scan::case_8_nothing_observed ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_stall::case_3_measured_queryname_saturated ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_stall::case_4_unclaimed_with_idle_capacity ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_stall::case_6_contention_masks_the_other_shares ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_stall::case_5_block_not_read_yet ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_stall::case_8_nothing_dominates ... ok
[INFO] [stdout] test merge_stalls::tests::test_classify_stall::case_7_consumer_not_waiting ... ok
[INFO] [stdout] test merge_stalls::tests::test_combine_skip::case_2 ... ok
[INFO] [stdout] test merge_stalls::tests::test_combine_skip::case_1 ... ok
[INFO] [stdout] test merge_stalls::tests::test_combine_skip::case_3 ... ok
[INFO] [stdout] test merge_stalls::tests::test_combine_skip::case_4 ... ok
[INFO] [stdout] test merge_stalls::tests::test_combine_skip::case_6 ... ok
[INFO] [stdout] test merge_stalls::tests::test_combine_skip::case_7 ... ok
[INFO] [stdout] test merge_stalls::tests::prop_park_segments_partition_the_park ... ok
[INFO] [stdout] test merge_stalls::tests::test_combine_skip::case_8 ... ok
[INFO] [stdout] test merge_stalls::tests::test_combine_skip::case_9 ... ok
[INFO] [stdout] test merge_stalls::tests::test_combine_skip::case_5 ... ok
[INFO] [stdout] test merge_stalls::tests::test_discovery_lag_is_half_the_sleep_that_found_work ... ok
[INFO] [stdout] test merge_stalls::tests::test_empty_consumer_report_is_reported_as_empty ... ok
[INFO] [stdout] test merge_stalls::tests::test_deep_sleep_wake_share ... ok
[INFO] [stdout] test merge_stalls::tests::test_discovery_lag_uses_the_observed_wait_not_the_requested_backoff ... ok
[INFO] [stdout] test merge_stalls::tests::test_empty_scan_report_is_reported_as_empty ... ok
[INFO] [stdout] test merge_stalls::tests::test_first_parked_ignores_workers_outside_the_active_limit ... ok
[INFO] [stdout] test merge_stalls::tests::test_first_parked_reports_none_when_every_worker_is_running ... ok
[INFO] [stdout] test merge_stalls::tests::test_first_parked_starts_at_the_cursor_and_wraps ... ok
[INFO] [stdout] test merge_stalls::tests::test_first_parked_tolerates_an_empty_pool ... ok
[INFO] [stdout] test merge_stalls::tests::test_park_segments_always_partition_the_park::case_1 ... ok
[INFO] [stdout] test merge_stalls::tests::test_park_segments_always_partition_the_park::case_2 ... ok
[INFO] [stdout] test merge_stalls::tests::test_park_segments_always_partition_the_park::case_3 ... ok
[INFO] [stdout] test merge_stalls::tests::test_park_segments_always_partition_the_park::case_4 ... ok
[INFO] [stdout] test merge_stalls::tests::test_empty_wake_report_is_reported_as_empty ... ok
[INFO] [stdout] test merge_stalls::tests::test_park_segments_always_partition_the_park::case_5 ... ok
[INFO] [stdout] test merge_stalls::tests::test_park_supply_separates_coordination_from_priority_from_capacity::case_1_one_sleeper_is_coordination_loss ... ok
[INFO] [stdout] test merge_stalls::tests::test_park_supply_separates_coordination_from_priority_from_capacity::case_2_a_sleeper_outranks_a_full_compress_queue ... ok
[INFO] [stdout] test merge_stalls::tests::test_park_supply_separates_coordination_from_priority_from_capacity::case_3_nobody_free_with_compress_queued_is_priority ... ok
[INFO] [stdout] test merge_stalls::tests::test_park_time_is_attributed_per_source ... ok
[INFO] [stdout] test merge_stalls::tests::test_park_supply_separates_coordination_from_priority_from_capacity::case_4_nobody_free_and_nothing_queued_is_capacity ... ok
[INFO] [stdout] test merge_stalls::tests::test_restart_drops_everything_observed_before_the_merge_clock ... ok
[INFO] [stdout] test merge_stalls::tests::test_saturation_threshold_agrees_with_classify_merge ... ok
[INFO] [stdout] test merge_stalls::tests::test_live_excludes_drained_files ... ok
[INFO] [stdout] test merge_stalls::tests::test_scan_stats_accumulate_across_scans ... ok
[INFO] [stdout] test merge_stalls::tests::test_tally_counts_by_reason ... ok
[INFO] [stdout] test merge_stalls::tests::test_stall_rate_counts_pulls_not_parks ... ok
[INFO] [stdout] test merge_stalls::tests::test_unreadable_awaited_file_is_not_counted ... ok
[INFO] [stdout] test merge_phases::tests::test_counter_accumulates_time_and_ops ... ok
[INFO] [stdout] test merge_stalls::tests::test_wake_bucket::case_2 ... ok
[INFO] [stdout] test merge_stalls::tests::test_pool_width_denominator_contradicts_the_active_cap_verdict ... ok
[INFO] [stdout] test merge_stalls::tests::test_the_merge_report_holds_only_the_merges_own_waits ... ok
[INFO] [stdout] test merge_stalls::tests::test_wake_bucket::case_1 ... ok
[INFO] [stdout] test merge_stalls::tests::test_wake_bucket::case_3 ... ok
[INFO] [stdout] test merge_stalls::tests::test_wake_bucket::case_6 ... ok
[INFO] [stdout] test merge_trace::tests::test_bucket_floor::case_1 ... ok
[INFO] [stdout] test merge_trace::tests::test_bucket_floor::case_2 ... ok
[INFO] [stdout] test merge_trace::tests::test_bucket_floor::case_3 ... ok
[INFO] [stdout] test merge_stalls::tests::test_wake_bucket::case_5 ... ok
[INFO] [stdout] test merge_stalls::tests::test_wake_bucket::case_4 ... ok
[INFO] [stdout] test merge_trace::tests::test_bucket_floor::case_4 ... ok
[INFO] [stdout] test merge_trace::tests::test_bucket_of_nanos::case_1 ... ok
[INFO] [stdout] test merge_trace::tests::test_bucket_of_nanos::case_4 ... ok
[INFO] [stdout] test merge_trace::tests::test_bucket_of_nanos::case_2 ... ok
[INFO] [stdout] test merge_trace::tests::test_bucket_of_nanos::case_3 ... ok
[INFO] [stdout] test merge_trace::tests::test_bucket_of_nanos::case_5 ... ok
[INFO] [stdout] test merge_trace::tests::test_bucket_of_nanos::case_6 ... ok
[INFO] [stdout] test merge_trace::tests::test_bucket_of_nanos::case_8 ... ok
[INFO] [stdout] test merge_trace::tests::test_bucket_of_nanos::case_7 ... ok
[INFO] [stdout] test merge_trace::tests::test_bucket_saturates ... ok
[INFO] [stdout] test merge_trace::tests::test_claim_share_is_clamped ... ok
[INFO] [stdout] test merge_trace::tests::test_claim_share_splits_waiting_to_start_from_doing_the_work ... ok
[INFO] [stdout] test merge_trace::tests::test_consumer_trace_carries_park_time_per_state_not_only_counts ... ok
[INFO] [stdout] test merge_trace::tests::test_consumer_trace_counts_parks_by_concurrency ... ok
[INFO] [stdout] test merge_phases::tests::test_busy_time_may_exceed_wall_clock ... ok
[INFO] [stdout] test merge_trace::tests::test_consumer_trace_reports_depth_beyond_one_worker ... ok
[INFO] [stdout] test merge_trace::tests::test_empty_cause::case_1 ... ok
[INFO] [stdout] test merge_trace::tests::test_empty_cause::case_3 ... ok
[INFO] [stdout] test merge_trace::tests::test_empty_cause::case_2 ... ok
[INFO] [stdout] test merge_trace::tests::test_empty_cause::case_4 ... ok
[INFO] [stdout] test merge_trace::tests::test_empty_consumer_trace ... ok
[INFO] [stdout] test merge_trace::tests::test_empty_histogram_reports_zeroes ... ok
[INFO] [stdout] test merge_trace::tests::test_empty_lifecycle_report_is_not_pass_through ... ok
[INFO] [stdout] test merge_trace::tests::test_empty_refill_report ... ok
[INFO] [stdout] test merge_trace::tests::test_histogram_keeps_an_exact_mean_and_a_bucketed_tail ... ok
[INFO] [stdout] test merge_trace::tests::test_mean_in_flight_is_zero_without_parks ... ok
[INFO] [stdout] test merge_trace::tests::test_pass_through_reorder_buffer_is_detected ... ok
[INFO] [stdout] test merge_trace::tests::test_percentiles_are_zero_when_only_the_count_is_populated ... ok
[INFO] [stdout] test merge_trace::tests::test_percentiles_ignore_a_count_that_ran_ahead_of_the_buckets ... ok
[INFO] [stdout] test merge_trace::tests::test_percentiles_separate_distributions_with_equal_means ... ok
[INFO] [stdout] test merge_trace::tests::test_record_count_scales_small_counts_out_of_the_zero_bucket ... ok
[INFO] [stdout] test merge_trace::tests::test_source_run_length_is_recorded_in_blocks ... ok
[INFO] [stdout] test merge_trace::tests::test_source_run_summary_reports_blocks_not_durations ... ok
[INFO] [stdout] test merge_trace::tests::test_source_runs_alone_make_the_consumer_trace_non_empty ... ok
[INFO] [stdout] test phase1_keys::tests::test_a_batch_whose_receiver_is_gone_finishes_quietly ... ok
[INFO] [stdout] test phase1_keys::tests::test_a_batch_reports_the_lowest_indexed_violation_not_the_last ... ok
[INFO] [stdout] test phase1_keys::tests::test_a_batch_extracts_the_keys_serial_extraction_would_have ... ok
[INFO] [stdout] test phase1_keys::tests::test_a_batch_reads_at_its_segments_base_not_the_arenas ... ok
[INFO] [stdout] test phase1_keys::tests::test_a_single_worker_pool_still_rejects_a_dropped_lane ... ok
[INFO] [stdout] test phase1_keys::tests::test_a_single_worker_pool_keys_inline_and_reports_no_overlap ... ok
[INFO] [stdout] test phase1_keys::tests::test_a_multi_segment_ingest_keys_every_record_exactly_once ... ok
[INFO] [stdout] test phase1_stats::tests::test_a_failed_read_is_timed_but_credited_no_bytes ... ok
[INFO] [stdout] test phase1_stats::tests::test_a_reader_report_partitions_the_step_with_a_signed_residual ... ok
[INFO] [stdout] test phase1_keys::tests::test_a_multi_segment_ingest_reports_a_violation_in_a_sealed_segment ... ok
[INFO] [stdout] test phase1_stats::tests::test_framing_is_read_raw_time_with_the_refills_taken_out ... ok
[INFO] [stdout] test phase1_stats::tests::test_mean_park_is_absent_rather_than_zero_when_it_never_parked ... ok
[INFO] [stdout] test phase1_stats::tests::test_park_causes_are_counted_separately ... ok
[INFO] [stdout] test phase1_stats::tests::test_scaling_happens_before_correction_is_meaningful ... ok
[INFO] [stdout] test phase1_stats::tests::test_per_block_micros_reproduces_the_number_under_investigation ... ok
[INFO] [stdout] test phase1_stats::tests::test_schedstat_parses_the_kernel_format ... ok
[INFO] [stdout] test phase1_stats::tests::test_schedstat_refuses_a_line_it_does_not_understand ... ok
[INFO] [stdout] test phase1_stats::tests::test_clock_correction_subtracts_one_pair_per_segment_per_sample ... ok
[INFO] [stdout] test phase1_stats::tests::test_refill_throughput_is_measured_against_the_bytes_actually_returned ... ok
[INFO] [stdout] test phase1_stats::tests::test_the_spill_handoff_wait_is_counted_on_its_own ... ok
[INFO] [stdout] test pipeline::tests::test_config_custom_values ... ok
[INFO] [stdout] test pipeline::tests::test_config_default ... ok
[INFO] [stdout] test pipeline::tests::test_config_single_thread ... ok
[INFO] [stdout] test pipeline::tests::test_merge_buffer_size ... ok
[INFO] [stdout] test phase1_stats::tests::test_the_residual_is_signed_so_over_attribution_is_visible ... ok
[INFO] [stdout] test pipeline::tests::test_merge_entry_greater_than ... ok
[INFO] [stdout] test pipeline::tests::test_merge_entry_in_binary_heap ... ok
[INFO] [stdout] test pipeline::tests::test_merge_entry_ordering ... ok
[INFO] [stdout] test pipeline::tests::test_merge_entry_ordering_ignores_chunk_idx ... ok
[INFO] [stdout] test pipeline::tests::test_merge_entry_partial_eq ... ok
[INFO] [stdout] test pipeline::tests::test_merge_entry_partial_eq_different ... ok
[INFO] [stdout] test pipeline::tests::test_prefetch_buffer_size ... ok
[INFO] [stdout] test pipeline::tests::test_merge_entry_equal_keys ... ok
[INFO] [stdout] test pipeline::tests::test_merge_entry_string_keys ... ok
[INFO] [stdout] test pooled_bam_writer::tests::test_pooled_bam_writer_indexing_rejects_stdout::case_1_dash ... ok
[INFO] [stdout] test pooled_bam_writer::tests::test_drop_before_finish ... ok
[INFO] [stdout] test pooled_bam_writer::tests::test_pooled_bam_writer_empty ... ok
[INFO] [stdout] test pooled_bam_writer::tests::test_pooled_bam_writer_raw_bytes_match ... ok
[INFO] [stdout] test pooled_bam_writer::tests::test_pooled_bam_writer_indexing_rejects_stdout::case_2_dev_stdout ... ok
[INFO] [stdout] test pooled_bam_writer::tests::test_pooled_bam_writer_oversized_record ... ok
[INFO] [stdout] test pooled_bam_writer::tests::test_pooled_bam_writer_roundtrip ... ok
[INFO] [stdout] test pooled_chunk_writer::tests::test_drop_before_finish ... ok
[INFO] [stdout] test pooled_chunk_writer::tests::test_pooled_writer_empty ... ok
[INFO] [stdout] test pooled_chunk_writer::tests::test_appending_leaves_one_bgzf_terminator ... ok
[INFO] [stdout] test pooled_chunk_writer::tests::test_pooled_writer_roundtrip ... ok
[INFO] [stdout] test inline::tests::proptest_msd::msd_sort_matches_reference ... ok
[INFO] [stdout] test pooled_bam_writer::tests::test_indexing_writer_output_matches_plain_and_writes_bai ... ok
[INFO] [stdout] test pooled_chunk_writer::tests::test_spill_write_handle_drop_without_wait ... ok
[INFO] [stdout] test progress_batch::tests::test_atomic_is_touched_once_per_batch_not_once_per_record ... ok
[INFO] [stdout] test pooled_bam_writer::tests::test_writer_stats_include_finish_drain ... ok
[INFO] [stdout] test progress_batch::tests::test_unflushed_remainder_is_the_only_loss_and_flush_recovers_it ... ok
[INFO] [stdout] test radix::tests::test_bytes_needed ... ok
[INFO] [stdout] test radix::tests::test_heap_operations ... ok
[INFO] [stdout] test pooled_chunk_writer::tests::test_start_finish_and_wait ... ok
[INFO] [stdout] test radix::tests::test_insertion_sort_by_key ... ok
[INFO] [stdout] test radix::tests::test_insertion_sort_by_key_packed ... ok
[INFO] [stdout] test radix::tests::test_insertion_sort ... ok
[INFO] [stdout] test progress_batch::tests::test_batched_ticks_preserve_the_total ... ok
[INFO] [stdout] test radix::tests::test_pack_coordinate_for_radix ... ok
[INFO] [stdout] test pooled_chunk_writer::tests::test_pooled_writer_roundtrip_zstd ... ok
[INFO] [stdout] test radix::tests::test_packed_coordinate_key ... ok
[INFO] [stdout] test radix::tests::test_packed_coordinate_key_unmapped ... ok
[INFO] [stdout] test radix::tests::test_radix_sort_coordinate_adaptive_large ... ok
[INFO] [stdout] test radix::tests::test_radix_sort_adaptive ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_body_exact_boundary_and_straddle ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_empty_stream ... ok
[INFO] [stdout] test pooled_bam_writer::tests::test_pooled_bam_writer_many_records ... ok
[INFO] [stdout] test read_ahead::tests::test_default_batch_config ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_matches_input_across_block_sizes::block_len_03_3 ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_matches_input_across_block_sizes::block_len_02_2 ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_matches_input_across_block_sizes::block_len_04_4 ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_matches_input_across_block_sizes::block_len_01_1usize ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_matches_input_across_block_sizes::block_len_05_5 ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_matches_input_across_block_sizes::block_len_06_6 ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_matches_input_across_block_sizes::block_len_09_16 ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_matches_input_across_block_sizes::block_len_08_8 ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_matches_input_across_block_sizes::block_len_10_64 ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_matches_input_across_block_sizes::block_len_12_65_535 ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_matches_input_across_block_sizes::block_len_11_1024 ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_matches_input_across_block_sizes::block_len_07_7 ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_parity_with_read_record::block_len_4_64 ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_parity_with_read_record::block_len_1_1usize ... ok
[INFO] [stdout] test pooled_chunk_writer::tests::test_pooled_writer_large_records ... ok
[INFO] [stdout] test read_ahead::tests::test_prefetch_total_records ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_parity_with_read_record::block_len_2_3 ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_prefix_straddle ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_parity_with_read_record::block_len_3_7 ... ok
[INFO] [stdout] test read_ahead::tests::test_next_record_borrowed_truncated_body_errors ... ok
[INFO] [stdout] test read_ahead::tests::test_read_ahead_polled_past_the_eof_sentinel_reports_no_error ... ok
[INFO] [stdout] test read_ahead::tests::test_read_ahead_reports_a_reader_thread_that_died_before_eof ... ok
[INFO] [stdout] test read_ahead::tests::test_stream_next_record_borrowed_matches_owned_iteration ... ok
[INFO] [stdout] test read_ahead::tests::test_stream_next_record_borrowed_surfaces_producer_error ... ok
[INFO] [stdout] test reader::tests::test_batched_reader_eof ... ok
[INFO] [stdout] test reader::tests::test_blocks_per_batch ... ok
[INFO] [stdout] test reader::tests::test_from_buf_reader ... ok
[INFO] [stdout] test read_ahead::tests::test_raw_read_ahead_multiple ... ok
[INFO] [stdout] test read_ahead::tests::test_raw_read_ahead_empty ... ok
[INFO] [stdout] test reader::tests::test_iterator_adapter ... ok
[INFO] [stdout] test reader::tests::test_new_invalid_magic ... ok
[INFO] [stdout] test reader::tests::test_new_valid_bam ... ok
[INFO] [stdout] test reader::tests::test_batched_reader ... ok
[INFO] [stdout] test reader::tests::test_next_record_without_skip_header_errors ... ok
[INFO] [stdout] test reader::tests::test_new_empty_input ... ok
[INFO] [stdout] test reader::tests::test_read_multiple_records ... ok
[INFO] [stdout] test reader::tests::test_read_single_record ... ok
[INFO] [stdout] test read_ahead::tests::test_read_ahead_next_record_borrowed_matches_owned_iteration ... ok
[INFO] [stdout] test reader::tests::test_skip_header_returns_bytes ... ok
[INFO] [stdout] test reader::tests::test_skip_header_twice_errors ... ok
[INFO] [stdout] test segmented_buf::tests::test_a_sealed_segment_is_readable_while_later_segments_are_written ... ok
[INFO] [stdout] test segmented_buf::tests::test_a_segment_seals_only_once_a_later_one_starts ... ok
[INFO] [stdout] test segmented_buf::tests::test_consecutive_writes_same_segment ... ok
[INFO] [stdout] test segmented_buf::tests::test_extend_and_len ... ok
[INFO] [stdout] test segmented_buf::tests::test_clear_resets ... ok
[INFO] [stdout] test segmented_buf::tests::test_many_segments ... ok
[INFO] [stdout] test segmented_buf::tests::test_memory_usage_includes_gaps ... ok
[INFO] [stdout] test segmented_buf::tests::test_new_is_empty ... ok
[INFO] [stdout] test segmented_buf::tests::test_offset_accounting_with_gaps ... ok
[INFO] [stdout] test segmented_buf::tests::test_reserve_contiguous_then_multi_part_write ... ok
[INFO] [stdout] test segmented_buf::tests::test_reset_for_reuse_keeps_the_segment_allocations ... ok
[INFO] [stdout] test segmented_buf::tests::test_reset_for_reuse_lets_go_of_a_segment_a_reader_still_holds ... ok
[INFO] [stdout] test segmented_buf::tests::test_realistic_record_pattern ... ok
[INFO] [stdout] test segmented_buf::tests::test_segment_boundary ... ok
[INFO] [stdout] test segmented_buf::tests::test_spill_to_new_segment_when_not_enough_room ... ok
[INFO] [stdout] test segmented_buf::tests::test_slice_retrieval ... ok
[INFO] [stdout] test inline::tests::proptest_msd::msd_sort_matches_reference_random_keys ... ok
[INFO] [stdout] test segmented_buf::tests::test_write_exceeding_segment_panics - should panic ... ok
[INFO] [stdout] test spill_reader::tests::test_an_empty_file_reads_as_eof_rather_than_hanging ... ok
[INFO] [stdout] test spill_reader::tests::test_an_incomplete_probe_decides_nothing ... ok
[INFO] [stdout] test read_ahead::tests::prop_next_record_borrowed_matches_input ... ok
[INFO] [stdout] test spill_reader::tests::test_a_failed_fill_keeps_failing_instead_of_hanging ... ok
[INFO] [stdout] test spill_reader::tests::test_a_fill_completes_when_no_worker_ever_takes_a_slice ... ok
[INFO] [stdout] test spill_reader::tests::test_exactly_one_caller_ever_runs_a_slice ... ok
[INFO] [stdout] test spill_reader::tests::test_a_scattered_read_matches_the_sequential_one_it_replaces ... ok
[INFO] [stdout] test spill_reader::tests::test_a_failed_fill_rewinds_so_the_next_read_retries_the_same_bytes ... ok
[INFO] [stdout] test spill_reader::tests::test_lookahead_does_not_run_ahead_of_the_end_of_the_file ... ok
[INFO] [stdout] test spill_reader::tests::test_delivers_the_file_verbatim_at_every_stream_count ... ok
[INFO] [stdout] test spill_reader::tests::test_one_stream_offers_nothing ... ok
[INFO] [stdout] test spill_reader::tests::test_read_streams_parses_what_a_user_would_type ... ok
[INFO] [stdout] test spill_reader::tests::test_read_streams_round_trips_through_its_display ... ok
[INFO] [stdout] test spill_reader::tests::test_readers_sharing_a_queue_share_one_measurement ... ok
[INFO] [stdout] test spill_reader::tests::test_buffers_recycled_through_many_fills_deliver_the_file_verbatim ... ok
[INFO] [stdout] test spill_reader::tests::test_a_worker_draining_the_queue_never_corrupts_the_bytes ... ok
[INFO] [stdout] test spill_reader::tests::test_the_probe_decides_once_and_then_stops_measuring ... ok
[INFO] [stdout] test spill_reader::tests::test_the_probe_is_capped_however_slow_the_device ... ok
[INFO] [stdout] test spill_reader::tests::test_the_probe_picks_the_stream_count_each_measured_device_wanted ... ok
[INFO] [stdout] test spill_reader::tests::test_the_probe_refuses_to_divide_by_a_degenerate_measurement ... ok
[INFO] [stdout] test spill_reader::tests::test_the_probe_scales_between_those_two_points ... ok
[INFO] [stdout] test spill_reader::tests::test_reading_starts_at_the_requested_offset ... ok
[INFO] [stdout] test tests::test_create_output_header_clears_stale_sort_tags ... ok
[INFO] [stdout] test tests::test_create_output_header_no_existing_hd ... ok
[INFO] [stdout] test tests::test_create_output_header_preserves_vn ... ok
[INFO] [stdout] test tests::test_create_output_header_ss_has_sort_order_prefix ... ok
[INFO] [stdout] test tests::test_create_temp_dir_default ... ok
[INFO] [stdout] test tests::test_create_temp_dir_with_base ... ok
[INFO] [stdout] test tests::test_header_declares_order_accepts_fgumi_own_output ... ok
[INFO] [stdout] test tests::test_header_declares_order_discriminates_queryname_flavors ... ok
[INFO] [stdout] test tests::test_header_declares_order_matches_coordinate ... ok
[INFO] [stdout] test tests::test_header_declares_order_needs_no_hd_line ... ok
[INFO] [stdout] test tests::test_header_declares_order_queryname_without_subsort_is_ambiguous ... ok
[INFO] [stdout] test tests::test_header_declares_order_rejects_a_different_order ... ok
[INFO] [stdout] test tests::test_header_declares_order_template_coordinate_requires_subsort ... ok
[INFO] [stdout] test tests::test_sort_stats_default ... ok
[INFO] [stdout] test tmp_dir_alloc::tests::test_all_dirs_below_threshold_errors ... ok
[INFO] [stdout] test tmp_dir_alloc::tests::test_initial_free_space_filter ... ok
[INFO] [stdout] test tmp_dir_alloc::tests::test_mark_full_all_exhausts ... ok
[INFO] [stdout] test tmp_dir_alloc::tests::test_mark_full_at_cursor_wraps_cleanly ... ok
[INFO] [stdout] test tmp_dir_alloc::tests::test_mark_full_preserves_round_robin_order ... ok
[INFO] [stdout] test tmp_dir_alloc::tests::test_mark_full_skips_dir ... ok
[INFO] [stdout] test tmp_dir_alloc::tests::test_new_empty_errors ... ok
[INFO] [stdout] test tmp_dir_alloc::tests::test_periodic_recheck_drops_dir ... ok
[INFO] [stdout] test tmp_dir_alloc::tests::test_periodic_recheck_preserves_round_robin_order ... ok
[INFO] [stdout] test tmp_dir_alloc::tests::test_single_dir_always_returns_same ... ok
[INFO] [stdout] test tmp_dir_alloc::tests::test_startup_filter_honors_threshold_argument ... ok
[INFO] [stdout] test tmp_dir_alloc::tests::test_two_dirs_round_robin ... ok
[INFO] [stdout] test worker_pool::tests::a_bigger_block_needs_fewer_blocks_per_refill ... ok
[INFO] [stdout] test worker_pool::tests::a_file_is_starving_only_with_nothing_buffered_and_nothing_coming::case_1_nothing_buffered_or_in_flight ... ok
[INFO] [stdout] test worker_pool::tests::a_file_is_starving_only_with_nothing_buffered_and_nothing_coming::case_2_blocks_buffered ... ok
[INFO] [stdout] test worker_pool::tests::a_file_is_starving_only_with_nothing_buffered_and_nothing_coming::case_3_decompression_in_flight ... ok
[INFO] [stdout] test worker_pool::tests::a_file_is_starving_only_with_nothing_buffered_and_nothing_coming::case_4_both ... ok
[INFO] [stdout] test worker_pool::tests::a_tiny_block_size_clamps_the_refill::case_1_two_hundred_byte_blocks ... ok
[INFO] [stdout] test worker_pool::tests::a_tiny_block_size_clamps_the_refill::case_2_one_byte_blocks ... ok
[INFO] [stdout] test spill_reader::tests::test_lookahead_delivers_the_file_verbatim_at_every_stream_count ... ok
[INFO] [stdout] test worker_pool::tests::active_workers_reports_the_phase2_cap_not_the_pool_width ... ok
[INFO] [stdout] test worker_pool::tests::an_oversized_block_floors_at_the_shallow_batch ... ok
[INFO] [stdout] test worker_pool::tests::disarmed_worker_panic_guard_does_not_set_flag ... ok
[INFO] [stdout] test worker_pool::tests::disarmed_worker_panic_guard_releases_its_shared_arc ... ok
[INFO] [stdout] test worker_pool::tests::jitter_spreads_waits_both_sides_of_the_backoff::backoff_us_1_20u64 ... ok
[INFO] [stdout] test worker_pool::tests::jitter_spreads_waits_both_sides_of_the_backoff::backoff_us_2_40 ... ok
[INFO] [stdout] test worker_pool::tests::jitter_spreads_waits_both_sides_of_the_backoff::backoff_us_3_80 ... ok
[INFO] [stdout] test worker_pool::tests::jitter_spreads_waits_both_sides_of_the_backoff::backoff_us_4_160 ... ok
[INFO] [stdout] test worker_pool::tests::jitter_spreads_waits_both_sides_of_the_backoff::backoff_us_5_320 ... ok
[INFO] [stdout] test worker_pool::tests::jitter_spreads_waits_both_sides_of_the_backoff::backoff_us_6_640 ... ok
[INFO] [stdout] test worker_pool::tests::jitter_spreads_waits_both_sides_of_the_backoff::backoff_us_7_1000 ... ok
[INFO] [stdout] test worker_pool::tests::one_refill_is_sized_in_bytes_not_blocks::case_1_ten_kb_blocks ... ok
[INFO] [stdout] test worker_pool::tests::one_refill_is_sized_in_bytes_not_blocks::case_2_sixty_four_kb_bgzf_blocks ... ok
[INFO] [stdout] test worker_pool::tests::one_refill_is_sized_in_bytes_not_blocks::case_3_quarter_mb_zstd_frames ... ok
[INFO] [stdout] test worker_pool::tests::permit_pool_acquire_fails_immediately_after_close ... ok
[INFO] [stdout] test worker_pool::tests::permit_pool_close_unblocks_parked_acquirers_with_error ... ok
[INFO] [stdout] test worker_pool::tests::permit_pool_hands_out_permits_up_to_capacity ... ok
[INFO] [stdout] test worker_pool::tests::permit_pool_release_after_close_is_a_noop ... ok
[INFO] [stdout] test worker_pool::tests::phase2_read_allowance_is_scoped_to_the_frontier::case_1_frontier_reads_deep ... ok
[INFO] [stdout] test worker_pool::tests::phase2_read_allowance_is_scoped_to_the_frontier::case_2_every_other_file_reads_shallow ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_prefers_a_starving_awaited_source::case_1_starving_awaited_outranks_a_starving_frontier ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_prefers_a_starving_awaited_source::case_2_starving_awaited_outranks_an_active_frontier ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_prefers_a_starving_awaited_source::case_3_starving_awaited_beats_the_cursor ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_prefers_a_starving_awaited_source::case_4_active_awaited_defers_to_a_starving_frontier ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_prefers_a_starving_awaited_source::case_5_active_awaited_defers_to_the_cursor ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_prefers_a_starving_awaited_source::case_6_unset_awaited_defers ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_prefers_a_starving_awaited_source::case_7_awaited_past_the_end_defers ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_prefers_a_starving_awaited_source::case_8_no_files_defers ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_starts_at_a_starving_frontier::case_1_starving_frontier_is_served_first ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_starts_at_a_starving_frontier::case_2_starving_frontier_mid_pool ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_starts_at_a_starving_frontier::case_3_active_frontier_defers_to_the_cursor ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_starts_at_a_starving_frontier::case_4_active_frontier_mid_pool ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_starts_at_a_starving_frontier::case_5_frontier_past_the_end_defers ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_starts_at_a_starving_frontier::case_6_frontier_far_past_the_end_defers ... ok
[INFO] [stdout] test worker_pool::tests::phase2_scan_starts_at_a_starving_frontier::case_7_no_files_defers ... ok
[INFO] [stdout] test worker_pool::tests::productive_wait_is_scoped_to_the_phase_it_ran_in::case_1_same_phase_wait_is_charged ... ok
[INFO] [stdout] test worker_pool::tests::productive_wait_is_scoped_to_the_phase_it_ran_in::case_2_phase1_wait_is_not_charged_to_phase2 ... ok
[INFO] [stdout] test worker_pool::tests::productive_wait_is_scoped_to_the_phase_it_ran_in::case_3_phase2_wait_is_not_charged_to_phase1 ... ok
[INFO] [stdout] test worker_pool::tests::productive_wait_is_scoped_to_the_phase_it_ran_in::case_4_a_phase1_wait_within_phase1_is_charged ... ok
[INFO] [stdout] test worker_pool::tests::productive_wait_is_scoped_to_the_phase_it_ran_in::case_5_no_pending_wait ... ok
[INFO] [stdout] test worker_pool::tests::read_batch_respects_the_raw_fifo_entry_and_byte_bounds::case_01_far_below_the_cap_reads_a_full_batch ... ok
[INFO] [stdout] test worker_pool::tests::read_batch_respects_the_raw_fifo_entry_and_byte_bounds::case_02_shallow_path_far_below_the_cap ... ok
[INFO] [stdout] test worker_pool::tests::read_batch_respects_the_raw_fifo_entry_and_byte_bounds::case_03_one_below_the_frontier_cap_reads_one ... ok
[INFO] [stdout] test worker_pool::tests::read_batch_respects_the_raw_fifo_entry_and_byte_bounds::case_04_one_below_the_shallow_cap_reads_one ... ok
[INFO] [stdout] test worker_pool::tests::read_batch_respects_the_raw_fifo_entry_and_byte_bounds::case_05_headroom_shorter_than_the_batch ... ok
[INFO] [stdout] test worker_pool::tests::read_batch_respects_the_raw_fifo_entry_and_byte_bounds::case_06_at_the_cap_declines ... ok
[INFO] [stdout] test worker_pool::tests::read_batch_respects_the_raw_fifo_entry_and_byte_bounds::case_07_past_the_cap_declines ... ok
[INFO] [stdout] test worker_pool::tests::read_batch_respects_the_raw_fifo_entry_and_byte_bounds::case_08_byte_budget_reached_declines_despite_entry_headroom ... ok
[INFO] [stdout] test worker_pool::tests::read_batch_respects_the_raw_fifo_entry_and_byte_bounds::case_09_byte_budget_exceeded_declines ... ok
[INFO] [stdout] test worker_pool::tests::read_batch_respects_the_raw_fifo_entry_and_byte_bounds::case_10_under_the_byte_budget_reads_a_full_batch ... ok
[INFO] [stdout] test worker_pool::tests::read_raw_zstd_frames_stops_at_the_byte_budget ... ok
[INFO] [stdout] test spill_reader::tests::test_lookahead_keeps_the_next_fill_in_flight_while_the_consumer_reads ... ok
[INFO] [stdout] test worker_pool::tests::set_active_workers_clamps ... ok
[INFO] [stdout] test worker_pool::tests::test_a_cycle_that_rolled_over_mid_sample_rejects_the_sample ... ok
[INFO] [stdout] test worker_pool::tests::test_a_sample_binds_only_to_a_cycle_that_preceded_it::case_2_event_at_the_instant_it_opened ... ok
[INFO] [stdout] test worker_pool::tests::test_a_sample_binds_only_to_a_cycle_that_preceded_it::case_3_cycle_opened_after_the_event ... ok
[INFO] [stdout] test worker_pool::tests::test_admission_at_cap_poppable_rejects ... ok
[INFO] [stdout] test worker_pool::tests::test_a_sample_binds_only_to_a_cycle_that_preceded_it::case_1_event_after_the_cycle_opened ... ok
[INFO] [stdout] test worker_pool::tests::test_admission_at_cap_stuck_wrong_head_rejects ... ok
[INFO] [stdout] test worker_pool::tests::test_admission_at_cap_stuck_admits_gap_filler ... ok
[INFO] [stdout] test worker_pool::tests::test_admission_empty_raw_reports_raw_empty ... ok
[INFO] [stdout] test worker_pool::tests::test_buffer_pool_checkout_empty ... ok
[INFO] [stdout] test worker_pool::tests::test_admission_under_cap_admits ... ok
[INFO] [stdout] test worker_pool::tests::test_buffer_pool_full_drops_excess ... ok
[INFO] [stdout] test worker_pool::tests::test_buffer_pool_recycle ... ok
[INFO] [stdout] test worker_pool::tests::test_compress_target_decides_level_regardless_of_phase::case_2_phase1 ... ok
[INFO] [stdout] test worker_pool::tests::test_compress_target_decides_level_regardless_of_phase::case_3_phase2 ... ok
[INFO] [stdout] test worker_pool::tests::test_dispatch_reserved_blocks_accounts_for_every_serial::case_1_all_fit ... ok
[INFO] [stdout] test worker_pool::tests::test_dispatch_reserved_blocks_accounts_for_every_serial::case_2_queue_fills_mid_batch ... ok
[INFO] [stdout] test worker_pool::tests::test_dispatch_reserved_blocks_accounts_for_every_serial::case_3_empty_batch ... ok
[INFO] [stdout] test worker_pool::tests::test_emptied_while_dry_tracks_the_cause_the_cycle_opened_with::case_1_nothing_anywhere ... ok
[INFO] [stdout] test worker_pool::tests::test_emptied_while_dry_tracks_the_cause_the_cycle_opened_with::case_2_raw_block_already_queued ... ok
[INFO] [stdout] test worker_pool::tests::test_emptied_while_dry_tracks_the_cause_the_cycle_opened_with::case_3_decompression_already_in_flight ... ok
[INFO] [stdout] test worker_pool::tests::test_compress_target_decides_level_regardless_of_phase::case_1_legacy ... ok
[INFO] [stdout] test worker_pool::tests::test_emptied_while_dry_tracks_the_cause_the_cycle_opened_with::case_4_both ... ok
[INFO] [stdout] test worker_pool::tests::test_first_claim_since_empty_fires_once_per_refill_cycle ... ok
[INFO] [stdout] test worker_pool::tests::test_fetch_bytes_outranks_every_other_step_in_every_state ... ok
[INFO] [stdout] test worker_pool::tests::test_first_read_since_empty_fires_once_per_refill_cycle ... ok
[INFO] [stdout] test worker_pool::tests::test_is_drained_blocks_on_pending_decompressed ... ok
[INFO] [stdout] test worker_pool::tests::test_is_drained_blocks_on_pending_raw ... ok
[INFO] [stdout] test worker_pool::tests::test_is_drained_short_circuits_once_retired ... ok
[INFO] [stdout] test worker_pool::tests::test_is_drained_respects_in_flight_counter ... ok
[INFO] [stdout] test worker_pool::tests::test_no_sample_binds_when_no_cycle_is_open ... ok
[INFO] [stdout] test worker_pool::tests::test_pipeline_stats_log_summary_does_not_panic ... ok
[INFO] [stdout] test worker_pool::tests::test_pipeline_stats_record_step_and_idle ... ok
[INFO] [stdout] test worker_pool::tests::test_pool_compress_roundtrip ... ok
[INFO] [stdout] test worker_pool::tests::test_pool_stats ... ok
[INFO] [stdout] test worker_pool::tests::test_pool_stats_log_summary ... ok
[INFO] [stdout] test worker_pool::tests::active_worker_limit_caps_then_reactivates ... ok
[INFO] [stdout] test worker_pool::tests::test_raw_len_mirror_tracks_the_deque_across_a_pop::case_1_pop_leaves_the_fifo_empty ... ok
[INFO] [stdout] test worker_pool::tests::test_published_predictions_are_counted_and_absent_ones_are_not ... ok
[INFO] [stdout] test worker_pool::tests::test_raw_len_mirror_tracks_the_deque_across_a_pop::case_2_pop_leaves_the_rest_behind ... ok
[INFO] [stdout] test worker_pool::tests::test_read_length_prefix_clean_eof_returns_none ... ok
[INFO] [stdout] test worker_pool::tests::test_read_length_prefix_oversized_is_invalid_data ... ok
[INFO] [stdout] test worker_pool::tests::test_read_length_prefix_partial_prefix_is_unexpected_eof::case_1 ... ok
[INFO] [stdout] test worker_pool::tests::test_pool_many_jobs ... ok
[INFO] [stdout] test worker_pool::tests::test_read_length_prefix_valid ... ok
[INFO] [stdout] test worker_pool::tests::test_read_length_prefix_partial_prefix_is_unexpected_eof::case_2 ... ok
[INFO] [stdout] test worker_pool::tests::test_read_length_prefix_partial_prefix_is_unexpected_eof::case_3 ... ok
[INFO] [stdout] test worker_pool::tests::test_read_raw_zstd_frames_reads_multiple_frames ... ok
[INFO] [stdout] test worker_pool::tests::test_read_raw_zstd_frames_truncated_body_is_unexpected_eof ... ok
[INFO] [stdout] test worker_pool::tests::test_read_raw_zstd_frames_clean_eof_returns_empty ... ok
[INFO] [stdout] test worker_pool::tests::test_set_phase2_files_clears_the_read_ahead_prediction ... ok
[INFO] [stdout] test worker_pool::tests::test_set_phase2_files_detects_bgzf_magic_and_keeps_position_zero ... ok
[INFO] [stdout] test worker_pool::tests::test_set_phase2_files_restarts_the_drain_frontier ... ok
[INFO] [stdout] test worker_pool::tests::test_set_phase2_files_empty_file_falls_back_to_bgzf ... ok
[INFO] [stdout] test worker_pool::tests::test_sort_priorities_legacy_drains_compress_and_no_phased_work ... ok
[INFO] [stdout] test worker_pool::tests::test_set_phase2_files_detects_zstd_magic_and_seeks_past_it ... ok
[INFO] [stdout] test worker_pool::tests::test_sort_priorities_phase1_compress_backpressure ... ok
[INFO] [stdout] test worker_pool::tests::test_set_phase2_files_restarts_the_refill_sizing_counters ... ok
[INFO] [stdout] test worker_pool::tests::test_sort_priorities_phase1_default_feeds_main_thread ... ok
[INFO] [stdout] test worker_pool::tests::test_sort_priorities_phase1_all_done_offers_no_input_or_compress_work ... ok
[INFO] [stdout] test worker_pool::tests::test_sort_priorities_phase2_always_offers_both_steps::case_1_consumer_parked ... ok
[INFO] [stdout] test worker_pool::tests::test_sort_priorities_phase2_compress_backpressure ... ok
[INFO] [stdout] test worker_pool::tests::test_sort_priorities_phase2_always_offers_both_steps::case_2_consumer_running ... ok
[INFO] [stdout] test worker_pool::tests::test_sort_priorities_phase2_keeps_compress_first_when_consumer_runs ... ok
[INFO] [stdout] test worker_pool::tests::test_sort_priorities_phase2_after_eof_still_drains_files ... ok
[INFO] [stdout] test worker_pool::tests::test_sort_priorities_phase2_parked_consumer_outranks_compression ... ok
[INFO] [stdout] test worker_pool::tests::test_the_read_and_claim_flags_are_independent ... ok
[INFO] [stdout] test worker_pool::tests::test_sort_priorities_phase2_default_feeds_merge_loop ... ok
[INFO] [stdout] test worker_pool::tests::test_the_worker_that_owns_the_reader_does_not_take_key_batches ... ok
[INFO] [stdout] test worker_pool::tests::test_wake_falls_back_to_rotation_when_nobody_is_parked ... ok
[INFO] [stdout] test worker_pool::tests::test_wake_keeps_the_rotating_target_when_it_is_itself_parked ... ok
[INFO] [stdout] test worker_pool::tests::test_wake_one_worker_rotates_across_the_pool ... ok
[INFO] [stdout] test worker_pool::tests::test_wake_preference_ignores_workers_outside_the_active_limit ... ok
[INFO] [stdout] test worker_pool::tests::test_wake_preference_rotates_across_several_sleepers ... ok
[INFO] [stdout] test worker_pool::tests::test_the_pool_runs_every_submitted_key_job ... ok
[INFO] [stdout] test worker_pool::tests::test_wake_prefers_a_parked_worker_over_the_rotating_target ... ok
[INFO] [stdout] test worker_pool::tests::test_wake_one_worker_unparks_a_registered_worker ... ok
[INFO] [stdout] test worker_pool::tests::test_workers_stay_awake_for_key_batches_after_the_input_is_drained ... ok
[INFO] [stdout] test worker_pool::tests::the_blocked_file_reads_deep_even_when_it_is_not_the_frontier::case_1_frontier_only ... ok
[INFO] [stdout] test worker_pool::tests::the_blocked_file_reads_deep_even_when_it_is_not_the_frontier::case_2_awaited_only ... ok
[INFO] [stdout] test worker_pool::tests::the_blocked_file_reads_deep_even_when_it_is_not_the_frontier::case_3_neither ... ok
[INFO] [stdout] test worker_pool::tests::the_blocked_file_reads_deep_even_when_it_is_not_the_frontier::case_4_no_awaited_source_yet ... ok
[INFO] [stdout] test worker_pool::tests::the_blocked_file_reads_deep_even_when_it_is_not_the_frontier::case_5_predicted_next_source ... ok
[INFO] [stdout] test worker_pool::tests::the_blocked_file_reads_deep_even_when_it_is_not_the_frontier::case_6_predicted_next_is_not_the_candidate ... ok
[INFO] [stdout] test worker_pool::tests::test_worker_pool_num_workers ... ok
[INFO] [stdout] test worker_pool::tests::the_blocked_file_reads_deep_even_when_it_is_not_the_frontier::case_7_no_prediction_yet ... ok
[INFO] [stdout] test worker_pool::tests::unmeasured_block_size_falls_back_to_the_shipped_defaults ... ok
[INFO] [stdout] test worker_pool::tests::wake_target_rotates_only_over_workers_that_can_take_phase2_work::case_2_capped_pool_wraps_at_the_cap ... ok
[INFO] [stdout] test worker_pool::tests::wake_target_rotates_only_over_workers_that_can_take_phase2_work::case_3_capped_pool_never_selects_a_capped_worker ... ok
[INFO] [stdout] test worker_pool::tests::wake_target_rotates_only_over_workers_that_can_take_phase2_work::case_4_capped_pool_keeps_rotating_past_the_wrap ... ok
[INFO] [stdout] test worker_pool::tests::wake_target_rotates_only_over_workers_that_can_take_phase2_work::case_1_capped_pool_rotates_only_over_active_workers ... ok
[INFO] [stdout] test worker_pool::tests::wake_target_rotates_only_over_workers_that_can_take_phase2_work::case_5_uncapped_pool_rotates_over_the_whole_width ... ok
[INFO] [stdout] test worker_pool::tests::wake_target_rotates_only_over_workers_that_can_take_phase2_work::case_6_uncapped_pool_wraps_at_the_width ... ok
[INFO] [stdout] test worker_pool::tests::wake_target_rotates_only_over_workers_that_can_take_phase2_work::case_8_zero_limit_falls_back_to_one_worker ... ok
[INFO] [stdout] test worker_pool::tests::test_zstd_output_job_trips_the_spill_only_assert - should panic ... ok
[INFO] [stdout] test worker_pool::tests::wake_target_rotates_only_over_workers_that_can_take_phase2_work::case_7_limit_above_the_width_is_clamped ... ok
[INFO] [stdout] test zspill_stream::tests::missing_magic_errors ... ok
[INFO] [stdout] test zspill_stream::tests::oversized_length_prefix_errors ... ok
[INFO] [stdout] test spill_reader::tests::test_position_ignores_bytes_that_are_only_in_flight ... ok
[INFO] [stdout] test zspill_stream::tests::roundtrip_empty_body ... ok
[INFO] [stdout] test zspill_stream::tests::truncated_frame_body_errors ... ok
[INFO] [stdout] test zspill_stream::tests::truncated_length_prefix_errors::case_2 ... ok
[INFO] [stdout] test zspill_stream::tests::truncated_length_prefix_errors::case_3 ... ok
[INFO] [stdout] test zspill_stream::tests::truncated_length_prefix_errors::case_1 ... ok
[INFO] [stdout] test zspill_stream::tests::roundtrip_three_frames ... ok
[INFO] [stdout] test worker_pool::tests::worker_panic_sets_flag_before_shutdown ... ok
[INFO] [stdout] test spill_reader::tests::test_tiny_reads_reassemble_across_slice_boundaries ... ok
[INFO] [stdout] test spill_reader::tests::test_lookahead_keeps_the_depth_it_was_given_in_flight ... ok
[INFO] [stdout] test spill_reader::tests::test_scattered_reading_spawns_no_threads_of_its_own ... FAILED
[INFO] [stdout] test external::tests::test_sort_stats_true_drives_diagnostics_through_a_spilling_merge ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- spill_reader::tests::test_scattered_reading_spawns_no_threads_of_its_own stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'spill_reader::tests::test_scattered_reading_spawns_no_threads_of_its_own' (6115) panicked at src/spill_reader.rs:1126:9:
[INFO] [stdout] assertion `left == right` failed: the reader spawned threads outside the pool
[INFO] [stdout]   left: 21
[INFO] [stdout]  right: 20
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x637c8f5d1781 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x637c8f5d1781 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x637c8f5d1781 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x637c8f5d1781 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x637c8f5e96ea - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x637c8f5e96ea - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x637c8f5d7aec - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x637c8f5d7aec - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x637c8f5a9876 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x637c8f5a9876 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x637c8f5c7ed9 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x637c8f0f2050 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x637c8f0f2050 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x637c8f5c8202 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x637c8f5c8202 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x637c8f5a9922 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x637c8f5a1a49 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x637c8f5aa95d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x637c8f5e9f8c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x637c8f5e9e83 - core[a373ad73a504971]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:447:23
[INFO] [stdout]   20:     0x637c8f5e5b1d - core[a373ad73a504971]::panicking::assert_failed::<usize, usize>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:407:5
[INFO] [stdout]   21:     0x637c8ed21f17 - fgumi_sort[a2e1750e109c4d89]::spill_reader::tests::test_scattered_reading_spawns_no_threads_of_its_own
[INFO] [stdout]                                at /opt/rustwide/workdir/src/spill_reader.rs:1126:9
[INFO] [stdout]   22:     0x637c8ed14017 - fgumi_sort[a2e1750e109c4d89]::spill_reader::tests::test_scattered_reading_spawns_no_threads_of_its_own::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/spill_reader.rs:1116:61
[INFO] [stdout]   23:     0x637c8efb8526 - <fgumi_sort[a2e1750e109c4d89]::spill_reader::tests::test_scattered_reading_spawns_no_threads_of_its_own::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x637c8f0e549b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x637c8f0e549b - 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]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   26:     0x637c8f0f2675 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   27:     0x637c8f0f2675 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x637c8f0f2675 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   29:     0x637c8f0f2675 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   30:     0x637c8f0f2675 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x637c8f0f2675 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   32:     0x637c8f0f2675 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   33:     0x637c8f0ebf64 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   34:     0x637c8f0ebf64 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x637c8f0f5702 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x637c8f0f5702 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x637c8f0f5702 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   38:     0x637c8f0f5702 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   39:     0x637c8f0f5702 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x637c8f0f5702 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x637c8f0f5702 - <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]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x637c8f5d06df - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   43:     0x637c8f5d06df - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   44:     0x7e672cab1dfa - <unknown>
[INFO] [stdout]   45:     0x7e672cb453d4 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     spill_reader::tests::test_scattered_reading_spawns_no_threads_of_its_own
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 969 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 23.58s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "8f60c1337141d421b9e2c1ef40c76c053f0c24b1db20b8cea2945a5b3c0f696e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8f60c1337141d421b9e2c1ef40c76c053f0c24b1db20b8cea2945a5b3c0f696e", kill_on_drop: false }`
[INFO] [stdout] 8f60c1337141d421b9e2c1ef40c76c053f0c24b1db20b8cea2945a5b3c0f696e
