[INFO] cloning repository https://github.com/eugenehp/bids-rs
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/eugenehp/bids-rs" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Feugenehp%2Fbids-rs", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Feugenehp%2Fbids-rs'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] f57cb249b0de4c1d9b38bd50f775820f33b43af9
[INFO] testing eugenehp/bids-rs against master#ec6f9a5b4413f74386267ef8efc93712c2ce6db6 for pr-155739
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Feugenehp%2Fbids-rs" "/workspace/builds/worker-2-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc1/source'...
[INFO] [stderr] done.
[INFO] removed /workspace/builds/worker-2-tc1/source/.cargo/config.toml
[INFO] started tweaking git repo https://github.com/eugenehp/bids-rs
[INFO] finished tweaking git repo https://github.com/eugenehp/bids-rs
[INFO] tweaked toml for git repo https://github.com/eugenehp/bids-rs written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/eugenehp/bids-rs on toolchain ec6f9a5b4413f74386267ef8efc93712c2ce6db6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/eugenehp/bids-rs 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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded safetensors v0.5.3
[INFO] [stderr]   Downloaded arrow-data v54.3.1
[INFO] [stderr]   Downloaded hdf5-metno-derive v0.10.0
[INFO] [stderr]   Downloaded arrow-select v54.3.1
[INFO] [stderr]   Downloaded pyo3-macros v0.25.1
[INFO] [stderr]   Downloaded hdf5-metno-types v0.11.0
[INFO] [stderr]   Downloaded winreg v0.55.0
[INFO] [stderr]   Downloaded arrow-schema v54.3.1
[INFO] [stderr]   Downloaded flatbuffers v24.12.23
[INFO] [stderr]   Downloaded fiff v0.1.0
[INFO] [stderr]   Downloaded arrow-csv v54.3.1
[INFO] [stderr]   Downloaded pyo3-build-config v0.25.1
[INFO] [stderr]   Downloaded hdf5-metno-sys v0.11.2
[INFO] [stderr]   Downloaded arrow-buffer v54.3.1
[INFO] [stderr]   Downloaded arrow-ipc v54.3.1
[INFO] [stderr]   Downloaded pyo3-macros-backend v0.25.1
[INFO] [stderr]   Downloaded pyo3-ffi v0.25.1
[INFO] [stderr]   Downloaded arrow-cast v54.3.1
[INFO] [stderr]   Downloaded brotli-decompressor v4.0.3
[INFO] [stderr]   Downloaded hdf5-metno v0.12.3
[INFO] [stderr]   Downloaded zune-jpeg v0.5.14
[INFO] [stderr]   Downloaded arrow-array v54.3.1
[INFO] [stderr]   Downloaded parquet v54.3.1
[INFO] [stderr]   Downloaded pyo3 v0.25.1
[INFO] [stderr]   Downloaded brotli v7.0.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 3d4d449fa17108a130e65f76fb5e9aba3d3f5e45341ec7091cdac53e0f468bf9
[INFO] running `Command { std: "docker" "start" "-a" "3d4d449fa17108a130e65f76fb5e9aba3d3f5e45341ec7091cdac53e0f468bf9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3d4d449fa17108a130e65f76fb5e9aba3d3f5e45341ec7091cdac53e0f468bf9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3d4d449fa17108a130e65f76fb5e9aba3d3f5e45341ec7091cdac53e0f468bf9", kill_on_drop: false }`
[INFO] [stdout] 3d4d449fa17108a130e65f76fb5e9aba3d3f5e45341ec7091cdac53e0f468bf9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 829543a90ebac74dd7d2f4834defe0c214c359b5a448583648dd914ef14db240
[INFO] running `Command { std: "docker" "start" "-a" "829543a90ebac74dd7d2f4834defe0c214c359b5a448583648dd914ef14db240", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling cc v1.2.57
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling hashbrown v0.15.5
[INFO] [stderr]    Compiling csv-core v0.1.13
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling flate2 v1.1.9
[INFO] [stderr]    Compiling target-lexicon v0.13.5
[INFO] [stderr]    Compiling libc v0.2.183
[INFO] [stderr]    Compiling bids-filter v0.0.1 (/opt/rustwide/workdir/crates/bids-filter)
[INFO] [stderr]    Compiling httparse v1.10.1
[INFO] [stderr]    Compiling rustls v0.23.37
[INFO] [stderr]    Compiling http v1.4.0
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling utf8-zero v0.8.1
[INFO] [stderr]    Compiling bids-inflect v0.0.1 (/opt/rustwide/workdir/crates/bids-inflect)
[INFO] [stderr]    Compiling bids-formula v0.0.1 (/opt/rustwide/workdir/crates/bids-formula)
[INFO] [stderr]    Compiling portable-atomic v1.13.1
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling bstr v1.12.1
[INFO] [stderr]    Compiling number_prefix v0.4.0
[INFO] [stderr]    Compiling indoc v2.0.7
[INFO] [stderr]    Compiling pyo3-build-config v0.25.1
[INFO] [stderr]    Compiling hashlink v0.10.0
[INFO] [stderr]    Compiling libsqlite3-sys v0.35.0
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling ureq-proto v0.6.0
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling pyo3-ffi v0.25.1
[INFO] [stderr]    Compiling pyo3-macros-backend v0.25.1
[INFO] [stderr]    Compiling pyo3 v0.25.1
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling console v0.15.11
[INFO] [stderr]    Compiling indicatif v0.17.11
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling indexmap v2.13.0
[INFO] [stderr]    Compiling csv v1.4.0
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling globset v0.4.18
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling bytemuck_derive v1.10.2
[INFO] [stderr]    Compiling clap_derive v4.6.0
[INFO] [stderr]    Compiling rustls-webpki v0.103.10
[INFO] [stderr]    Compiling bytemuck v1.25.0
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling clap v4.6.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling pyo3-macros v0.25.1
[INFO] [stderr]    Compiling bids-core v0.0.1 (/opt/rustwide/workdir/crates/bids-core)
[INFO] [stderr]    Compiling bids-schema v0.0.1 (/opt/rustwide/workdir/crates/bids-schema)
[INFO] [stderr]    Compiling ureq v3.3.0
[INFO] [stderr]    Compiling bids-io v0.0.1 (/opt/rustwide/workdir/crates/bids-io)
[INFO] [stderr]    Compiling bids-validate v0.0.1 (/opt/rustwide/workdir/crates/bids-validate)
[INFO] [stderr]    Compiling bids-nifti v0.0.1 (/opt/rustwide/workdir/crates/bids-nifti)
[INFO] [stderr]    Compiling rusqlite v0.37.0
[INFO] [stderr]    Compiling bids-layout v0.0.1 (/opt/rustwide/workdir/crates/bids-layout)
[INFO] [stderr]    Compiling bids-variables v0.0.1 (/opt/rustwide/workdir/crates/bids-variables)
[INFO] [stderr]    Compiling bids-micr v0.0.1 (/opt/rustwide/workdir/crates/bids-micr)
[INFO] [stderr]    Compiling bids-perf v0.0.1 (/opt/rustwide/workdir/crates/bids-perf)
[INFO] [stderr]    Compiling bids-beh v0.0.1 (/opt/rustwide/workdir/crates/bids-beh)
[INFO] [stderr]    Compiling bids-reports v0.0.1 (/opt/rustwide/workdir/crates/bids-reports)
[INFO] [stderr]    Compiling bids-mrs v0.0.1 (/opt/rustwide/workdir/crates/bids-mrs)
[INFO] [stderr]    Compiling bids-derive v0.0.1 (/opt/rustwide/workdir/crates/bids-derive)
[INFO] [stderr]    Compiling bids-dataset v0.0.1 (/opt/rustwide/workdir/crates/bids-dataset)
[INFO] [stderr]    Compiling bids-eeg v0.0.1 (/opt/rustwide/workdir/crates/bids-eeg)
[INFO] [stderr]    Compiling bids-modeling v0.0.1 (/opt/rustwide/workdir/crates/bids-modeling)
[INFO] [stderr]    Compiling bids-meg v0.0.1 (/opt/rustwide/workdir/crates/bids-meg)
[INFO] [stderr]    Compiling bids-ieeg v0.0.1 (/opt/rustwide/workdir/crates/bids-ieeg)
[INFO] [stderr]    Compiling bids-pet v0.0.1 (/opt/rustwide/workdir/crates/bids-pet)
[INFO] [stderr]    Compiling bids-motion v0.0.1 (/opt/rustwide/workdir/crates/bids-motion)
[INFO] [stderr]    Compiling bids-nirs v0.0.1 (/opt/rustwide/workdir/crates/bids-nirs)
[INFO] [stderr]    Compiling bids v0.0.2 (/opt/rustwide/workdir/crates/bids)
[INFO] [stderr]    Compiling bids-e2e-tests v0.0.1 (/opt/rustwide/workdir/crates/bids-e2e-tests)
[INFO] [stderr]    Compiling pybids-rs v0.0.1 (/opt/rustwide/workdir/crates/pybids-rs)
[INFO] [stderr]    Compiling bids-cli v0.0.1 (/opt/rustwide/workdir/crates/bids-cli)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 14s
[INFO] running `Command { std: "docker" "inspect" "829543a90ebac74dd7d2f4834defe0c214c359b5a448583648dd914ef14db240", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "829543a90ebac74dd7d2f4834defe0c214c359b5a448583648dd914ef14db240", kill_on_drop: false }`
[INFO] [stdout] 829543a90ebac74dd7d2f4834defe0c214c359b5a448583648dd914ef14db240
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9e1bf32418c073fb26d9269b5d53c8d5d025231d635a10b27265b1d20970ac96
[INFO] running `Command { std: "docker" "start" "-a" "9e1bf32418c073fb26d9269b5d53c8d5d025231d635a10b27265b1d20970ac96", kill_on_drop: false }`
[INFO] [stderr]    Compiling bids-layout v0.0.1 (/opt/rustwide/workdir/crates/bids-layout)
[INFO] [stderr]    Compiling bids-eeg v0.0.1 (/opt/rustwide/workdir/crates/bids-eeg)
[INFO] [stderr]    Compiling bids-modeling v0.0.1 (/opt/rustwide/workdir/crates/bids-modeling)
[INFO] [stderr]    Compiling bids-dataset v0.0.1 (/opt/rustwide/workdir/crates/bids-dataset)
[INFO] [stderr]    Compiling bids-ieeg v0.0.1 (/opt/rustwide/workdir/crates/bids-ieeg)
[INFO] [stderr]    Compiling bids v0.0.2 (/opt/rustwide/workdir/crates/bids)
[INFO] [stderr]    Compiling bids-cli v0.0.1 (/opt/rustwide/workdir/crates/bids-cli)
[INFO] [stderr]    Compiling bids-e2e-tests v0.0.1 (/opt/rustwide/workdir/crates/bids-e2e-tests)
[INFO] [stderr]    Compiling pybids-rs v0.0.1 (/opt/rustwide/workdir/crates/pybids-rs)
[INFO] [stderr]    Compiling bids-nirs v0.0.1 (/opt/rustwide/workdir/crates/bids-nirs)
[INFO] [stdout] warning: unused variable: `expected`
[INFO] [stdout]    --> crates/bids-e2e-tests/src/precision.rs:113:9
[INFO] [stdout]     |
[INFO] [stdout] 113 |     let expected = get_f64_vec(&g["lfilter_output"]);
[INFO] [stdout]     |         ^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_expected`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `expected_first20`
[INFO] [stdout]    --> crates/bids-e2e-tests/src/precision.rs:134:9
[INFO] [stdout]     |
[INFO] [stdout] 134 |     let expected_first20 = get_f64_vec(&g["filtfilt_output_first20"]);
[INFO] [stdout]     |         ^^^^^^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_expected_first20`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `expected_last20`
[INFO] [stdout]    --> crates/bids-e2e-tests/src/precision.rs:135:9
[INFO] [stdout]     |
[INFO] [stdout] 135 |     let expected_last20 = get_f64_vec(&g["filtfilt_output_last20"]);
[INFO] [stdout]     |         ^^^^^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_expected_last20`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `expected_rms`
[INFO] [stdout]    --> crates/bids-e2e-tests/src/precision.rs:136:9
[INFO] [stdout]     |
[INFO] [stdout] 136 |     let expected_rms = g["filtfilt_rms"].as_f64().unwrap();
[INFO] [stdout]     |         ^^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_expected_rms`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable does not need to be mutable
[INFO] [stdout]    --> crates/bids-e2e-tests/src/precision.rs:292:9
[INFO] [stdout]     |
[INFO] [stdout] 292 |     let mut q = (xx - 0.5) * xx.ln() - xx + 0.918938533204672741780329736406;
[INFO] [stdout]     |         ----^
[INFO] [stdout]     |         |
[INFO] [stdout]     |         help: remove this `mut`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_mut)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling bids-meg v0.0.1 (/opt/rustwide/workdir/crates/bids-meg)
[INFO] [stderr]    Compiling bids-motion v0.0.1 (/opt/rustwide/workdir/crates/bids-motion)
[INFO] [stderr]    Compiling bids-pet v0.0.1 (/opt/rustwide/workdir/crates/bids-pet)
[INFO] [stderr]    Compiling bids-derive v0.0.1 (/opt/rustwide/workdir/crates/bids-derive)
[INFO] [stderr]    Compiling bids-beh v0.0.1 (/opt/rustwide/workdir/crates/bids-beh)
[INFO] [stderr]    Compiling bids-micr v0.0.1 (/opt/rustwide/workdir/crates/bids-micr)
[INFO] [stderr]    Compiling bids-mrs v0.0.1 (/opt/rustwide/workdir/crates/bids-mrs)
[INFO] [stderr]    Compiling bids-reports v0.0.1 (/opt/rustwide/workdir/crates/bids-reports)
[INFO] [stderr]    Compiling bids-perf v0.0.1 (/opt/rustwide/workdir/crates/bids-perf)
[INFO] [stderr]    Compiling bids-variables v0.0.1 (/opt/rustwide/workdir/crates/bids-variables)
[INFO] [stderr]    Compiling bids-validate v0.0.1 (/opt/rustwide/workdir/crates/bids-validate)
[INFO] [stderr]    Compiling bids-io v0.0.1 (/opt/rustwide/workdir/crates/bids-io)
[INFO] [stderr]    Compiling bids-nifti v0.0.1 (/opt/rustwide/workdir/crates/bids-nifti)
[INFO] [stderr]    Compiling bids-core v0.0.1 (/opt/rustwide/workdir/crates/bids-core)
[INFO] [stderr]    Compiling bids-schema v0.0.1 (/opt/rustwide/workdir/crates/bids-schema)
[INFO] [stderr]    Compiling bids-filter v0.0.1 (/opt/rustwide/workdir/crates/bids-filter)
[INFO] [stderr]    Compiling bids-inflect v0.0.1 (/opt/rustwide/workdir/crates/bids-inflect)
[INFO] [stderr]    Compiling bids-formula v0.0.1 (/opt/rustwide/workdir/crates/bids-formula)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 18.64s
[INFO] running `Command { std: "docker" "inspect" "9e1bf32418c073fb26d9269b5d53c8d5d025231d635a10b27265b1d20970ac96", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9e1bf32418c073fb26d9269b5d53c8d5d025231d635a10b27265b1d20970ac96", kill_on_drop: false }`
[INFO] [stdout] 9e1bf32418c073fb26d9269b5d53c8d5d025231d635a10b27265b1d20970ac96
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a4de1f11ce72ea2bcdd3da9c68cf7bd8b09205fc1cfee9d9690133356e350977
[INFO] running `Command { std: "docker" "start" "-a" "a4de1f11ce72ea2bcdd3da9c68cf7bd8b09205fc1cfee9d9690133356e350977", kill_on_drop: false }`
[INFO] [stderr] warning: unused variable: `expected`
[INFO] [stderr]    --> crates/bids-e2e-tests/src/precision.rs:113:9
[INFO] [stderr]     |
[INFO] [stderr] 113 |     let expected = get_f64_vec(&g["lfilter_output"]);
[INFO] [stderr]     |         ^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_expected`
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `expected_first20`
[INFO] [stderr]    --> crates/bids-e2e-tests/src/precision.rs:134:9
[INFO] [stderr]     |
[INFO] [stderr] 134 |     let expected_first20 = get_f64_vec(&g["filtfilt_output_first20"]);
[INFO] [stderr]     |         ^^^^^^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_expected_first20`
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `expected_last20`
[INFO] [stderr]    --> crates/bids-e2e-tests/src/precision.rs:135:9
[INFO] [stderr]     |
[INFO] [stderr] 135 |     let expected_last20 = get_f64_vec(&g["filtfilt_output_last20"]);
[INFO] [stderr]     |         ^^^^^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_expected_last20`
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `expected_rms`
[INFO] [stderr]    --> crates/bids-e2e-tests/src/precision.rs:136:9
[INFO] [stderr]     |
[INFO] [stderr] 136 |     let expected_rms = g["filtfilt_rms"].as_f64().unwrap();
[INFO] [stderr]     |         ^^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_expected_rms`
[INFO] [stderr] 
[INFO] [stderr] warning: variable does not need to be mutable
[INFO] [stderr]    --> crates/bids-e2e-tests/src/precision.rs:292:9
[INFO] [stderr]     |
[INFO] [stderr] 292 |     let mut q = (xx - 0.5) * xx.ln() - xx + 0.918938533204672741780329736406;
[INFO] [stderr]     |         ----^
[INFO] [stderr]     |         |
[INFO] [stderr]     |         help: remove this `mut`
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_mut)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `bids-e2e-tests` (lib test) generated 5 warnings (run `cargo fix --lib -p bids-e2e-tests --tests` to apply 5 suggestions)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.33s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids-7b033d1890de4750)
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_beh-f13d2f55c03430e4)
[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] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_beh_events ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/bids-22b54a5b23faf481)
[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 unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_core-bcb9048087da711a)
[INFO] [stdout] 
[INFO] [stdout] running 44 tests
[INFO] [stdout] test dataset_description::tests::test_derivative_description ... ok
[INFO] [stdout] test genetic::tests::test_genetic_info_parse ... ok
[INFO] [stdout] test hed::tests::test_empty ... ok
[INFO] [stdout] test hed::tests::test_extract_all ... ok
[INFO] [stdout] test hed::tests::test_group ... ok
[INFO] [stdout] test metadata::tests::test_metadata_source_file ... ok
[INFO] [stdout] test hed::tests::test_hierarchical ... ok
[INFO] [stdout] test hed::tests::test_simple_tags ... ok
[INFO] [stdout] test genetic::tests::test_genetic_info_missing_file ... ok
[INFO] [stdout] test metadata::tests::test_metadata_deserialize_as ... ok
[INFO] [stdout] test hed::tests::test_mixed ... ok
[INFO] [stdout] test metadata::tests::test_metadata_extend_overrides ... ok
[INFO] [stdout] test file::tests::test_bids_file ... ok
[INFO] [stdout] test metadata::tests::test_metadata_typed_accessors ... ok
[INFO] [stdout] test timeseries::tests::test_band_power ... ok
[INFO] [stdout] test timeseries::tests::test_channel_data_by_name ... ok
[INFO] [stdout] test file::tests::test_natural_sort ... ok
[INFO] [stdout] test file::tests::test_file_type_detection ... ok
[INFO] [stdout] test timeseries::tests::test_epochs_with_stride ... ok
[INFO] [stdout] test genetic::tests::test_genetic_database_parse ... ok
[INFO] [stdout] test timeseries::tests::test_channel_stds ... ok
[INFO] [stdout] test timeseries::tests::test_peak_to_peak ... ok
[INFO] [stdout] test timeseries::tests::test_shape ... ok
[INFO] [stdout] test timeseries::tests::test_times ... ok
[INFO] [stdout] test timeseries::tests::test_covariance_matrix ... ok
[INFO] [stdout] test timeseries::tests::test_epochs ... ok
[INFO] [stdout] test timeseries::tests::test_duration ... ok
[INFO] [stdout] test timeseries::tests::test_channel_means ... ok
[INFO] [stdout] test timeseries::tests::test_to_flat_vec ... ok
[INFO] [stdout] test timeseries::tests::test_window ... ok
[INFO] [stdout] test timeseries::tests::test_z_score ... ok
[INFO] [stdout] test timeseries::tests::test_to_column_major ... ok
[INFO] [stdout] test entities::tests::test_int_entity ... ok
[INFO] [stdout] test dataset_description::tests::test_parse_description ... ok
[INFO] [stdout] test metadata::tests::test_metadata_from_iterator ... ok
[INFO] [stdout] test padded_int::tests::test_padded_int ... ok
[INFO] [stdout] test utils::tests::test_close_matches ... ok
[INFO] [stdout] test utils::tests::test_camel_to_snake ... ok
[INFO] [stdout] test entities::tests::test_entity_matching ... ok
[INFO] [stdout] test entities::tests::test_parse_file_entities ... ok
[INFO] [stdout] test timeseries::tests::test_min_max_normalize ... ok
[INFO] [stdout] test timeseries::tests::test_log_variance ... ok
[INFO] [stdout] test utils::tests::test_matches_entities ... ok
[INFO] [stdout] test utils::tests::test_snake_to_camel ... ok
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_dataset-0a4801f52de4d3fe)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 44 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 38 tests
[INFO] [stdout] test benchmark::tests::test_append_csv ... ok
[INFO] [stdout] test benchmark::tests::test_summary ... ok
[INFO] [stdout] test benchmark::tests::test_mean_scores ... ok
[INFO] [stdout] test benchmark::tests::test_csv_roundtrip ... ok
[INFO] [stdout] test evaluation::tests::test_cross_session ... ok
[INFO] [stdout] test evaluation::tests::test_cross_subject ... ok
[INFO] [stdout] test cache::tests::test_blob_dedup ... ok
[INFO] [stdout] test filter::tests::test_filter_matches_path ... ok
[INFO] [stdout] test evaluation::tests::test_cross_subject_kfold ... ok
[INFO] [stdout] test filter::tests::test_filter_remote ... ok
[INFO] [stdout] test filter::tests::test_filter_subjects ... ok
[INFO] [stdout] test filter::tests::test_filter_tasks ... ok
[INFO] [stdout] test evaluation::tests::test_within_session ... ok
[INFO] [stdout] test ml::tests::test_dataset_iter_with_epochs ... ok
[INFO] [stdout] test aggregate::tests::test_file_entry_serde ... ok
[INFO] [stdout] test ml::tests::test_dataset_iter_shuffle ... ok
[INFO] [stdout] test ml::tests::test_dataset_iter_basic ... ok
[INFO] [stdout] test cache::tests::test_cache_store_and_resolve ... ok
[INFO] [stdout] test ml::tests::test_dataset_iter_with_subjects ... ok
[INFO] [stdout] test ml::tests::test_epoch_spec ... ok
[INFO] [stdout] test ml::tests::test_kfold ... ok
[INFO] [stdout] test ml::tests::test_kfold_iter ... ok
[INFO] [stdout] test paradigm::tests::test_display ... ok
[INFO] [stdout] test paradigm::tests::test_resting_state ... ok
[INFO] [stdout] test openneuro::tests::test_dataset_info_serde ... ok
[INFO] [stdout] test ml::tests::test_label_distribution ... ok
[INFO] [stdout] test split::tests::test_split_partition ... ok
[INFO] [stdout] test paradigm::tests::test_fixed_interval ... ok
[INFO] [stdout] test ratelimit::tests::test_rate_limiter_unlimited ... ok
[INFO] [stdout] test split::tests::test_split_small ... ok
[INFO] [stdout] test paradigm::tests::test_filter_bank ... ok
[INFO] [stdout] test paradigm::tests::test_p300_defaults ... ok
[INFO] [stdout] test openneuro::tests::test_s3_listing_parser ... ok
[INFO] [stdout] test ratelimit::tests::test_parse_retry_after ... ok
[INFO] [stdout] test paradigm::tests::test_motor_imagery_defaults ... ok
[INFO] [stdout] test ml::tests::test_stratified_split ... ok
[INFO] [stdout] test ratelimit::tests::test_rate_limiter_basic ... ok
[INFO] [stdout] test ratelimit::tests::test_cooldown ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 38 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.15s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/live_openneuro.rs (/opt/rustwide/target/debug/deps/live_openneuro-c761d2922bd4f710)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test test_download_small_files ... ignored
[INFO] [stdout] test test_end_to_end_eeg_pipeline ... ignored
[INFO] [stdout] test test_filter_and_aggregate ... ignored
[INFO] [stdout] test test_list_files_s3 ... ignored
[INFO] [stdout] test test_list_full_dataset ... ignored
[INFO] [stdout] test test_search_by_keyword ... ignored
[INFO] [stdout] test test_search_eeg_datasets ... ignored
[INFO] [stdout] test test_search_mri_datasets ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 8 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_derive-080d2727c4312b06)
[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 unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_e2e_tests-9d9a64c153b9cecf)
[INFO] [stdout] 
[INFO] [stdout] running 24 tests
[INFO] [stdout] test fixtures::tests::test_cache_dir_is_absolute ... ok
[INFO] [stdout] test precision::precision_summary ... ok
[INFO] [stdout] test tests::test_butter_coefficients ... ok
[INFO] [stdout] test precision::test_filtfilt_rms ... ok
[INFO] [stdout] test tests::test_formula_basic ... ok
[INFO] [stdout] test tests::test_formula_interaction ... ok
[INFO] [stdout] test tests::test_inflect ... ok
[INFO] [stdout] test precision::test_gamma_pdf_values ... ok
[INFO] [stdout] test tests::benchmark_layout_indexing ... ok
[INFO] [stdout] test tests::test_butter_order1 ... ok
[INFO] [stdout] test tests::test_hrf_glover ... ok
[INFO] [stdout] test tests::test_layout_eeg_rishikesh ... ok
[INFO] [stdout] test tests::test_layout_eeg_cbm ... ok
[INFO] [stdout] test tests::test_filtfilt_energy ... ok
[INFO] [stdout] test tests::test_nifti_header ... ok
[INFO] [stdout] test precision::test_hrf_values_all_configs ... ok
[INFO] [stdout] test tests::test_path_building ... ok
[INFO] [stdout] test precision::test_dc_gain ... ok
[INFO] [stdout] test tests::test_hrf_spm ... ok
[INFO] [stdout] test precision::test_butter_all_orders_cutoffs ... ok
[INFO] [stdout] test tests::test_schema_validation ... ok
[INFO] [stdout] test fixtures::tests::test_require_returns_valid_root ... ok
[INFO] [stdout] test tests::test_entity_parsing ... ok
[INFO] [stderr]      Running tests/bids_examples.rs (/opt/rustwide/target/debug/deps/bids_examples-f3c903ab444af393)
[INFO] [stdout] test precision::test_lfilter_vs_scipy ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test test_derivative_examples ... ok
[INFO] [stdout] test test_ieeg_examples ... ok
[INFO] [stdout] test test_metadata_inheritance ... ok
[INFO] [stdout] test test_eeg_examples ... ok
[INFO] [stdout] test test_mrs_examples ... ok
[INFO] [stdout] test test_validate_all_examples ... ok
[INFO] [stdout] test test_all_datasets_index_successfully ... ok
[INFO] [stdout] test test_motion_examples ... ok
[INFO] [stdout] test test_micr_examples ... ok
[INFO] [stdout] test test_perf_examples ... ok
[INFO] [stdout] test test_nirs_examples ... ok
[INFO] [stdout] test test_all_datasets_have_subjects ... ok
[INFO] [stdout] test test_pet_examples ... ok
[INFO] [stdout] test test_entity_parsing_on_examples ... ok
[INFO] [stdout] test test_schema_validates_example_filenames ... ok
[INFO] [stdout] test test_meg_examples ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/round_trip.rs (/opt/rustwide/target/debug/deps/round_trip-f2652ec4201674d4)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test test_bidsfile_builder ... ok
[INFO] [stdout] test test_metadata_inheritance ... ok
[INFO] [stdout] test test_regex_filter ... ok
[INFO] [stdout] test test_query_return_types ... ok
[INFO] [stdout] test test_parse_and_build_path ... ok
[INFO] [stdout] test test_layout_round_trip ... ok
[INFO] [stdout] test test_persistent_database ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.21s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_eeg-001cf4b9c08a2f6d)
[INFO] [stdout] 
[INFO] [stdout] running 52 tests
[INFO] [stdout] test csp::tests::test_csp_not_fitted ... ok
[INFO] [stdout] test channels::tests::test_read_channels_tsv ... ok
[INFO] [stdout] test coordsystem::tests::test_coordsystem_parse ... ok
[INFO] [stdout] test csp::tests::test_symmetric_eigen ... ok
[INFO] [stdout] test data::tests::test_brainvision_header_parse ... ok
[INFO] [stdout] test data::tests::test_channel_by_name ... ok
[INFO] [stdout] test data::tests::test_concatenate ... ok
[INFO] [stdout] test data::tests::test_display_debug ... ok
[INFO] [stdout] test data::tests::test_convert_units ... ok
[INFO] [stdout] test data::tests::test_brainvision_with_markers ... ok
[INFO] [stdout] test csp::tests::test_csp_transform_all ... ok
[INFO] [stdout] test data::tests::test_edf_tal_parse ... ok
[INFO] [stdout] test data::tests::test_eeg_data_time_slice ... ok
[INFO] [stdout] test data::tests::test_exclude_channels ... ok
[INFO] [stdout] test data::tests::test_get_data_with_times ... ok
[INFO] [stdout] test data::tests::test_epoch_and_average ... ok
[INFO] [stdout] test data::tests::test_eeg_data_select_channels ... ok
[INFO] [stdout] test data::tests::test_read_brainvision ... ok
[INFO] [stdout] test data::tests::test_read_edf_basic ... ok
[INFO] [stdout] test data::tests::test_reject_by_annotation ... ok
[INFO] [stdout] test data::tests::test_filter_lowpass ... ok
[INFO] [stdout] test data::tests::test_read_edf_channel_select ... ok
[INFO] [stdout] test csp::tests::test_csp_fit_transform ... ok
[INFO] [stdout] test data::tests::test_read_edf_with_exclude ... ok
[INFO] [stdout] test data::tests::test_set_average_reference ... ok
[INFO] [stdout] test data::tests::test_times ... ok
[INFO] [stdout] test data::tests::test_vmrk_parse ... ok
[INFO] [stdout] test data::tests::test_set_reference ... ok
[INFO] [stdout] test data::tests::test_stim_channel_detection ... ok
[INFO] [stdout] test data::tests::test_pick_types ... ok
[INFO] [stdout] test data::tests::test_read_eeg_data_dispatch ... ok
[INFO] [stdout] test data::tests::test_read_edf_unknown_n_records ... ok
[INFO] [stdout] test data::tests::test_resample ... ok
[INFO] [stdout] test harmonize::tests::test_apply_harmonization ... ok
[INFO] [stdout] test harmonize::tests::test_intersect_strategy ... ok
[INFO] [stdout] test metadata::tests::test_eeg_metadata_parse ... ok
[INFO] [stdout] test harmonize::tests::test_union_strategy ... ok
[INFO] [stdout] test pipeline::tests::test_save_load_json_file ... ok
[INFO] [stdout] test harmonize::tests::test_sr_shift ... ok
[INFO] [stdout] test pipeline::tests::test_no_epoch_pipeline ... ok
[INFO] [stdout] test eeg_layout::tests::test_companion ... ok
[INFO] [stdout] test events::tests::test_read_events_tsv ... ok
[INFO] [stdout] test pipeline::tests::test_step_visibility ... ok
[INFO] [stdout] test pipeline::tests::test_pipeline_result_helpers ... ok
[INFO] [stdout] test electrodes::tests::test_read_electrodes_tsv ... ok
[INFO] [stdout] test data::tests::test_read_edf_time_range ... ok
[INFO] [stdout] test pipeline::tests::test_pipeline_with_resample ... ok
[INFO] [stdout] test data::tests::test_notch_filter ... ok
[INFO] [stdout] test data::tests::test_compute_psd ... ok
[INFO] [stdout] test pipeline::tests::test_basic_pipeline ... ok
[INFO] [stdout] test pipeline::tests::test_json_roundtrip ... ok
[INFO] [stdout] test data::tests::test_read_edf_large ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.36s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/bench_regression.rs (/opt/rustwide/target/debug/deps/bench_regression-b84fa68dbcc45704)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test regression_numeric_correctness ... ok
[INFO] [stdout] test regression_bdf_32ch_30s ... ok
[INFO] [stdout] test regression_edf_2ch_select ... ok
[INFO] [stdout] test regression_edf_time_window ... ok
[INFO] [stdout] test regression_edf_64ch_60s ... ok
[INFO] [stdout] test regression_brainvision_64ch_60s ... ok
[INFO] [stdout] test regression_edf_large_150mb ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 26.42s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_filter-c9af1900ad6d34cb)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test tests::test_butter_lowpass_order5 ... ok
[INFO] [stdout] test tests::test_butter_bandpass ... ok
[INFO] [stdout] test tests::test_butter_lowpass_order1 ... ok
[INFO] [stdout] test tests::test_filtfilt_removes_high_freq ... ok
[INFO] [stdout] test tests::test_resample_identity ... ok
[INFO] [stdout] test tests::test_butter_highpass ... ok
[INFO] [stdout] test tests::test_lfilter_passthrough ... ok
[INFO] [stdout] test tests::test_resample_upsample ... ok
[INFO] [stdout] test tests::test_notch_filter ... ok
[INFO] [stdout] test tests::test_resample_downsample ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_formula-33b7ea22582218b2)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test tests::test_build_design_matrix ... ok
[INFO] [stdout] test tests::test_interaction_matrix ... ok
[INFO] [stdout] test tests::test_star_expansion ... ok
[INFO] [stdout] test tests::test_interaction ... ok
[INFO] [stdout] test tests::test_no_intercept ... ok
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_ieeg-e169e08aeaa57493)
[INFO] [stdout] test tests::test_simple_formula ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test tests::test_ieeg_coordsystem ... ok
[INFO] [stdout] test tests::test_ieeg_metadata ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_inflect-7f004812c6c9f17f)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test tests::test_roundtrip ... ok
[INFO] [stdout] test tests::test_singularize ... ok
[INFO] [stdout] test tests::test_pluralize ... ok
[INFO] [stdout] test tests::test_singularize_already_singular ... ok
[INFO] [stdout] test tests::test_is_plural ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_io-d18d43a42c337132)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test gradient::tests::test_gradient_table_mismatch ... ok
[INFO] [stdout] test gradient::tests::test_display ... ok
[INFO] [stdout] test gradient::tests::test_gradient_table ... ok
[INFO] [stdout] test writer::tests::test_conflict_fail ... ok
[INFO] [stdout] test gradient::tests::test_read_bvals ... ok
[INFO] [stdout] test writer::tests::test_copy_from ... ok
[INFO] [stdout] test writer::tests::test_conflict_skip ... ok
[INFO] [stdout] test writer::tests::test_write_contents ... ok
[INFO] [stdout] test writer::tests::test_conflict_append ... ok
[INFO] [stdout] test writer::tests::test_conflict_overwrite ... ok
[INFO] [stdout] test writer::tests::test_creates_parent_dirs ... ok
[INFO] [stdout] test tsv::tests::test_read_tsv ... ok
[INFO] [stdout] test writer::tests::test_no_source_errors ... ok
[INFO] [stdout] test path_builder::tests::test_cartesian_product ... ok
[INFO] [stdout] test path_builder::tests::test_expand_options ... ok
[INFO] [stdout] test gradient::tests::test_read_bvecs ... ok
[INFO] [stdout] test json::tests::test_read_json_sidecar ... ok
[INFO] [stdout] test path_builder::tests::test_build_path_basic ... ok
[INFO] [stdout] test path_builder::tests::test_build_paths_expanded ... ok
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_layout-1b64dba703a7a0de)
[INFO] [stdout] test path_builder::tests::test_build_path_with_default ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test db::tests::test_transaction_rollback ... ok
[INFO] [stdout] test db::tests::test_query_none_any ... ok
[INFO] [stdout] test db::tests::test_transactions ... ok
[INFO] [stdout] test db::tests::test_regexp_query ... ok
[INFO] [stdout] test db::tests::test_database_operations ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_meg-f543dcc9ef47e62a)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test ctf::tests::test_missing_res4 ... ok
[INFO] [stdout] test headshape::tests::test_read_no_labels ... ok
[INFO] [stdout] test tests::test_meg_metadata ... ok
[INFO] [stdout] test headshape::tests::test_read_headshape_pos ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_micr-d011295ed21ef2ff)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test tests::test_micr_metadata ... ok
[INFO] [stdout] test ome::tests::test_parse_ome_xml ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_modeling-abc8d53b1314b1ca)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test auto_model::tests::test_auto_model_signature ... ok
[INFO] [stdout] test hrf::tests::test_regressor_names ... ok
[INFO] [stdout] test hrf::tests::test_glover_hrf ... ok
[INFO] [stdout] test graph::tests::test_parse_model ... ok
[INFO] [stdout] test spec::tests::test_dummies_to_vec ... ok
[INFO] [stdout] test hrf::tests::test_spm_hrf ... ok
[INFO] [stdout] test spec::tests::test_compute_vif ... ok
[INFO] [stdout] test transformations::tests::test_factor ... ok
[INFO] [stdout] test transformations::tests::test_scale ... ok
[INFO] [stdout] test transformations::tests::test_rename ... ok
[INFO] [stdout] test transformations::tests::test_threshold ... ok
[INFO] [stdout] test hrf::tests::test_compute_regressor ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.48s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_motion-81ba06d8c40436b0)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_motion_metadata ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_mrs-0b5b194b67874b55)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_mrs_metadata ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_nifti-e5b23d2aba899e3b)
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test gifti::tests::test_not_gifti ... ok
[INFO] [stdout] test qmri::tests::test_qmri_mp2rage ... ok
[INFO] [stdout] test qmri::tests::test_qmri_metadata_parse ... ok
[INFO] [stdout] test tests::test_header_nifti2_synthetic ... ok
[INFO] [stdout] test gifti::tests::test_read_gifti_header ... ok
[INFO] [stdout] test cifti::tests::test_parse_brain_models ... ok
[INFO] [stdout] test tests::test_load_single_volume ... ok
[INFO] [stdout] test tests::test_load_gzip ... ok
[INFO] [stdout] test tests::test_scaling ... ok
[INFO] [stdout] test tests::test_load_4d_image ... ok
[INFO] [stdout] test tests::test_sform_affine ... ok
[INFO] [stdout] test tests::test_int16_datatype ... ok
[INFO] [stdout] test tests::test_load_3d_image ... ok
[INFO] [stdout] test mmap::tests::test_mmap_lazy_volume ... ok
[INFO] [stdout] test tests::test_header_nifti1 ... ok
[INFO] [stderr] error: test failed, to rerun pass `-p bids-nifti --lib`
[INFO] [stdout] test tests::test_large_4d_performance ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_large_4d_performance stdout ----
[INFO] [stdout]   NIfTI 64×64×32×100 float32 (52MB): 595.1ms (88 MB/s)
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_large_4d_performance' (315) panicked at crates/bids-nifti/src/lib.rs:1219:9:
[INFO] [stdout] NIfTI read took 595ms, expected <500ms
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f4de8fe9f8a - std[29689e6404d28ef9]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5f4de8fe9f8a - std[29689e6404d28ef9]::backtrace_rs::backtrace::trace_unsynchronized::<std[29689e6404d28ef9]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5f4de8fe9f8a - std[29689e6404d28ef9]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5f4de8fe9f8a - <<std[29689e6404d28ef9]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[e929cb53b82a81ca]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5f4de8ffeaaa - <core[e929cb53b82a81ca]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5f4de8ffeaaa - core[e929cb53b82a81ca]::fmt::write
[INFO] [stdout]    6:     0x5f4de8fee8e2 - std[29689e6404d28ef9]::io::default_write_fmt::<alloc[9d7caffeb3b5d2c6]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5f4de8fee8e2 - <alloc[9d7caffeb3b5d2c6]::vec::Vec<u8> as std[29689e6404d28ef9]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5f4de8fc716f - <std[29689e6404d28ef9]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5f4de8fc716f - std[29689e6404d28ef9]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5f4de8fe15d9 - std[29689e6404d28ef9]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5f4de8f09efc - <alloc[9d7caffeb3b5d2c6]::boxed::Box<dyn for<'a, 'b> core[e929cb53b82a81ca]::ops::function::Fn<(&'a std[29689e6404d28ef9]::panic::PanicHookInfo<'b>,), Output = ()> + core[e929cb53b82a81ca]::marker::Send + core[e929cb53b82a81ca]::marker::Sync> as core[e929cb53b82a81ca]::ops::function::Fn<(&std[29689e6404d28ef9]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5f4de8f09efc - test[a24b3028667022f7]::test_main_inner::<test[a24b3028667022f7]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5f4de8fe1792 - <alloc[9d7caffeb3b5d2c6]::boxed::Box<dyn for<'a, 'b> core[e929cb53b82a81ca]::ops::function::Fn<(&'a std[29689e6404d28ef9]::panic::PanicHookInfo<'b>,), Output = ()> + core[e929cb53b82a81ca]::marker::Send + core[e929cb53b82a81ca]::marker::Sync> as core[e929cb53b82a81ca]::ops::function::Fn<(&std[29689e6404d28ef9]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5f4de8fe1792 - std[29689e6404d28ef9]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5f4de8fc7228 - std[29689e6404d28ef9]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5f4de8fbc209 - std[29689e6404d28ef9]::sys::backtrace::__rust_end_short_backtrace::<std[29689e6404d28ef9]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5f4de8fc7f3d - __rustc[3aed6af316653e63]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5f4de8fff23c - core[e929cb53b82a81ca]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5f4de8efc5ef - bids_nifti[47f94350d68bf3d2]::tests::test_large_4d_performance
[INFO] [stdout]                                at /opt/rustwide/workdir/crates/bids-nifti/src/lib.rs:1219:9
[INFO] [stdout]   20:     0x5f4de8ef3687 - bids_nifti[47f94350d68bf3d2]::tests::test_large_4d_performance::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/crates/bids-nifti/src/lib.rs:1182:35
[INFO] [stdout]   21:     0x5f4de8eea0b6 - <bids_nifti[47f94350d68bf3d2]::tests::test_large_4d_performance::{closure#0} as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   22:     0x5f4de8efd1db - <fn() -> core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x5f4de8efd1db - test[a24b3028667022f7]::__rust_begin_short_backtrace::<core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>, fn() -> core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:724:18
[INFO] [stdout]   24:     0x5f4de8f0a9cb - test[a24b3028667022f7]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:747:74
[INFO] [stdout]   25:     0x5f4de8f0a9cb - <core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   26:     0x5f4de8f0a9cb - std[29689e6404d28ef9]::panicking::catch_unwind::do_call::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}>, core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   27:     0x5f4de8f0a9cb - std[29689e6404d28ef9]::panicking::catch_unwind::<core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>, core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   28:     0x5f4de8f0a9cb - std[29689e6404d28ef9]::panic::catch_unwind::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}>, core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stdout]   29:     0x5f4de8f0a9cb - test[a24b3028667022f7]::run_test_in_process
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:747:27
[INFO] [stdout]   30:     0x5f4de8f0a9cb - test[a24b3028667022f7]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:668:43
[INFO] [stdout]   31:     0x5f4de8f040e4 - test[a24b3028667022f7]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:698:41
[INFO] [stdout]   32:     0x5f4de8f040e4 - std[29689e6404d28ef9]::sys::backtrace::__rust_begin_short_backtrace::<test[a24b3028667022f7]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   33:     0x5f4de8f0d5d2 - std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked::<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   34:     0x5f4de8f0d5d2 - <core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   35:     0x5f4de8f0d5d2 - std[29689e6404d28ef9]::panicking::catch_unwind::do_call::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   36:     0x5f4de8f0d5d2 - std[29689e6404d28ef9]::panicking::catch_unwind::<(), core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   37:     0x5f4de8f0d5d2 - std[29689e6404d28ef9]::panic::catch_unwind::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stdout]   38:     0x5f4de8f0d5d2 - std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked::<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   39:     0x5f4de8f0d5d2 - <std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1} as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x5f4de8fe907f - <alloc[9d7caffeb3b5d2c6]::boxed::Box<dyn core[e929cb53b82a81ca]::ops::function::FnOnce<(), Output = ()> + core[e929cb53b82a81ca]::marker::Send> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   41:     0x5f4de8fe907f - <std[29689e6404d28ef9]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   42:     0x7cf04dbd8aa4 - <unknown>
[INFO] [stdout]   43:     0x7cf04dc65a64 - clone
[INFO] [stdout]   44:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::test_large_4d_performance
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 15 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.28s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "a4de1f11ce72ea2bcdd3da9c68cf7bd8b09205fc1cfee9d9690133356e350977", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a4de1f11ce72ea2bcdd3da9c68cf7bd8b09205fc1cfee9d9690133356e350977", kill_on_drop: false }`
[INFO] [stdout] a4de1f11ce72ea2bcdd3da9c68cf7bd8b09205fc1cfee9d9690133356e350977
