[INFO] cloning repository https://github.com/arissupriy/scte
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/arissupriy/scte" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Farissupriy%2Fscte", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Farissupriy%2Fscte'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 0f90cac7eb7894b3992e2c241a3bd996eeab9a0d
[INFO] testing arissupriy/scte against try#33835004928d3bf65db4d4712e1330766263b0bd for pr-155739
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Farissupriy%2Fscte" "/workspace/builds/worker-3-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/arissupriy/scte
[INFO] finished tweaking git repo https://github.com/arissupriy/scte
[INFO] tweaked toml for git repo https://github.com/arissupriy/scte written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/arissupriy/scte on toolchain 33835004928d3bf65db4d4712e1330766263b0bd
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/arissupriy/scte 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" "+33835004928d3bf65db4d4712e1330766263b0bd" "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/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 1eafe53a488390a1a36e9b3ce667f4785551cd0bca17320c91c42ffcb7f34b8f
[INFO] running `Command { std: "docker" "start" "-a" "1eafe53a488390a1a36e9b3ce667f4785551cd0bca17320c91c42ffcb7f34b8f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1eafe53a488390a1a36e9b3ce667f4785551cd0bca17320c91c42ffcb7f34b8f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1eafe53a488390a1a36e9b3ce667f4785551cd0bca17320c91c42ffcb7f34b8f", kill_on_drop: false }`
[INFO] [stdout] 1eafe53a488390a1a36e9b3ce667f4785551cd0bca17320c91c42ffcb7f34b8f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1e6409361ea2032afbe5143e389031e5b4a2fe8b803e42220f13d63a06a0dffc
[INFO] running `Command { std: "docker" "start" "-a" "1e6409361ea2032afbe5143e389031e5b4a2fe8b803e42220f13d63a06a0dffc", kill_on_drop: false }`
[INFO] [stderr]    Compiling scte-core v0.1.0 (/opt/rustwide/workdir/scte-core)
[INFO] [stdout] warning: unused import: `decode_columnar`
[INFO] [stdout]   --> scte-core/src/codec/decoder.rs:12:9
[INFO] [stdout]    |
[INFO] [stdout] 12 |         decode_columnar,
[INFO] [stdout]    |         ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `try_encode_columnar_from_tokens`
[INFO] [stdout]   --> scte-core/src/pipelines/text/mod.rs:22:36
[INFO] [stdout]    |
[INFO] [stdout] 22 | pub(crate) use columnar_pipeline::{try_encode_columnar_from_tokens,
[INFO] [stdout]    |                                    ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: type `RawColumn` is more private than the item `compute_global_col_kind`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2540:1
[INFO] [stdout]      |
[INFO] [stdout] 2540 | pub(crate) fn compute_global_col_kind(col: &RawColumn) -> GlobalColKind {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ function `compute_global_col_kind` is reachable at visibility `pub(crate)`
[INFO] [stdout]      |
[INFO] [stdout] note: but type `RawColumn` is only usable at visibility `pub(self)`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:266:1
[INFO] [stdout]      |
[INFO] [stdout]  266 | struct RawColumn {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^
[INFO] [stdout]      = note: `#[warn(private_interfaces)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: type `RawColumn` is more private than the item `build_global_context`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2602:1
[INFO] [stdout]      |
[INFO] [stdout] 2602 | pub(crate) fn build_global_context(scalar_cols: &[RawColumn]) -> GlobalColsContext {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ function `build_global_context` is reachable at visibility `pub(crate)`
[INFO] [stdout]      |
[INFO] [stdout] note: but type `RawColumn` is only usable at visibility `pub(self)`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:266:1
[INFO] [stdout]      |
[INFO] [stdout]  266 | struct RawColumn {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: type `RawColumn` is more private than the item `encode_extract_range_with_global`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2898:1
[INFO] [stdout]      |
[INFO] [stdout] 2898 | / pub(crate) fn encode_extract_range_with_global(
[INFO] [stdout] 2899 | |     scalar_cols: &[RawColumn],
[INFO] [stdout] 2900 | |     sub_tables:  &[SubTable],
[INFO] [stdout] 2901 | |     row_start:   usize,
[INFO] [stdout] 2902 | |     row_end:     usize,
[INFO] [stdout] 2903 | |     global_ctx:  &GlobalColsContext,
[INFO] [stdout] 2904 | | ) -> Vec<u8> {
[INFO] [stdout]      | |____________^ function `encode_extract_range_with_global` is reachable at visibility `pub(crate)`
[INFO] [stdout]      |
[INFO] [stdout] note: but type `RawColumn` is only usable at visibility `pub(self)`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:266:1
[INFO] [stdout]      |
[INFO] [stdout]  266 | struct RawColumn {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: type `SubTable` is more private than the item `encode_extract_range_with_global`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2898:1
[INFO] [stdout]      |
[INFO] [stdout] 2898 | / pub(crate) fn encode_extract_range_with_global(
[INFO] [stdout] 2899 | |     scalar_cols: &[RawColumn],
[INFO] [stdout] 2900 | |     sub_tables:  &[SubTable],
[INFO] [stdout] 2901 | |     row_start:   usize,
[INFO] [stdout] 2902 | |     row_end:     usize,
[INFO] [stdout] 2903 | |     global_ctx:  &GlobalColsContext,
[INFO] [stdout] 2904 | | ) -> Vec<u8> {
[INFO] [stdout]      | |____________^ function `encode_extract_range_with_global` is reachable at visibility `pub(crate)`
[INFO] [stdout]      |
[INFO] [stdout] note: but type `SubTable` is only usable at visibility `pub(self)`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:325:1
[INFO] [stdout]      |
[INFO] [stdout]  325 | struct SubTable {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field `total` is never read
[INFO] [stdout]    --> scte-core/src/pipelines/text/columnar_pipeline.rs:331:5
[INFO] [stdout]     |
[INFO] [stdout] 325 | struct SubTable {
[INFO] [stdout]     |        -------- field in this struct
[INFO] [stdout] ...
[INFO] [stdout] 331 |     total:  usize,
[INFO] [stdout]     |     ^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `try_encode_columnar_from_tokens` is never used
[INFO] [stdout]    --> scte-core/src/pipelines/text/columnar_pipeline.rs:382:15
[INFO] [stdout]     |
[INFO] [stdout] 382 | pub(crate) fn try_encode_columnar_from_tokens(tokens: &[Token]) -> Option<Vec<u8>> {
[INFO] [stdout]     |               ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `encode_sub_table` is never used
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:1678:4
[INFO] [stdout]      |
[INFO] [stdout] 1678 | fn encode_sub_table(sub: &SubTable, out: &mut Vec<u8>) {
[INFO] [stdout]      |    ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling scte-cli v0.1.0 (/opt/rustwide/workdir/scte-cli)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 3.83s
[INFO] running `Command { std: "docker" "inspect" "1e6409361ea2032afbe5143e389031e5b4a2fe8b803e42220f13d63a06a0dffc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1e6409361ea2032afbe5143e389031e5b4a2fe8b803e42220f13d63a06a0dffc", kill_on_drop: false }`
[INFO] [stdout] 1e6409361ea2032afbe5143e389031e5b4a2fe8b803e42220f13d63a06a0dffc
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6bdb6c1e0bf59a4443a54e5f56bdd32f0ce85172627e84a9af042df77c63eeea
[INFO] running `Command { std: "docker" "start" "-a" "6bdb6c1e0bf59a4443a54e5f56bdd32f0ce85172627e84a9af042df77c63eeea", kill_on_drop: false }`
[INFO] [stdout] warning: unused import: `decode_columnar`
[INFO] [stdout]   --> scte-core/src/codec/decoder.rs:12:9
[INFO] [stdout]    |
[INFO] [stdout] 12 |         decode_columnar,
[INFO] [stdout]    |         ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `try_encode_columnar_from_tokens`
[INFO] [stdout]   --> scte-core/src/pipelines/text/mod.rs:22:36
[INFO] [stdout]    |
[INFO] [stdout] 22 | pub(crate) use columnar_pipeline::{try_encode_columnar_from_tokens,
[INFO] [stdout]    |                                    ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: type `RawColumn` is more private than the item `compute_global_col_kind`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2540:1
[INFO] [stdout]      |
[INFO] [stdout] 2540 | pub(crate) fn compute_global_col_kind(col: &RawColumn) -> GlobalColKind {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ function `compute_global_col_kind` is reachable at visibility `pub(crate)`
[INFO] [stdout]      |
[INFO] [stdout] note: but type `RawColumn` is only usable at visibility `pub(self)`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:266:1
[INFO] [stdout]      |
[INFO] [stdout]  266 | struct RawColumn {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^
[INFO] [stdout]      = note: `#[warn(private_interfaces)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: type `RawColumn` is more private than the item `build_global_context`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2602:1
[INFO] [stdout]      |
[INFO] [stdout] 2602 | pub(crate) fn build_global_context(scalar_cols: &[RawColumn]) -> GlobalColsContext {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ function `build_global_context` is reachable at visibility `pub(crate)`
[INFO] [stdout]      |
[INFO] [stdout] note: but type `RawColumn` is only usable at visibility `pub(self)`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:266:1
[INFO] [stdout]      |
[INFO] [stdout]  266 | struct RawColumn {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: type `RawColumn` is more private than the item `encode_extract_range_with_global`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2898:1
[INFO] [stdout]      |
[INFO] [stdout] 2898 | / pub(crate) fn encode_extract_range_with_global(
[INFO] [stdout] 2899 | |     scalar_cols: &[RawColumn],
[INFO] [stdout] 2900 | |     sub_tables:  &[SubTable],
[INFO] [stdout] 2901 | |     row_start:   usize,
[INFO] [stdout] 2902 | |     row_end:     usize,
[INFO] [stdout] 2903 | |     global_ctx:  &GlobalColsContext,
[INFO] [stdout] 2904 | | ) -> Vec<u8> {
[INFO] [stdout]      | |____________^ function `encode_extract_range_with_global` is reachable at visibility `pub(crate)`
[INFO] [stdout]      |
[INFO] [stdout] note: but type `RawColumn` is only usable at visibility `pub(self)`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:266:1
[INFO] [stdout]      |
[INFO] [stdout]  266 | struct RawColumn {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: type `SubTable` is more private than the item `encode_extract_range_with_global`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2898:1
[INFO] [stdout]      |
[INFO] [stdout] 2898 | / pub(crate) fn encode_extract_range_with_global(
[INFO] [stdout] 2899 | |     scalar_cols: &[RawColumn],
[INFO] [stdout] 2900 | |     sub_tables:  &[SubTable],
[INFO] [stdout] 2901 | |     row_start:   usize,
[INFO] [stdout] 2902 | |     row_end:     usize,
[INFO] [stdout] 2903 | |     global_ctx:  &GlobalColsContext,
[INFO] [stdout] 2904 | | ) -> Vec<u8> {
[INFO] [stdout]      | |____________^ function `encode_extract_range_with_global` is reachable at visibility `pub(crate)`
[INFO] [stdout]      |
[INFO] [stdout] note: but type `SubTable` is only usable at visibility `pub(self)`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:325:1
[INFO] [stdout]      |
[INFO] [stdout]  325 | struct SubTable {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field `total` is never read
[INFO] [stdout]    --> scte-core/src/pipelines/text/columnar_pipeline.rs:331:5
[INFO] [stdout]     |
[INFO] [stdout] 325 | struct SubTable {
[INFO] [stdout]     |        -------- field in this struct
[INFO] [stdout] ...
[INFO] [stdout] 331 |     total:  usize,
[INFO] [stdout]     |     ^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `try_encode_columnar_from_tokens` is never used
[INFO] [stdout]    --> scte-core/src/pipelines/text/columnar_pipeline.rs:382:15
[INFO] [stdout]     |
[INFO] [stdout] 382 | pub(crate) fn try_encode_columnar_from_tokens(tokens: &[Token]) -> Option<Vec<u8>> {
[INFO] [stdout]     |               ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `encode_sub_table` is never used
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:1678:4
[INFO] [stdout]      |
[INFO] [stdout] 1678 | fn encode_sub_table(sub: &SubTable, out: &mut Vec<u8>) {
[INFO] [stdout]      |    ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling scte-core v0.1.0 (/opt/rustwide/workdir/scte-core)
[INFO] [stderr]    Compiling scte-cli v0.1.0 (/opt/rustwide/workdir/scte-cli)
[INFO] [stdout] warning: unused import: `detect_prefix_pattern`
[INFO] [stdout]   --> scte-core/tests/delta_pipeline.rs:20:5
[INFO] [stdout]    |
[INFO] [stdout] 20 |     detect_prefix_pattern, encode_prefix_strings, decode_prefix_strings,
[INFO] [stdout]    |     ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `decode_columnar`
[INFO] [stdout]   --> scte-core/src/codec/decoder.rs:12:9
[INFO] [stdout]    |
[INFO] [stdout] 12 |         decode_columnar,
[INFO] [stdout]    |         ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `try_encode_columnar_from_tokens`
[INFO] [stdout]   --> scte-core/src/pipelines/text/mod.rs:22:36
[INFO] [stdout]    |
[INFO] [stdout] 22 | pub(crate) use columnar_pipeline::{try_encode_columnar_from_tokens,
[INFO] [stdout]    |                                    ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: type `RawColumn` is more private than the item `compute_global_col_kind`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2540:1
[INFO] [stdout]      |
[INFO] [stdout] 2540 | pub(crate) fn compute_global_col_kind(col: &RawColumn) -> GlobalColKind {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ function `compute_global_col_kind` is reachable at visibility `pub(crate)`
[INFO] [stdout]      |
[INFO] [stdout] note: but type `RawColumn` is only usable at visibility `pub(self)`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:266:1
[INFO] [stdout]      |
[INFO] [stdout]  266 | struct RawColumn {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^
[INFO] [stdout]      = note: `#[warn(private_interfaces)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: type `RawColumn` is more private than the item `build_global_context`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2602:1
[INFO] [stdout]      |
[INFO] [stdout] 2602 | pub(crate) fn build_global_context(scalar_cols: &[RawColumn]) -> GlobalColsContext {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ function `build_global_context` is reachable at visibility `pub(crate)`
[INFO] [stdout]      |
[INFO] [stdout] note: but type `RawColumn` is only usable at visibility `pub(self)`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:266:1
[INFO] [stdout]      |
[INFO] [stdout]  266 | struct RawColumn {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: type `RawColumn` is more private than the item `encode_extract_range_with_global`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2898:1
[INFO] [stdout]      |
[INFO] [stdout] 2898 | / pub(crate) fn encode_extract_range_with_global(
[INFO] [stdout] 2899 | |     scalar_cols: &[RawColumn],
[INFO] [stdout] 2900 | |     sub_tables:  &[SubTable],
[INFO] [stdout] 2901 | |     row_start:   usize,
[INFO] [stdout] 2902 | |     row_end:     usize,
[INFO] [stdout] 2903 | |     global_ctx:  &GlobalColsContext,
[INFO] [stdout] 2904 | | ) -> Vec<u8> {
[INFO] [stdout]      | |____________^ function `encode_extract_range_with_global` is reachable at visibility `pub(crate)`
[INFO] [stdout]      |
[INFO] [stdout] note: but type `RawColumn` is only usable at visibility `pub(self)`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:266:1
[INFO] [stdout]      |
[INFO] [stdout]  266 | struct RawColumn {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: type `SubTable` is more private than the item `encode_extract_range_with_global`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2898:1
[INFO] [stdout]      |
[INFO] [stdout] 2898 | / pub(crate) fn encode_extract_range_with_global(
[INFO] [stdout] 2899 | |     scalar_cols: &[RawColumn],
[INFO] [stdout] 2900 | |     sub_tables:  &[SubTable],
[INFO] [stdout] 2901 | |     row_start:   usize,
[INFO] [stdout] 2902 | |     row_end:     usize,
[INFO] [stdout] 2903 | |     global_ctx:  &GlobalColsContext,
[INFO] [stdout] 2904 | | ) -> Vec<u8> {
[INFO] [stdout]      | |____________^ function `encode_extract_range_with_global` is reachable at visibility `pub(crate)`
[INFO] [stdout]      |
[INFO] [stdout] note: but type `SubTable` is only usable at visibility `pub(self)`
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:325:1
[INFO] [stdout]      |
[INFO] [stdout]  325 | struct SubTable {
[INFO] [stdout]      | ^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field `total` is never read
[INFO] [stdout]    --> scte-core/src/pipelines/text/columnar_pipeline.rs:331:5
[INFO] [stdout]     |
[INFO] [stdout] 325 | struct SubTable {
[INFO] [stdout]     |        -------- field in this struct
[INFO] [stdout] ...
[INFO] [stdout] 331 |     total:  usize,
[INFO] [stdout]     |     ^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `try_encode_columnar_from_tokens` is never used
[INFO] [stdout]    --> scte-core/src/pipelines/text/columnar_pipeline.rs:382:15
[INFO] [stdout]     |
[INFO] [stdout] 382 | pub(crate) fn try_encode_columnar_from_tokens(tokens: &[Token]) -> Option<Vec<u8>> {
[INFO] [stdout]     |               ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `encode_sub_table` is never used
[INFO] [stdout]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:1678:4
[INFO] [stdout]      |
[INFO] [stdout] 1678 | fn encode_sub_table(sub: &SubTable, out: &mut Vec<u8>) {
[INFO] [stdout]      |    ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 5.78s
[INFO] running `Command { std: "docker" "inspect" "6bdb6c1e0bf59a4443a54e5f56bdd32f0ce85172627e84a9af042df77c63eeea", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6bdb6c1e0bf59a4443a54e5f56bdd32f0ce85172627e84a9af042df77c63eeea", kill_on_drop: false }`
[INFO] [stdout] 6bdb6c1e0bf59a4443a54e5f56bdd32f0ce85172627e84a9af042df77c63eeea
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] d4adcda00e3fcac6ae7d6551f5e747fdac63bf024be9d089f2d61c76b3e184d9
[INFO] running `Command { std: "docker" "start" "-a" "d4adcda00e3fcac6ae7d6551f5e747fdac63bf024be9d089f2d61c76b3e184d9", kill_on_drop: false }`
[INFO] [stderr] warning: unused import: `decode_columnar`
[INFO] [stderr]   --> scte-core/src/codec/decoder.rs:12:9
[INFO] [stderr]    |
[INFO] [stderr] 12 |         decode_columnar,
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused import: `try_encode_columnar_from_tokens`
[INFO] [stderr]   --> scte-core/src/pipelines/text/mod.rs:22:36
[INFO] [stderr]    |
[INFO] [stderr] 22 | pub(crate) use columnar_pipeline::{try_encode_columnar_from_tokens,
[INFO] [stderr]    |                                    ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: type `RawColumn` is more private than the item `compute_global_col_kind`
[INFO] [stderr]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2540:1
[INFO] [stderr]      |
[INFO] [stderr] 2540 | pub(crate) fn compute_global_col_kind(col: &RawColumn) -> GlobalColKind {
[INFO] [stderr]      | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ function `compute_global_col_kind` is reachable at visibility `pub(crate)`
[INFO] [stderr]      |
[INFO] [stderr] note: but type `RawColumn` is only usable at visibility `pub(self)`
[INFO] [stderr]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:266:1
[INFO] [stderr]      |
[INFO] [stderr]  266 | struct RawColumn {
[INFO] [stderr]      | ^^^^^^^^^^^^^^^^
[INFO] [stderr]      = note: `#[warn(private_interfaces)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: type `RawColumn` is more private than the item `build_global_context`
[INFO] [stderr]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2602:1
[INFO] [stderr]      |
[INFO] [stderr] 2602 | pub(crate) fn build_global_context(scalar_cols: &[RawColumn]) -> GlobalColsContext {
[INFO] [stderr]      | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ function `build_global_context` is reachable at visibility `pub(crate)`
[INFO] [stderr]      |
[INFO] [stderr] note: but type `RawColumn` is only usable at visibility `pub(self)`
[INFO] [stderr]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:266:1
[INFO] [stderr]      |
[INFO] [stderr]  266 | struct RawColumn {
[INFO] [stderr]      | ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: type `RawColumn` is more private than the item `encode_extract_range_with_global`
[INFO] [stderr]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2898:1
[INFO] [stderr]      |
[INFO] [stderr] 2898 | / pub(crate) fn encode_extract_range_with_global(
[INFO] [stderr] 2899 | |     scalar_cols: &[RawColumn],
[INFO] [stderr] 2900 | |     sub_tables:  &[SubTable],
[INFO] [stderr] 2901 | |     row_start:   usize,
[INFO] [stderr] 2902 | |     row_end:     usize,
[INFO] [stderr] 2903 | |     global_ctx:  &GlobalColsContext,
[INFO] [stderr] 2904 | | ) -> Vec<u8> {
[INFO] [stderr]      | |____________^ function `encode_extract_range_with_global` is reachable at visibility `pub(crate)`
[INFO] [stderr]      |
[INFO] [stderr] note: but type `RawColumn` is only usable at visibility `pub(self)`
[INFO] [stderr]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:266:1
[INFO] [stderr]      |
[INFO] [stderr]  266 | struct RawColumn {
[INFO] [stderr]      | ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: type `SubTable` is more private than the item `encode_extract_range_with_global`
[INFO] [stderr]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:2898:1
[INFO] [stderr]      |
[INFO] [stderr] 2898 | / pub(crate) fn encode_extract_range_with_global(
[INFO] [stderr] 2899 | |     scalar_cols: &[RawColumn],
[INFO] [stderr] 2900 | |     sub_tables:  &[SubTable],
[INFO] [stderr] 2901 | |     row_start:   usize,
[INFO] [stderr] 2902 | |     row_end:     usize,
[INFO] [stderr] 2903 | |     global_ctx:  &GlobalColsContext,
[INFO] [stderr] 2904 | | ) -> Vec<u8> {
[INFO] [stderr]      | |____________^ function `encode_extract_range_with_global` is reachable at visibility `pub(crate)`
[INFO] [stderr]      |
[INFO] [stderr] note: but type `SubTable` is only usable at visibility `pub(self)`
[INFO] [stderr]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:325:1
[INFO] [stderr]      |
[INFO] [stderr]  325 | struct SubTable {
[INFO] [stderr]      | ^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field `total` is never read
[INFO] [stderr]    --> scte-core/src/pipelines/text/columnar_pipeline.rs:331:5
[INFO] [stderr]     |
[INFO] [stderr] 325 | struct SubTable {
[INFO] [stdout] 
[INFO] [stderr]     |        -------- field in this struct
[INFO] [stdout] running 0 tests
[INFO] [stderr] ...
[INFO] [stdout] 
[INFO] [stderr] 331 |     total:  usize,
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stderr]     |     ^^^^^
[INFO] [stdout] 
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: function `try_encode_columnar_from_tokens` is never used
[INFO] [stderr]    --> scte-core/src/pipelines/text/columnar_pipeline.rs:382:15
[INFO] [stderr]     |
[INFO] [stderr] 382 | pub(crate) fn try_encode_columnar_from_tokens(tokens: &[Token]) -> Option<Vec<u8>> {
[INFO] [stderr]     |               ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: function `encode_sub_table` is never used
[INFO] [stderr]     --> scte-core/src/pipelines/text/columnar_pipeline.rs:1678:4
[INFO] [stderr]      |
[INFO] [stderr] 1678 | fn encode_sub_table(sub: &SubTable, out: &mut Vec<u8>) {
[INFO] [stderr]      |    ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `scte-core` (lib) generated 9 warnings (run `cargo fix --lib -p scte-core` to apply 2 suggestions)
[INFO] [stderr] warning: unused import: `detect_prefix_pattern`
[INFO] [stderr]   --> scte-core/tests/delta_pipeline.rs:20:5
[INFO] [stderr]    |
[INFO] [stderr] 20 |     detect_prefix_pattern, encode_prefix_strings, decode_prefix_strings,
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `scte-core` (test "delta_pipeline") generated 1 warning (run `cargo fix --test "delta_pipeline" -p scte-core` to apply 1 suggestion)
[INFO] [stderr] warning: `scte-core` (lib test) generated 9 warnings (9 duplicates)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/scte_cli-9d733286056f8640)
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/scte_core-1d1a6a6c646b284a)
[INFO] [stdout] 
[INFO] [stdout] running 351 tests
[INFO] [stdout] test codec::decoder::tests::decode_rejects_corrupted_header_checksum ... ok
[INFO] [stdout] test codec::decoder::tests::decode_rejects_too_short_buffer ... ok
[INFO] [stdout] test codec::decoder::tests::decode_empty_passthrough_payload ... ok
[INFO] [stdout] test codec::decoder::tests::json_roundtrip_array_of_objects ... ok
[INFO] [stdout] test codec::decoder::tests::passthrough_roundtrip ... ok
[INFO] [stdout] test codec::encoder::tests::encode_output_starts_with_magic ... ok
[INFO] [stdout] test codec::encoder::tests::encode_passthrough_size_is_predictable ... ok
[INFO] [stdout] test codec::encoder::tests::encode_empty_input ... ok
[INFO] [stdout] test container::checksum::tests::different_inputs_produce_different_hashes ... ok
[INFO] [stdout] test container::header::tests::pipeline_id_roundtrips ... ok
[INFO] [stdout] test container::header::tests::reject_tampered_checksum ... ok
[INFO] [stdout] test codec::encoder::tests::encode_json_uses_text_pipeline ... ok
[INFO] [stdout] test container::header::tests::reject_wrong_version ... ok
[INFO] [stdout] test container::header::tests::roundtrip_header ... ok
[INFO] [stdout] test container::checksum::tests::empty_input_is_offset_basis ... ok
[INFO] [stdout] test container::header::tests::version_byte_is_current ... ok
[INFO] [stdout] test container::header::tests::write_produces_correct_size ... ok
[INFO] [stdout] test container::section::tests::roundtrip_entry ... ok
[INFO] [stdout] test container::section::tests::verify_correct_payload_succeeds ... ok
[INFO] [stdout] test container::checksum::tests::deterministic_across_calls ... ok
[INFO] [stdout] test container::section::tests::verify_wrong_payload_fails ... ok
[INFO] [stdout] test container::checksum::tests::known_vector_fnv1a_32 ... ok
[INFO] [stdout] test container::header::tests::magic_bytes_are_scte ... ok
[INFO] [stdout] test container::header::tests::reject_too_short_buffer ... ok
[INFO] [stdout] test codec::encoder::tests::json_encode_smaller_than_passthrough_for_repetitive_data ... ok
[INFO] [stdout] test container::header::tests::reject_wrong_magic ... ok
[INFO] [stdout] test container::section::tests::length_matches_payload_size ... ok
[INFO] [stdout] test container::section::tests::no_meta_size_is_fixed_size ... ok
[INFO] [stdout] test container::section::tests::offset_is_preserved ... ok
[INFO] [stdout] test container::section::tests::reject_too_short_buffer ... ok
[INFO] [stdout] test container::section::tests::serialized_size_matches_write_len ... ok
[INFO] [stdout] test entropy::arithmetic::tests::alternating_bits ... ok
[INFO] [stdout] test entropy::arithmetic::tests::highly_skewed_roundtrip ... ok
[INFO] [stdout] test entropy::arithmetic::tests::invalid_prob_errors ... ok
[INFO] [stdout] test entropy::arithmetic::tests::single_one ... ok
[INFO] [stdout] test entropy::arithmetic::tests::uniform_all_zeros ... ok
[INFO] [stdout] test entropy::arithmetic::tests::skewed_is_smaller_than_uniform ... ok
[INFO] [stdout] test entropy::arithmetic::tests::single_zero ... ok
[INFO] [stdout] test entropy::arithmetic::tests::uniform_all_ones ... ok
[INFO] [stdout] test entropy::codec::tests::auto_decode_unknown_tag_errors ... ok
[INFO] [stdout] test entropy::arithmetic::tests::byte_sequence_roundtrip ... ok
[INFO] [stdout] test entropy::arithmetic::tests::empty_sequence ... ok
[INFO] [stdout] test entropy::arithmetic::tests::length_mismatch_errors ... ok
[INFO] [stdout] test entropy::codec::tests::auto_roundtrip_empty ... ok
[INFO] [stdout] test entropy::codec::tests::decode_empty_buffer_returns_error ... ok
[INFO] [stdout] test entropy::codec::tests::auto_decode_at_nonzero_offset ... ok
[INFO] [stdout] test entropy::codec::tests::roundtrip_empty_stream ... ok
[INFO] [stdout] test entropy::codec::tests::roundtrip_single_repeated_symbol ... ok
[INFO] [stdout] test entropy::context::tests::context_model_is_btreemap_ordered ... ok
[INFO] [stdout] test codec::decoder::tests::decode_rejects_wrong_magic ... ok
[INFO] [stdout] test entropy::context::tests::parent_chain_shortens_history ... ok
[INFO] [stdout] test entropy::context::tests::fallback_to_parent_when_sparse ... ok
[INFO] [stdout] test entropy::context::tests::prob_zero_updates_after_observations ... ok
[INFO] [stdout] test entropy::context::tests::uniform_prior_with_no_data ... ok
[INFO] [stdout] test entropy::ctw::tests::corrupt_data_returns_none ... ok
[INFO] [stdout] test entropy::ctw::tests::depth_0_roundtrip ... ok
[INFO] [stdout] test entropy::codec::tests::decode_with_nonzero_offset ... ok
[INFO] [stdout] test entropy::ctw::tests::empty_roundtrip ... ok
[INFO] [stdout] test entropy::ctw::tests::hello_world_roundtrip ... ok
[INFO] [stdout] test entropy::codec::tests::roundtrip_two_symbols ... ok
[INFO] [stdout] test codec::encoder::tests::small_json_falls_back_to_passthrough ... ok
[INFO] [stdout] test entropy::ctw::tests::single_byte_roundtrip ... ok
[INFO] [stdout] test entropy::frequency::tests::absent_symbol_gets_zero_slots ... ok
[INFO] [stdout] test codec::decoder::tests::json_roundtrip_simple_object ... ok
[INFO] [stdout] test entropy::codec::tests::compressed_smaller_than_raw_for_skewed ... ok
[INFO] [stdout] test entropy::codec::tests::roundtrip_alphabet10_uniform ... ok
[INFO] [stdout] test entropy::ctw::tests::depth_16_roundtrip ... ok
[INFO] [stdout] test codec::encoder::tests::encode_large_passthrough ... ok
[INFO] [stdout] test entropy::codec::tests::deterministic_same_output ... ok
[INFO] [stdout] test entropy::frequency::tests::deserialize_wrong_sum_returns_error ... ok
[INFO] [stdout] test entropy::codec::tests::symbol_out_of_alphabet_returns_error ... ok
[INFO] [stdout] test entropy::ctw::tests::highly_repetitive_compresses_well ... ok
[INFO] [stdout] test entropy::frequency::tests::serialize_deserialize_roundtrip ... ok
[INFO] [stdout] test entropy::frequency::tests::validate_passes ... ok
[INFO] [stdout] test entropy::frequency::tests::slot_table_len_equals_m ... ok
[INFO] [stdout] test entropy::rans::tests::decode_with_nonzero_offset ... ok
[INFO] [stdout] test entropy::frequency::tests::norm_freqs_sum_to_m ... ok
[INFO] [stdout] test entropy::frequency::tests::deserialize_with_offset ... ok
[INFO] [stdout] test entropy::rans::tests::roundtrip_all_token_kinds ... ok
[INFO] [stdout] test entropy::ctw::tests::random_bytes_roundtrip ... ok
[INFO] [stdout] test entropy::ctw::tests::all_zeros_roundtrip ... ok
[INFO] [stdout] test entropy::rans::tests::roundtrip_single_symbol_twice ... ok
[INFO] [stdout] test entropy::rans::tests::compressed_size_smaller_than_input_for_skewed_input ... ok
[INFO] [stdout] test entropy::rans::tests::roundtrip_skewed_distribution ... ok
[INFO] [stdout] test entropy::rans::tests::roundtrip_two_symbols ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::empty_object_unchanged ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::backslash_escaped ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::genuine_float_preserved ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::invalid_json_returns_error ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::negative_int_preserved ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::pure_integer_unchanged ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::quote_escaped ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::real_world_api_response ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::float_one_normalized_to_int ... ok
[INFO] [stdout] test entropy::rans::tests::roundtrip_realistic_json_distribution ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::same_semantics_same_output ... ok
[INFO] [stdout] test entropy::rans::tests::roundtrip_uniform_four_symbols ... ok
[INFO] [stdout] test entropy::rans::tests::decode_truncated_state_returns_error ... ok
[INFO] [stdout] test entropy::rans::tests::encode_unknown_symbol_returns_error ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::single_key_unchanged ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::sorts_nested_object_keys ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::strips_spaces_from_array ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::sorts_object_keys ... ok
[INFO] [stdout] test entropy::frequency::tests::uniform_symbols_sum_to_m ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::strips_newlines_and_indentation ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::unicode_escape_decoded_to_utf8 ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::strips_spaces_from_object ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::tab_normalized_to_escaped_tab ... ok
[INFO] [stdout] test pipelines::text::columnar::tests::column_stream_push_and_len ... ok
[INFO] [stdout] test pipelines::text::columnar::tests::is_all_int_false_for_mixed_column ... ok
[INFO] [stdout] test pipelines::text::columnar::tests::is_constant_false_for_varying_values ... ok
[INFO] [stdout] test pipelines::text::columnar::tests::is_constant_true_for_same_values ... ok
[INFO] [stdout] test pipelines::text::columnar::tests::is_all_int_true_for_int_column ... ok
[INFO] [stdout] test pipelines::text::columnar::tests::columnar_batch_column_lookup ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::base64_helpers_roundtrip ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::backref_detected ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::detect_period_simple ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::base64_column_roundtrip ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::deep_nested_arrays ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::detect_period_100 ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::float_fixed_column ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::detect_period_none_for_sequential ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::enum_column_cycling ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::idempotent ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::integer_extremes_roundtrip ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::float_fixed_rans_roundtrip ... ok
[INFO] [stdout] test entropy::codec::tests::auto_roundtrip_uniform_10 ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::full_api_json_roundtrip ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::nested_array_varying_counts ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::nested_array_of_scalars ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::nested_objects ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::nested_array_of_objects ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::passthrough_binary_byte_equality ... ok
[INFO] [stdout] test pipelines::text::canonicalize::tests::exponent_integer_normalized ... ok
[INFO] [stdout] test entropy::frequency::tests::every_present_symbol_gets_at_least_one_slot ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::simple_int_column ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::strprefix_column ... ok
[INFO] [stdout] test entropy::frequency::tests::slot_table_consistent_with_cum_freqs ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::timestamp_period_column ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::uuid_detect_rejects_non_uuid ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::uppercase_hex_suffix_must_not_mangle_case ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::uuid_helpers_roundtrip ... ok
[INFO] [stdout] test pipelines::text::delta::cross_record::tests::changed_field_encodes_full_value ... ok
[INFO] [stdout] test pipelines::text::delta::cross_record::tests::encoding_saves_bytes_for_stable_fields ... ok
[INFO] [stdout] test pipelines::text::delta::cross_record::tests::repeated_field_encodes_as_same ... ok
[INFO] [stdout] test pipelines::text::delta::cross_record::tests::first_field_always_changed ... ok
[INFO] [stdout] test pipelines::text::delta::cross_record::tests::same_ratio_all_different ... ok
[INFO] [stdout] test pipelines::text::delta::cross_record::tests::same_ratio_all_same ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::bounded_much_smaller_than_flat ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::utf8_edge_cases_roundtrip ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::clustered_smaller_than_flat ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::uppercase_uuid_must_not_mangle_case ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::array_of_array_not_silently_nulled ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::uuid_column_roundtrip ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::detect_random ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::detect_bounded_ts_like ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::detect_clustered ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::detect_monotonic ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::raw_str_rans_roundtrip ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::timestamp_rans_roundtrip ... ok
[INFO] [stdout] test pipelines::text::delta::cross_record::tests::reset_clears_state ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::detect_sequential_ids ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::detect_sequential_negative ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::random_latency_not_bounded ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::roundtrip_monotonic ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::roundtrip_bounded ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::roundtrip_random ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::detect_sequential_even ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::roundtrip_sequential ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::roundtrip_negatives ... ok
[INFO] [stdout] test pipelines::text::delta::timestamp::tests::epoch_1970_is_zero ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::roundtrip_clustered ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::roundtrip_single ... ok
[INFO] [stdout] test pipelines::text::delta::timestamp::tests::parse_timestamp_with_offset ... ok
[INFO] [stdout] test pipelines::text::delta::timestamp::tests::parse_date_only ... ok
[INFO] [stdout] test pipelines::text::delta::timestamp::tests::timestamp_encode_decode_roundtrip ... ok
[INFO] [stdout] test pipelines::text::dictionary::codec::tests::decode_invalid_dict_id_returns_error ... ok
[INFO] [stdout] test pipelines::text::dictionary::codec::tests::decode_roundtrip ... ok
[INFO] [stdout] test pipelines::text::dictionary::codec::tests::encode_decode_large_stream ... ok
[INFO] [stdout] test pipelines::text::delta::timestamp::tests::sequential_timestamps_encode_compactly ... ok
[INFO] [stdout] test pipelines::text::dictionary::codec::tests::encode_does_not_touch_int_bool_null ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::deserialize_preserves_lookup_index ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::deserialize_truncated_returns_error ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::deserialize_unknown_type_byte_returns_error ... ok
[INFO] [stdout] test pipelines::text::dictionary::codec::tests::encode_keeps_unknown_strings_literal ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::roundtrip_empty ... ok
[INFO] [stdout] test pipelines::text::delta::timestamp::tests::epoch_to_iso8601_roundtrip ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::empty_dict_serializes_to_one_zero_byte ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::empty_token_stream_produces_empty_dict ... ok
[INFO] [stdout] test pipelines::text::delta::timestamp::tests::parse_full_utc_timestamp ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::get_out_of_range_returns_none ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::build_is_deterministic ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::higher_frequency_gets_lower_id ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::key_and_str_are_independent ... ok
[INFO] [stdout] test pipelines::text::dictionary::codec::tests::encode_replaces_known_keys_with_dict_id ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::lookup_missing_token_returns_none ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::min_freq_filters_low_frequency_entries ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::primitives_not_added_to_dict ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::serialize_deserialize_roundtrip ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::single_key_is_added ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::get_by_id_roundtrips ... ok
[INFO] [stdout] test pipelines::text::entropic::tests::decode_empty_buffer_returns_error ... ok
[INFO] [stdout] test pipelines::text::entropic::tests::byte_to_kind_unknown_returns_none ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::heterogeneous_sub_table_field_survives ... ok
[INFO] [stdout] test pipelines::text::entropic::tests::kind_byte_roundtrip_all_variants ... ok
[INFO] [stdout] test pipelines::text::dictionary::tests::single_str_value_is_added ... ok
[INFO] [stdout] test pipelines::text::delta::integer::tests::sequential_is_compact ... ok
[INFO] [stdout] test pipelines::text::entropic::tests::decode_truncated_stream_returns_error ... ok
[INFO] [stdout] test pipelines::text::entropic::tests::roundtrip_negative_integer ... ok
[INFO] [stdout] test pipelines::text::numeric::tests::flat_encoder_empty ... ok
[INFO] [stdout] test pipelines::text::entropic::tests::roundtrip_simple_object ... ok
[INFO] [stdout] test pipelines::text::entropic::tests::roundtrip_literal_string_fallback ... ok
[INFO] [stdout] test pipelines::text::numeric::tests::flat_encoder_roundtrip_negative ... ok
[INFO] [stdout] test pipelines::text::entropic::tests::roundtrip_array_of_objects ... ok
[INFO] [stdout] test pipelines::text::numeric::tests::flat_encoder_roundtrip_positive ... ok
[INFO] [stdout] test pipelines::text::numeric::tests::flat_encoder_truncated_returns_error ... ok
[INFO] [stdout] test pipelines::text::numeric::tests::float_genuine_f64_roundtrip ... ok
[INFO] [stdout] test pipelines::text::numeric::tests::float_truncated_returns_error ... ok
[INFO] [stdout] test pipelines::text::pattern::rle::tests::correct_pair_count ... ok
[INFO] [stdout] test pipelines::text::pattern::rle::tests::compresses_long_runs ... ok
[INFO] [stdout] test pipelines::text::pattern::rle::tests::roundtrip_empty ... ok
[INFO] [stdout] test pipelines::text::pattern::rle::tests::roundtrip_mixed ... ok
[INFO] [stdout] test pipelines::text::pattern::rle::tests::roundtrip_single ... ok
[INFO] [stdout] test pipelines::text::pattern::string_prefix::tests::common_prefix_empty ... ok
[INFO] [stdout] test pipelines::text::pattern::string_prefix::tests::common_prefix_simple ... ok
[INFO] [stdout] test pipelines::text::numeric::tests::float_negative_integer_roundtrip ... ok
[INFO] [stdout] test pipelines::text::numeric::tests::float_integer_value_roundtrip ... ok
[INFO] [stdout] test pipelines::text::pattern::rle::tests::roundtrip_all_different ... ok
[INFO] [stdout] test pipelines::text::pattern::string_prefix::tests::detect_sequential_suffix ... ok
[INFO] [stdout] test pipelines::text::pattern::string_prefix::tests::no_pattern_no_prefix ... ok
[INFO] [stdout] test pipelines::text::pattern::string_prefix::tests::prefix_compresses_well ... ok
[INFO] [stdout] test pipelines::text::pattern::string_prefix::tests::roundtrip_fallback ... ok
[INFO] [stdout] test pipelines::text::pattern::string_prefix::tests::roundtrip_prefix ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::array_of_ints ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::bool_false_token ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::bool_true_token ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::empty_array ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::empty_object ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::float_one_normalized_to_int_token ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::genuine_float_token ... ok
[INFO] [stdout] test pipelines::text::entropic::tests::roundtrip_nested_object ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::int_token ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::invalid_json_returns_error ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::key_token_not_str_token ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::mixed_types_object ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::nested_object ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::object_keys_emitted_sorted ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::str_in_array_is_str_not_key ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::simple_object ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::string_token ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::token_count_flat_object ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::token_count_nested ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::tokenize_is_deterministic ... ok
[INFO] [stdout] test pipelines::text::two_pass::tests::encode_decode_tokens_roundtrip ... ok
[INFO] [stdout] test pipelines::text::two_pass::tests::enum_str_replaced_with_numint ... ok
[INFO] [stdout] test pipelines::text::two_pass::tests::integer_at_enum_path_not_mangled ... ok
[INFO] [stdout] test pipelines::text::two_pass::tests::non_enum_str_is_unchanged ... ok
[INFO] [stdout] test pipelines::text::value::tests::array_of_ints ... ok
[INFO] [stdout] test pipelines::text::tokenizer::tests::null_token ... ok
[INFO] [stdout] test pipelines::text::value::tests::empty_input_errors ... ok
[INFO] [stdout] test pipelines::text::value::tests::array_with_whitespace ... ok
[INFO] [stdout] test pipelines::text::value::tests::empty_string ... ok
[INFO] [stdout] test pipelines::text::value::tests::empty_array ... ok
[INFO] [stdout] test pipelines::text::value::tests::escape_sequences ... ok
[INFO] [stdout] test pipelines::text::value::tests::empty_object ... ok
[INFO] [stdout] test pipelines::text::value::tests::exponent_float ... ok
[INFO] [stdout] test pipelines::text::value::tests::exponent_integer ... ok
[INFO] [stdout] test pipelines::text::value::tests::genuine_float ... ok
[INFO] [stdout] test pipelines::text::value::tests::leading_zeros_rejected ... ok
[INFO] [stdout] test pipelines::text::value::tests::lone_high_surrogate_rejected ... ok
[INFO] [stdout] test pipelines::text::value::tests::nested_array ... ok
[INFO] [stdout] test pipelines::text::value::tests::nested_object ... ok
[INFO] [stdout] test pipelines::text::value::tests::object_preserves_parse_order ... ok
[INFO] [stdout] test pipelines::text::value::tests::parse_false ... ok
[INFO] [stdout] test pipelines::text::value::tests::parse_negative ... ok
[INFO] [stdout] test pipelines::text::two_pass::tests::encode_json_two_pass_produces_output ... ok
[INFO] [stdout] test pipelines::text::value::tests::parse_null ... ok
[INFO] [stdout] test pipelines::text::value::tests::parse_true ... ok
[INFO] [stdout] test pipelines::text::two_pass::tests::two_pass_schema_bytes_valid ... ok
[INFO] [stdout] test pipelines::text::value::tests::parse_positive ... ok
[INFO] [stdout] test entropy::codec::tests::auto_picks_smaller_codec ... ok
[INFO] [stdout] test pipelines::text::pattern::rle::tests::roundtrip_all_same ... ok
[INFO] [stdout] test pipelines::text::value::tests::parse_zero ... ok
[INFO] [stdout] test pipelines::text::value::tests::simple_object ... ok
[INFO] [stdout] test pipelines::text::value::tests::trailing_comma_array_rejected ... ok
[INFO] [stdout] test pipelines::text::value::tests::trailing_comma_object_rejected ... ok
[INFO] [stdout] test pipelines::text::value::tests::unescaped_control_char_rejected ... ok
[INFO] [stdout] test pipelines::text::value::tests::unicode_escape_bmp ... ok
[INFO] [stdout] test pipelines::text::value::tests::unicode_surrogate_pair ... ok
[INFO] [stdout] test pipelines::text::value::tests::whitespace_around_value ... ok
[INFO] [stdout] test schema::inferencer::tests::detects_bool_field ... ok
[INFO] [stdout] test schema::inferencer::tests::detects_enum_field ... ok
[INFO] [stdout] test schema::inferencer::tests::detects_integer_field_sequential ... ok
[INFO] [stdout] test schema::inferencer::tests::detects_integer_hint_flat ... ok
[INFO] [stdout] test schema::inferencer::tests::detects_integer_hint_monotonic ... ok
[INFO] [stdout] test schema::inferencer::tests::empty_input_gives_empty_schema ... ok
[INFO] [stdout] test schema::inferencer::tests::enum_variant_index_and_str_roundtrip ... ok
[INFO] [stdout] test pipelines::text::value::tests::unicode_escape_ascii ... ok
[INFO] [stdout] test schema::inferencer::tests::nested_field_path ... ok
[INFO] [stdout] test schema::inferencer::tests::detects_null_only_field ... ok
[INFO] [stdout] test schema::inferencer::tests::timestamp_detected ... ok
[INFO] [stdout] test schema::inferencer::tests::high_cardinality_string_is_str_not_enum ... ok
[INFO] [stdout] test pipelines::text::value::tests::float_normalized_to_int ... ok
[INFO] [stdout] test schema::serializer::tests::complex_schema_roundtrip ... ok
[INFO] [stdout] test schema::serializer::tests::empty_schema_serializes_to_one_byte ... ok
[INFO] [stdout] test schema::serializer::tests::enum_field_roundtrip ... ok
[INFO] [stdout] test schema::inferencer::tests::truly_random_strings_are_str ... ok
[INFO] [stdout] test schema::serializer::tests::integer_field_roundtrip ... ok
[INFO] [stdout] test schema::serializer::tests::truncated_data_returns_error ... ok
[INFO] [stdout] test schema::serializer::tests::unknown_tag_returns_error ... ok
[INFO] [stdout] test varint::tests::decode_empty_buffer_returns_none ... ok
[INFO] [stdout] test schema::serializer::tests::bool_field_roundtrip ... ok
[INFO] [stdout] test schema::serializer::tests::empty_schema_roundtrip ... ok
[INFO] [stdout] test varint::tests::decode_pos_beyond_buffer_returns_none ... ok
[INFO] [stdout] test varint::tests::decode_stops_at_non_continuation_byte ... ok
[INFO] [stdout] test varint::tests::encode_decode_i64_roundtrip ... ok
[INFO] [stdout] test varint::tests::decode_usize_roundtrip ... ok
[INFO] [stdout] test varint::tests::decode_with_nonzero_pos ... ok
[INFO] [stdout] test varint::tests::encode_usize_matches_encode_u64 ... ok
[INFO] [stdout] test varint::tests::known_vector_300 ... ok
[INFO] [stdout] test varint::tests::max_single_byte_is_127 ... ok
[INFO] [stdout] test varint::tests::max_u64_encodes_to_ten_bytes ... ok
[INFO] [stdout] test varint::tests::min_two_byte_is_128 ... ok
[INFO] [stdout] test varint::tests::roundtrip_127 ... ok
[INFO] [stdout] test varint::tests::roundtrip_128 ... ok
[INFO] [stdout] test varint::tests::roundtrip_300 ... ok
[INFO] [stdout] test varint::tests::roundtrip_65535 ... ok
[INFO] [stdout] test varint::tests::decode_truncated_sequence_returns_none ... ok
[INFO] [stdout] test varint::tests::encode_i64_small_negative_is_compact ... ok
[INFO] [stdout] test varint::tests::roundtrip_one ... ok
[INFO] [stdout] test varint::tests::roundtrip_u32_max ... ok
[INFO] [stdout] test varint::tests::roundtrip_u64_max ... ok
[INFO] [stdout] test varint::tests::roundtrip_zero ... ok
[INFO] [stdout] test varint::tests::zigzag_positive ... ok
[INFO] [stdout] test varint::tests::zigzag_roundtrip_negative ... ok
[INFO] [stdout] test varint::tests::zigzag_roundtrip_positive ... ok
[INFO] [stdout] test varint::tests::zigzag_negative ... ok
[INFO] [stdout] test varint::tests::zero_encodes_to_one_byte ... ok
[INFO] [stdout] test varint::tests::zigzag_zero ... ok
[INFO] [stdout] test entropy::codec::tests::roundtrip_alphabet10_skewed ... ok
[INFO] [stdout] test pipelines::text::value::tests::simple_string ... ok
[INFO] [stdout] test varint::tests::one_encodes_to_one_byte ... ok
[INFO] [stdout] test pipelines::text::entropic::tests::roundtrip_all_payload_types ... ok
[INFO] [stdout] test pipelines::text::entropic::tests::encoded_bytes_smaller_than_naive_for_large_input ... ok
[INFO] [stdout] test pipelines::text::value::tests::trailing_content_rejected ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::two_pass_pipeline_non_columnar_roundtrip ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::multi_chunk_row_order_preserved ... ok
[INFO] [stdout] test pipelines::text::columnar_pipeline::tests::multi_chunk_roundtrip_above_threshold ... ok
[INFO] [stdout] test entropy::codec::tests::auto_roundtrip_highly_skewed ... ok
[INFO] [stdout] test pipelines::text::two_pass::tests::two_pass_smaller_than_naive_for_enum_input ... ok
[INFO] [stdout] test entropy::codec::tests::roundtrip_alphabet256 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 351 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.11s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/benchmark.rs (/opt/rustwide/target/debug/deps/benchmark-81ae0e2b9adcc1d9)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/benchmark.rs (/opt/rustwide/target/debug/deps/benchmark-0b39edddd519d48f)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test encoding_mode_raw_binary_is_byte_exact ... ok
[INFO] [stdout] test verify_non_json_asset_files_roundtrip_byte_exact ... ok
[INFO] [stdout] test verify_asset_files_roundtrip ... ok
[INFO] [stdout] test invalid_json_never_panics_and_is_byte_exact ... ok
[INFO] [stdout] test encoding_mode_raw_json_is_byte_exact ... ok
[INFO] [stdout] test encoding_mode_structured_json_is_semantically_equal ... ok
[INFO] [stdout] test benchmark_log_1k ... FAILED
[INFO] [stdout] test benchmark_summary ... FAILED
[INFO] [stdout] test benchmark_api_1k ... FAILED
[INFO] [stdout] test benchmark_log_5k ... FAILED
[INFO] [stdout] test benchmark_api_5k ... FAILED
[INFO] [stdout] test benchmark_log_10k ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- benchmark_log_1k stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'benchmark_log_1k' (374) panicked at scte-core/tests/benchmark.rs:474:10:
[INFO] [stdout] zstd not found on PATH: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f50dfae897a - std[ec419fa8110287d5]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5f50dfae897a - std[ec419fa8110287d5]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec419fa8110287d5]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5f50dfae897a - std[ec419fa8110287d5]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5f50dfae897a - <<std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[35159d6ffb30e017]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5f50dfafcfea - <core[35159d6ffb30e017]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5f50dfafcfea - core[35159d6ffb30e017]::fmt::write
[INFO] [stdout]    6:     0x5f50dfaed1f2 - std[ec419fa8110287d5]::io::default_write_fmt::<alloc[a8a7aba520129d98]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5f50dfaed1f2 - <alloc[a8a7aba520129d98]::vec::Vec<u8> as std[ec419fa8110287d5]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5f50dfac706f - <std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5f50dfac706f - std[ec419fa8110287d5]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5f50dfae0b29 - std[ec419fa8110287d5]::panicking::default_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5f50df96749c - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5f50df96749c - test[a8007afcd3effadc]::test_main_inner::<test[a8007afcd3effadc]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5f50dfae0ce2 - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5f50dfae0ce2 - std[ec419fa8110287d5]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5f50dfac7128 - std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5f50dfabe979 - std[ec419fa8110287d5]::sys::backtrace::__rust_end_short_backtrace::<std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5f50dfac7e3d - __rustc[cfb3622dd870db93]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5f50dfafd77c - core[35159d6ffb30e017]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5f50dfafd4f2 - core[35159d6ffb30e017]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5f50df94b016 - <core[35159d6ffb30e017]::result::Result<std[ec419fa8110287d5]::process::Child, std[ec419fa8110287d5]::io::error::Error>>::expect
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5f50df9556c4 - benchmark[46c10e78c08f1c86]::zstd_len
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:474:10
[INFO] [stdout]   22:     0x5f50df95500c - benchmark[46c10e78c08f1c86]::measure
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:532:15
[INFO] [stdout]   23:     0x5f50df955d42 - benchmark[46c10e78c08f1c86]::benchmark_log_1k
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:547:26
[INFO] [stdout]   24:     0x5f50df94ff47 - benchmark[46c10e78c08f1c86]::benchmark_log_1k::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:547:22
[INFO] [stdout]   25:     0x5f50df94eff6 - <benchmark[46c10e78c08f1c86]::benchmark_log_1k::{closure#0} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5f50df95a77b - <fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   27:     0x5f50df95a77b - test[a8007afcd3effadc]::__rust_begin_short_backtrace::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:724:18
[INFO] [stdout]   28:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:74
[INFO] [stdout]   29:     0x5f50df967f6b - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   30:     0x5f50df967f6b - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   31:     0x5f50df967f6b - std[ec419fa8110287d5]::panicking::catch_unwind::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   32:     0x5f50df967f6b - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   33:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test_in_process
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:27
[INFO] [stdout]   34:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:668:43
[INFO] [stdout]   35:     0x5f50df962944 - test[a8007afcd3effadc]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:698:41
[INFO] [stdout]   36:     0x5f50df962944 - std[ec419fa8110287d5]::sys::backtrace::__rust_begin_short_backtrace::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   37:     0x5f50df96ab72 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   38:     0x5f50df96ab72 - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   39:     0x5f50df96ab72 - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   40:     0x5f50df96ab72 - std[ec419fa8110287d5]::panicking::catch_unwind::<(), core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   41:     0x5f50df96ab72 - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   42:     0x5f50df96ab72 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stderr] error: test failed, to rerun pass `-p scte-core --test benchmark`
[INFO] [stdout]   43:     0x5f50df96ab72 - <std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x5f50dfae7f8f - <alloc[a8a7aba520129d98]::boxed::Box<dyn core[35159d6ffb30e017]::ops::function::FnOnce<(), Output = ()> + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   45:     0x5f50dfae7f8f - <std[ec419fa8110287d5]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   46:     0x7f4cf69aaaa4 - <unknown>
[INFO] [stdout]   47:     0x7f4cf6a37a64 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- benchmark_summary stdout ----
[INFO] [stdout] 
[INFO] [stdout] ====================================================================================================================================================
[INFO] [stdout]   SCTE encoding results  [build: debug  (run with --release for representative throughput numbers)]
[INFO] [stdout]   All rows verified: decode(encode(input)) == input (canonical JSON comparison)
[INFO] [stdout]   zstd columns are reference data only.
[INFO] [stdout]   [periodic] = all fields cycle with small periods — columnar period detector stores base cycle only.
[INFO] [stdout]   [random]   = fields randomised independently per row via LCG.
[INFO] [stdout] ====================================================================================================================================================
[INFO] [stdout]   Dataset                                                   Raw             SCTE       enc MB/s       dec MB/s      zstd -3 ref     zstd -19 ref
[INFO] [stdout] ----------------------------------------------------------------------------------------------------------------------------------------------------
[INFO] [stdout]   [real files — assets/users_*.json  (nested JSON, row-major text pipeline)]
[INFO] [stdout]   users_100.json                                    (not found, skipped)
[INFO] [stdout]   users_1k.json                                     (not found, skipped)
[INFO] [stdout]   users_10k.json                                    (not found, skipped)
[INFO] [stdout] 
[INFO] [stdout]   [real files — assets/flat_users_*.json  (flat real data, columnar pipeline active)]
[INFO] [stdout]   flat_users_1k.json                                (not found, skipped)
[INFO] [stdout]   flat_users_10k.json                               (not found, skipped)
[INFO] [stdout]   flat_users_100k.json                              (not found, skipped)
[INFO] [stdout] 
[INFO] [stdout]   [entropy ceiling — UUID primary keys + base64 payloads + random latencies]
[INFO] [stdout] 
[INFO] [stdout] thread 'benchmark_summary' (376) panicked at scte-core/tests/benchmark.rs:474:10:
[INFO] [stdout] zstd not found on PATH: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f50dfae897a - std[ec419fa8110287d5]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5f50dfae897a - std[ec419fa8110287d5]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec419fa8110287d5]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5f50dfae897a - std[ec419fa8110287d5]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5f50dfae897a - <<std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[35159d6ffb30e017]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5f50dfafcfea - <core[35159d6ffb30e017]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5f50dfafcfea - core[35159d6ffb30e017]::fmt::write
[INFO] [stdout]    6:     0x5f50dfaed1f2 - std[ec419fa8110287d5]::io::default_write_fmt::<alloc[a8a7aba520129d98]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5f50dfaed1f2 - <alloc[a8a7aba520129d98]::vec::Vec<u8> as std[ec419fa8110287d5]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5f50dfac706f - <std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5f50dfac706f - std[ec419fa8110287d5]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5f50dfae0b29 - std[ec419fa8110287d5]::panicking::default_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5f50df96749c - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5f50df96749c - test[a8007afcd3effadc]::test_main_inner::<test[a8007afcd3effadc]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5f50dfae0ce2 - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5f50dfae0ce2 - std[ec419fa8110287d5]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5f50dfac7128 - std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5f50dfabe979 - std[ec419fa8110287d5]::sys::backtrace::__rust_end_short_backtrace::<std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5f50dfac7e3d - __rustc[cfb3622dd870db93]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5f50dfafd77c - core[35159d6ffb30e017]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5f50dfafd4f2 - core[35159d6ffb30e017]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5f50df94b016 - <core[35159d6ffb30e017]::result::Result<std[ec419fa8110287d5]::process::Child, std[ec419fa8110287d5]::io::error::Error>>::expect
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5f50df9556c4 - benchmark[46c10e78c08f1c86]::zstd_len
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:474:10
[INFO] [stdout]   22:     0x5f50df95500c - benchmark[46c10e78c08f1c86]::measure
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:532:15
[INFO] [stdout]   23:     0x5f50df95756c - benchmark[46c10e78c08f1c86]::benchmark_summary
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:622:9
[INFO] [stdout]   24:     0x5f50df94ffd7 - benchmark[46c10e78c08f1c86]::benchmark_summary::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:565:23
[INFO] [stdout]   25:     0x5f50df94f0b6 - <benchmark[46c10e78c08f1c86]::benchmark_summary::{closure#0} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5f50df95a77b - <fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   27:     0x5f50df95a77b - test[a8007afcd3effadc]::__rust_begin_short_backtrace::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:724:18
[INFO] [stdout]   28:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:74
[INFO] [stdout]   29:     0x5f50df967f6b - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   30:     0x5f50df967f6b - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   31:     0x5f50df967f6b - std[ec419fa8110287d5]::panicking::catch_unwind::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   32:     0x5f50df967f6b - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   33:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test_in_process
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:27
[INFO] [stdout]   34:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:668:43
[INFO] [stdout]   35:     0x5f50df962944 - test[a8007afcd3effadc]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:698:41
[INFO] [stdout]   36:     0x5f50df962944 - std[ec419fa8110287d5]::sys::backtrace::__rust_begin_short_backtrace::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   37:     0x5f50df96ab72 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   38:     0x5f50df96ab72 - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   39:     0x5f50df96ab72 - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   40:     0x5f50df96ab72 - std[ec419fa8110287d5]::panicking::catch_unwind::<(), core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   41:     0x5f50df96ab72 - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   42:     0x5f50df96ab72 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   43:     0x5f50df96ab72 - <std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x5f50dfae7f8f - <alloc[a8a7aba520129d98]::boxed::Box<dyn core[35159d6ffb30e017]::ops::function::FnOnce<(), Output = ()> + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   45:     0x5f50dfae7f8f - <std[ec419fa8110287d5]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   46:     0x7f4cf69aaaa4 - <unknown>
[INFO] [stdout]   47:     0x7f4cf6a37a64 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- benchmark_api_1k stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'benchmark_api_1k' (371) panicked at scte-core/tests/benchmark.rs:474:10:
[INFO] [stdout] zstd not found on PATH: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f50dfae897a - std[ec419fa8110287d5]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5f50dfae897a - std[ec419fa8110287d5]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec419fa8110287d5]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5f50dfae897a - std[ec419fa8110287d5]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5f50dfae897a - <<std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[35159d6ffb30e017]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5f50dfafcfea - <core[35159d6ffb30e017]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5f50dfafcfea - core[35159d6ffb30e017]::fmt::write
[INFO] [stdout]    6:     0x5f50dfaed1f2 - std[ec419fa8110287d5]::io::default_write_fmt::<alloc[a8a7aba520129d98]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5f50dfaed1f2 - <alloc[a8a7aba520129d98]::vec::Vec<u8> as std[ec419fa8110287d5]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5f50dfac706f - <std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5f50dfac706f - std[ec419fa8110287d5]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5f50dfae0b29 - std[ec419fa8110287d5]::panicking::default_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5f50df96749c - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5f50df96749c - test[a8007afcd3effadc]::test_main_inner::<test[a8007afcd3effadc]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5f50dfae0ce2 - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5f50dfae0ce2 - std[ec419fa8110287d5]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5f50dfac7128 - std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5f50dfabe979 - std[ec419fa8110287d5]::sys::backtrace::__rust_end_short_backtrace::<std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5f50dfac7e3d - __rustc[cfb3622dd870db93]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5f50dfafd77c - core[35159d6ffb30e017]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5f50dfafd4f2 - core[35159d6ffb30e017]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5f50df94b016 - <core[35159d6ffb30e017]::result::Result<std[ec419fa8110287d5]::process::Child, std[ec419fa8110287d5]::io::error::Error>>::expect
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5f50df9556c4 - benchmark[46c10e78c08f1c86]::zstd_len
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:474:10
[INFO] [stdout]   22:     0x5f50df95500c - benchmark[46c10e78c08f1c86]::measure
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:532:15
[INFO] [stdout]   23:     0x5f50df955b20 - benchmark[46c10e78c08f1c86]::benchmark_api_1k
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:555:5
[INFO] [stdout]   24:     0x5f50df94fee7 - benchmark[46c10e78c08f1c86]::benchmark_api_1k::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:554:22
[INFO] [stdout]   25:     0x5f50df94ef76 - <benchmark[46c10e78c08f1c86]::benchmark_api_1k::{closure#0} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5f50df95a77b - <fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   27:     0x5f50df95a77b - test[a8007afcd3effadc]::__rust_begin_short_backtrace::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:724:18
[INFO] [stdout]   28:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:74
[INFO] [stdout]   29:     0x5f50df967f6b - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   30:     0x5f50df967f6b - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   31:     0x5f50df967f6b - std[ec419fa8110287d5]::panicking::catch_unwind::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   32:     0x5f50df967f6b - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   33:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test_in_process
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:27
[INFO] [stdout]   34:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:668:43
[INFO] [stdout]   35:     0x5f50df962944 - test[a8007afcd3effadc]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:698:41
[INFO] [stdout]   36:     0x5f50df962944 - std[ec419fa8110287d5]::sys::backtrace::__rust_begin_short_backtrace::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   37:     0x5f50df96ab72 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   38:     0x5f50df96ab72 - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   39:     0x5f50df96ab72 - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   40:     0x5f50df96ab72 - std[ec419fa8110287d5]::panicking::catch_unwind::<(), core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   41:     0x5f50df96ab72 - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   42:     0x5f50df96ab72 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   43:     0x5f50df96ab72 - <std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x5f50dfae7f8f - <alloc[a8a7aba520129d98]::boxed::Box<dyn core[35159d6ffb30e017]::ops::function::FnOnce<(), Output = ()> + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   45:     0x5f50dfae7f8f - <std[ec419fa8110287d5]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   46:     0x7f4cf69aaaa4 - <unknown>
[INFO] [stdout]   47:     0x7f4cf6a37a64 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- benchmark_log_5k stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'benchmark_log_5k' (375) panicked at scte-core/tests/benchmark.rs:474:10:
[INFO] [stdout] zstd not found on PATH: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f50dfae897a - std[ec419fa8110287d5]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5f50dfae897a - std[ec419fa8110287d5]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec419fa8110287d5]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5f50dfae897a - std[ec419fa8110287d5]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5f50dfae897a - <<std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[35159d6ffb30e017]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5f50dfafcfea - <core[35159d6ffb30e017]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5f50dfafcfea - core[35159d6ffb30e017]::fmt::write
[INFO] [stdout]    6:     0x5f50dfaed1f2 - std[ec419fa8110287d5]::io::default_write_fmt::<alloc[a8a7aba520129d98]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5f50dfaed1f2 - <alloc[a8a7aba520129d98]::vec::Vec<u8> as std[ec419fa8110287d5]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5f50dfac706f - <std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5f50dfac706f - std[ec419fa8110287d5]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5f50dfae0b29 - std[ec419fa8110287d5]::panicking::default_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5f50df96749c - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5f50df96749c - test[a8007afcd3effadc]::test_main_inner::<test[a8007afcd3effadc]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5f50dfae0ce2 - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5f50dfae0ce2 - std[ec419fa8110287d5]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5f50dfac7128 - std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5f50dfabe979 - std[ec419fa8110287d5]::sys::backtrace::__rust_end_short_backtrace::<std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5f50dfac7e3d - __rustc[cfb3622dd870db93]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5f50dfafd77c - core[35159d6ffb30e017]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5f50dfafd4f2 - core[35159d6ffb30e017]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5f50df94b016 - <core[35159d6ffb30e017]::result::Result<std[ec419fa8110287d5]::process::Child, std[ec419fa8110287d5]::io::error::Error>>::expect
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5f50df9556c4 - benchmark[46c10e78c08f1c86]::zstd_len
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:474:10
[INFO] [stdout]   22:     0x5f50df95500c - benchmark[46c10e78c08f1c86]::measure
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:532:15
[INFO] [stdout]   23:     0x5f50df955de2 - benchmark[46c10e78c08f1c86]::benchmark_log_5k
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:549:26
[INFO] [stdout]   24:     0x5f50df94ff77 - benchmark[46c10e78c08f1c86]::benchmark_log_5k::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:549:22
[INFO] [stdout]   25:     0x5f50df94f036 - <benchmark[46c10e78c08f1c86]::benchmark_log_5k::{closure#0} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5f50df95a77b - <fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   27:     0x5f50df95a77b - test[a8007afcd3effadc]::__rust_begin_short_backtrace::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:724:18
[INFO] [stdout]   28:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:74
[INFO] [stdout]   29:     0x5f50df967f6b - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   30:     0x5f50df967f6b - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   31:     0x5f50df967f6b - std[ec419fa8110287d5]::panicking::catch_unwind::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   32:     0x5f50df967f6b - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   33:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test_in_process
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:27
[INFO] [stdout]   34:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:668:43
[INFO] [stdout]   35:     0x5f50df962944 - test[a8007afcd3effadc]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:698:41
[INFO] [stdout]   36:     0x5f50df962944 - std[ec419fa8110287d5]::sys::backtrace::__rust_begin_short_backtrace::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   37:     0x5f50df96ab72 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   38:     0x5f50df96ab72 - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   39:     0x5f50df96ab72 - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   40:     0x5f50df96ab72 - std[ec419fa8110287d5]::panicking::catch_unwind::<(), core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   41:     0x5f50df96ab72 - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   42:     0x5f50df96ab72 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   43:     0x5f50df96ab72 - <std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x5f50dfae7f8f - <alloc[a8a7aba520129d98]::boxed::Box<dyn core[35159d6ffb30e017]::ops::function::FnOnce<(), Output = ()> + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   45:     0x5f50dfae7f8f - <std[ec419fa8110287d5]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   46:     0x7f4cf69aaaa4 - <unknown>
[INFO] [stdout]   47:     0x7f4cf6a37a64 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- benchmark_api_5k stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'benchmark_api_5k' (372) panicked at scte-core/tests/benchmark.rs:474:10:
[INFO] [stdout] zstd not found on PATH: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f50dfae897a - std[ec419fa8110287d5]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5f50dfae897a - std[ec419fa8110287d5]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec419fa8110287d5]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5f50dfae897a - std[ec419fa8110287d5]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5f50dfae897a - <<std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[35159d6ffb30e017]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5f50dfafcfea - <core[35159d6ffb30e017]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5f50dfafcfea - core[35159d6ffb30e017]::fmt::write
[INFO] [stdout]    6:     0x5f50dfaed1f2 - std[ec419fa8110287d5]::io::default_write_fmt::<alloc[a8a7aba520129d98]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5f50dfaed1f2 - <alloc[a8a7aba520129d98]::vec::Vec<u8> as std[ec419fa8110287d5]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5f50dfac706f - <std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5f50dfac706f - std[ec419fa8110287d5]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5f50dfae0b29 - std[ec419fa8110287d5]::panicking::default_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5f50df96749c - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5f50df96749c - test[a8007afcd3effadc]::test_main_inner::<test[a8007afcd3effadc]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5f50dfae0ce2 - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5f50dfae0ce2 - std[ec419fa8110287d5]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5f50dfac7128 - std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5f50dfabe979 - std[ec419fa8110287d5]::sys::backtrace::__rust_end_short_backtrace::<std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5f50dfac7e3d - __rustc[cfb3622dd870db93]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5f50dfafd77c - core[35159d6ffb30e017]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5f50dfafd4f2 - core[35159d6ffb30e017]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5f50df94b016 - <core[35159d6ffb30e017]::result::Result<std[ec419fa8110287d5]::process::Child, std[ec419fa8110287d5]::io::error::Error>>::expect
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5f50df9556c4 - benchmark[46c10e78c08f1c86]::zstd_len
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:474:10
[INFO] [stdout]   22:     0x5f50df95500c - benchmark[46c10e78c08f1c86]::measure
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:532:15
[INFO] [stdout]   23:     0x5f50df955c30 - benchmark[46c10e78c08f1c86]::benchmark_api_5k
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:560:5
[INFO] [stdout]   24:     0x5f50df94ff17 - benchmark[46c10e78c08f1c86]::benchmark_api_5k::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:559:22
[INFO] [stdout]   25:     0x5f50df94efb6 - <benchmark[46c10e78c08f1c86]::benchmark_api_5k::{closure#0} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5f50df95a77b - <fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   27:     0x5f50df95a77b - test[a8007afcd3effadc]::__rust_begin_short_backtrace::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:724:18
[INFO] [stdout]   28:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:74
[INFO] [stdout]   29:     0x5f50df967f6b - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   30:     0x5f50df967f6b - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   31:     0x5f50df967f6b - std[ec419fa8110287d5]::panicking::catch_unwind::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   32:     0x5f50df967f6b - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   33:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test_in_process
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:27
[INFO] [stdout]   34:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:668:43
[INFO] [stdout]   35:     0x5f50df962944 - test[a8007afcd3effadc]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:698:41
[INFO] [stdout]   36:     0x5f50df962944 - std[ec419fa8110287d5]::sys::backtrace::__rust_begin_short_backtrace::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   37:     0x5f50df96ab72 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   38:     0x5f50df96ab72 - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   39:     0x5f50df96ab72 - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   40:     0x5f50df96ab72 - std[ec419fa8110287d5]::panicking::catch_unwind::<(), core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   41:     0x5f50df96ab72 - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   42:     0x5f50df96ab72 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   43:     0x5f50df96ab72 - <std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x5f50dfae7f8f - <alloc[a8a7aba520129d98]::boxed::Box<dyn core[35159d6ffb30e017]::ops::function::FnOnce<(), Output = ()> + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   45:     0x5f50dfae7f8f - <std[ec419fa8110287d5]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   46:     0x7f4cf69aaaa4 - <unknown>
[INFO] [stdout]   47:     0x7f4cf6a37a64 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- benchmark_log_10k stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'benchmark_log_10k' (373) panicked at scte-core/tests/benchmark.rs:474:10:
[INFO] [stdout] zstd not found on PATH: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f50dfae897a - std[ec419fa8110287d5]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5f50dfae897a - std[ec419fa8110287d5]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec419fa8110287d5]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5f50dfae897a - std[ec419fa8110287d5]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5f50dfae897a - <<std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[35159d6ffb30e017]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5f50dfafcfea - <core[35159d6ffb30e017]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5f50dfafcfea - core[35159d6ffb30e017]::fmt::write
[INFO] [stdout]    6:     0x5f50dfaed1f2 - std[ec419fa8110287d5]::io::default_write_fmt::<alloc[a8a7aba520129d98]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5f50dfaed1f2 - <alloc[a8a7aba520129d98]::vec::Vec<u8> as std[ec419fa8110287d5]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5f50dfac706f - <std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5f50dfac706f - std[ec419fa8110287d5]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5f50dfae0b29 - std[ec419fa8110287d5]::panicking::default_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5f50df96749c - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5f50df96749c - test[a8007afcd3effadc]::test_main_inner::<test[a8007afcd3effadc]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5f50dfae0ce2 - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5f50dfae0ce2 - std[ec419fa8110287d5]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5f50dfac7128 - std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5f50dfabe979 - std[ec419fa8110287d5]::sys::backtrace::__rust_end_short_backtrace::<std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5f50dfac7e3d - __rustc[cfb3622dd870db93]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5f50dfafd77c - core[35159d6ffb30e017]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5f50dfafd4f2 - core[35159d6ffb30e017]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5f50df94b016 - <core[35159d6ffb30e017]::result::Result<std[ec419fa8110287d5]::process::Child, std[ec419fa8110287d5]::io::error::Error>>::expect
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5f50df9556c4 - benchmark[46c10e78c08f1c86]::zstd_len
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:474:10
[INFO] [stdout]   22:     0x5f50df95500c - benchmark[46c10e78c08f1c86]::measure
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:532:15
[INFO] [stdout]   23:     0x5f50df955e82 - benchmark[46c10e78c08f1c86]::benchmark_log_10k
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:551:26
[INFO] [stdout]   24:     0x5f50df94ffa7 - benchmark[46c10e78c08f1c86]::benchmark_log_10k::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/scte-core/tests/benchmark.rs:551:23
[INFO] [stdout]   25:     0x5f50df94f076 - <benchmark[46c10e78c08f1c86]::benchmark_log_10k::{closure#0} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5f50df95a77b - <fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   27:     0x5f50df95a77b - test[a8007afcd3effadc]::__rust_begin_short_backtrace::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:724:18
[INFO] [stdout]   28:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:74
[INFO] [stdout]   29:     0x5f50df967f6b - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   30:     0x5f50df967f6b - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   31:     0x5f50df967f6b - std[ec419fa8110287d5]::panicking::catch_unwind::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   32:     0x5f50df967f6b - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   33:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test_in_process
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:27
[INFO] [stdout]   34:     0x5f50df967f6b - test[a8007afcd3effadc]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:668:43
[INFO] [stdout]   35:     0x5f50df962944 - test[a8007afcd3effadc]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:698:41
[INFO] [stdout]   36:     0x5f50df962944 - std[ec419fa8110287d5]::sys::backtrace::__rust_begin_short_backtrace::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   37:     0x5f50df96ab72 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   38:     0x5f50df96ab72 - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   39:     0x5f50df96ab72 - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   40:     0x5f50df96ab72 - std[ec419fa8110287d5]::panicking::catch_unwind::<(), core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   41:     0x5f50df96ab72 - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   42:     0x5f50df96ab72 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   43:     0x5f50df96ab72 - <std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x5f50dfae7f8f - <alloc[a8a7aba520129d98]::boxed::Box<dyn core[35159d6ffb30e017]::ops::function::FnOnce<(), Output = ()> + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   45:     0x5f50dfae7f8f - <std[ec419fa8110287d5]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   46:     0x7f4cf69aaaa4 - <unknown>
[INFO] [stdout]   47:     0x7f4cf6a37a64 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     benchmark_api_1k
[INFO] [stdout]     benchmark_api_5k
[INFO] [stdout]     benchmark_log_10k
[INFO] [stdout]     benchmark_log_1k
[INFO] [stdout]     benchmark_log_5k
[INFO] [stdout]     benchmark_summary
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 6 passed; 6 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.36s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "d4adcda00e3fcac6ae7d6551f5e747fdac63bf024be9d089f2d61c76b3e184d9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d4adcda00e3fcac6ae7d6551f5e747fdac63bf024be9d089f2d61c76b3e184d9", kill_on_drop: false }`
[INFO] [stdout] d4adcda00e3fcac6ae7d6551f5e747fdac63bf024be9d089f2d61c76b3e184d9
