[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#562dee4820c458d823175268e41601d4c060588a for pr-154210 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Feugenehp%2Fbids-rs" "/workspace/builds/worker-3-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc1/source'... [INFO] [stderr] done. [INFO] removed /workspace/builds/worker-3-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-3-tc1/source/Cargo.toml [INFO] validating manifest of git repo https://github.com/eugenehp/bids-rs on toolchain 562dee4820c458d823175268e41601d4c060588a [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "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" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Updating crates.io index [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded utf8-zero v0.8.1 [INFO] [stderr] Downloaded lz4_flex v0.11.6 [INFO] [stderr] Downloaded hdf5-metno-derive v0.10.0 [INFO] [stderr] Downloaded pyo3-macros v0.25.1 [INFO] [stderr] Downloaded safetensors v0.5.3 [INFO] [stderr] Downloaded fiff v0.1.0 [INFO] [stderr] Downloaded hdf5-metno-types v0.11.0 [INFO] [stderr] Downloaded flatbuffers v24.12.23 [INFO] [stderr] Downloaded arrow-csv v54.3.1 [INFO] [stderr] Downloaded pyo3-ffi v0.25.1 [INFO] [stderr] Downloaded pyo3-macros-backend v0.25.1 [INFO] [stderr] Downloaded arrow-select v54.3.1 [INFO] [stderr] Downloaded arrow-cast v54.3.1 [INFO] [stderr] Downloaded arrow-ipc v54.3.1 [INFO] [stderr] Downloaded hdf5-metno v0.12.3 [INFO] [stderr] Downloaded zune-jpeg v0.5.14 [INFO] [stderr] Downloaded brotli-decompressor v4.0.3 [INFO] [stderr] Downloaded ureq v3.3.0 [INFO] [stderr] Downloaded zerocopy-derive v0.8.47 [INFO] [stderr] Downloaded arrow-array v54.3.1 [INFO] [stderr] Downloaded pyo3-build-config v0.25.1 [INFO] [stderr] Downloaded hdf5-metno-sys v0.11.2 [INFO] [stderr] Downloaded zerocopy v0.8.47 [INFO] [stderr] Downloaded arrow-buffer v54.3.1 [INFO] [stderr] Downloaded arrow-data v54.3.1 [INFO] [stderr] Downloaded arrow-schema v54.3.1 [INFO] [stderr] Downloaded ureq-proto v0.6.0 [INFO] [stderr] Downloaded parquet v54.3.1 [INFO] [stderr] Downloaded pyo3 v0.25.1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 3f58f9c4cc9a0e247f04caee46c14848462a2b7618615d009d90f5527727c6f4 [INFO] running `Command { std: "docker" "start" "-a" "3f58f9c4cc9a0e247f04caee46c14848462a2b7618615d009d90f5527727c6f4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "3f58f9c4cc9a0e247f04caee46c14848462a2b7618615d009d90f5527727c6f4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3f58f9c4cc9a0e247f04caee46c14848462a2b7618615d009d90f5527727c6f4", kill_on_drop: false }` [INFO] [stdout] 3f58f9c4cc9a0e247f04caee46c14848462a2b7618615d009d90f5527727c6f4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 4625c4dcdfca47fa9a6c33120316d0bd4e9af77983167a3a53f711d5030ccb00 [INFO] running `Command { std: "docker" "start" "-a" "4625c4dcdfca47fa9a6c33120316d0bd4e9af77983167a3a53f711d5030ccb00", kill_on_drop: false }` [INFO] [stderr] Compiling memchr v2.8.0 [INFO] [stderr] Compiling serde_core v1.0.228 [INFO] [stderr] Compiling itoa v1.0.18 [INFO] [stderr] Compiling cc v1.2.57 [INFO] [stderr] Compiling simd-adler32 v0.3.8 [INFO] [stderr] Compiling bitflags v2.11.0 [INFO] [stderr] Compiling fallible-streaming-iterator v0.1.9 [INFO] [stderr] Compiling fallible-iterator v0.3.0 [INFO] [stderr] Compiling syn v2.0.117 [INFO] [stderr] Compiling target-lexicon v0.13.5 [INFO] [stderr] Compiling bids-filter v0.0.1 (/opt/rustwide/workdir/crates/bids-filter) [INFO] [stderr] Compiling hashlink v0.10.0 [INFO] [stderr] Compiling zeroize v1.8.2 [INFO] [stderr] Compiling getrandom v0.2.17 [INFO] [stderr] Compiling httparse v1.10.1 [INFO] [stderr] Compiling rustls v0.23.37 [INFO] [stderr] Compiling miniz_oxide v0.8.9 [INFO] [stderr] Compiling http v1.4.0 [INFO] [stderr] Compiling crypto-common v0.1.7 [INFO] [stderr] Compiling rustls-pki-types v1.14.0 [INFO] [stderr] Compiling anstyle-parse v1.0.0 [INFO] [stderr] Compiling portable-atomic v1.13.1 [INFO] [stderr] Compiling utf8-zero v0.8.1 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling colorchoice v1.0.5 [INFO] [stderr] Compiling bids-formula v0.0.1 (/opt/rustwide/workdir/crates/bids-formula) [INFO] [stderr] Compiling anstyle v1.0.14 [INFO] [stderr] Compiling bids-inflect v0.0.1 (/opt/rustwide/workdir/crates/bids-inflect) [INFO] [stderr] Compiling clap_lex v1.1.0 [INFO] [stderr] Compiling console v0.15.11 [INFO] [stderr] Compiling anstream v1.0.0 [INFO] [stderr] Compiling number_prefix v0.4.0 [INFO] [stderr] Compiling unindent v0.2.4 [INFO] [stderr] Compiling sha2 v0.10.9 [INFO] [stderr] Compiling webpki-roots v1.0.6 [INFO] [stderr] Compiling flate2 v1.1.9 [INFO] [stderr] Compiling clap_builder v4.6.0 [INFO] [stderr] Compiling ureq-proto v0.6.0 [INFO] [stderr] Compiling aho-corasick v1.1.4 [INFO] [stderr] Compiling csv-core v0.1.13 [INFO] [stderr] Compiling bstr v1.12.1 [INFO] [stderr] Compiling pyo3-build-config v0.25.1 [INFO] [stderr] Compiling libsqlite3-sys v0.35.0 [INFO] [stderr] Compiling ring v0.17.14 [INFO] [stderr] Compiling indicatif v0.17.11 [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 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 thiserror v2.0.18 [INFO] [stderr] Compiling bytemuck v1.25.0 [INFO] [stderr] Compiling rustls-webpki v0.103.10 [INFO] [stderr] Compiling clap v4.6.0 [INFO] [stderr] Compiling serde v1.0.228 [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 pyo3-macros v0.25.1 [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 ureq v3.3.0 [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-reports v0.0.1 (/opt/rustwide/workdir/crates/bids-reports) [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-beh v0.0.1 (/opt/rustwide/workdir/crates/bids-beh) [INFO] [stderr] Compiling bids-perf v0.0.1 (/opt/rustwide/workdir/crates/bids-perf) [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 56.79s [INFO] running `Command { std: "docker" "inspect" "4625c4dcdfca47fa9a6c33120316d0bd4e9af77983167a3a53f711d5030ccb00", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4625c4dcdfca47fa9a6c33120316d0bd4e9af77983167a3a53f711d5030ccb00", kill_on_drop: false }` [INFO] [stdout] 4625c4dcdfca47fa9a6c33120316d0bd4e9af77983167a3a53f711d5030ccb00 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 1d1d9b69aa7ab837249731faf9a441bfaa1fc06e4582254c1f086a63bfd78999 [INFO] running `Command { std: "docker" "start" "-a" "1d1d9b69aa7ab837249731faf9a441bfaa1fc06e4582254c1f086a63bfd78999", kill_on_drop: false }` [INFO] [stderr] Compiling bids-layout v0.0.1 (/opt/rustwide/workdir/crates/bids-layout) [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-modeling v0.0.1 (/opt/rustwide/workdir/crates/bids-modeling) [INFO] [stderr] Compiling bids-pet v0.0.1 (/opt/rustwide/workdir/crates/bids-pet) [INFO] [stderr] Compiling bids-eeg v0.0.1 (/opt/rustwide/workdir/crates/bids-eeg) [INFO] [stderr] Compiling bids-e2e-tests v0.0.1 (/opt/rustwide/workdir/crates/bids-e2e-tests) [INFO] [stderr] Compiling bids-dataset v0.0.1 (/opt/rustwide/workdir/crates/bids-dataset) [INFO] [stderr] Compiling bids-cli v0.0.1 (/opt/rustwide/workdir/crates/bids-cli) [INFO] [stderr] Compiling bids v0.0.2 (/opt/rustwide/workdir/crates/bids) [INFO] [stderr] Compiling pybids-rs v0.0.1 (/opt/rustwide/workdir/crates/pybids-rs) [INFO] [stderr] Compiling bids-motion v0.0.1 (/opt/rustwide/workdir/crates/bids-motion) [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-ieeg v0.0.1 (/opt/rustwide/workdir/crates/bids-ieeg) [INFO] [stderr] Compiling bids-nirs v0.0.1 (/opt/rustwide/workdir/crates/bids-nirs) [INFO] [stderr] Compiling bids-micr v0.0.1 (/opt/rustwide/workdir/crates/bids-micr) [INFO] [stderr] Compiling bids-derive v0.0.1 (/opt/rustwide/workdir/crates/bids-derive) [INFO] [stderr] Compiling bids-variables v0.0.1 (/opt/rustwide/workdir/crates/bids-variables) [INFO] [stderr] Compiling bids-beh v0.0.1 (/opt/rustwide/workdir/crates/bids-beh) [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-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-formula v0.0.1 (/opt/rustwide/workdir/crates/bids-formula) [INFO] [stderr] Compiling bids-inflect v0.0.1 (/opt/rustwide/workdir/crates/bids-inflect) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 17.24s [INFO] running `Command { std: "docker" "inspect" "1d1d9b69aa7ab837249731faf9a441bfaa1fc06e4582254c1f086a63bfd78999", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "1d1d9b69aa7ab837249731faf9a441bfaa1fc06e4582254c1f086a63bfd78999", kill_on_drop: false }` [INFO] [stdout] 1d1d9b69aa7ab837249731faf9a441bfaa1fc06e4582254c1f086a63bfd78999 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] ebb88b23b09f05f4a1287a2ab0e073ddae5fc1dff6d12aea1901fea0f84c4a25 [INFO] running `Command { std: "docker" "start" "-a" "ebb88b23b09f05f4a1287a2ab0e073ddae5fc1dff6d12aea1901fea0f84c4a25", 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.34s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids-3b5087c730693737) [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_beh-0d10f93145940046) [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-d8c0c25bfdd88a00) [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-54d74667b3d22058) [INFO] [stdout] [INFO] [stdout] running 44 tests [INFO] [stdout] test dataset_description::tests::test_derivative_description ... ok [INFO] [stdout] test dataset_description::tests::test_parse_description ... ok [INFO] [stdout] test file::tests::test_bids_file ... ok [INFO] [stdout] test file::tests::test_file_type_detection ... ok [INFO] [stdout] test genetic::tests::test_genetic_info_missing_file ... ok [INFO] [stdout] test genetic::tests::test_genetic_database_parse ... ok [INFO] [stdout] test genetic::tests::test_genetic_info_parse ... ok [INFO] [stdout] test hed::tests::test_extract_all ... ok [INFO] [stdout] test hed::tests::test_group ... ok [INFO] [stdout] test hed::tests::test_hierarchical ... ok [INFO] [stdout] test entities::tests::test_entity_matching ... ok [INFO] [stdout] test hed::tests::test_empty ... ok [INFO] [stdout] test entities::tests::test_int_entity ... ok [INFO] [stdout] test hed::tests::test_mixed ... ok [INFO] [stdout] test entities::tests::test_parse_file_entities ... ok [INFO] [stdout] test hed::tests::test_simple_tags ... ok [INFO] [stdout] test metadata::tests::test_metadata_extend_overrides ... ok [INFO] [stdout] test metadata::tests::test_metadata_typed_accessors ... ok [INFO] [stdout] test metadata::tests::test_metadata_from_iterator ... ok [INFO] [stdout] test metadata::tests::test_metadata_deserialize_as ... ok [INFO] [stdout] test padded_int::tests::test_padded_int ... ok [INFO] [stdout] test timeseries::tests::test_channel_stds ... ok [INFO] [stdout] test timeseries::tests::test_channel_data_by_name ... ok [INFO] [stdout] test timeseries::tests::test_covariance_matrix ... ok [INFO] [stdout] test timeseries::tests::test_channel_means ... ok [INFO] [stdout] test timeseries::tests::test_duration ... ok [INFO] [stdout] test timeseries::tests::test_epochs_with_stride ... ok [INFO] [stdout] test timeseries::tests::test_epochs ... ok [INFO] [stdout] test timeseries::tests::test_peak_to_peak ... ok [INFO] [stdout] test timeseries::tests::test_shape ... ok [INFO] [stdout] test file::tests::test_natural_sort ... ok [INFO] [stdout] test timeseries::tests::test_min_max_normalize ... ok [INFO] [stdout] test timeseries::tests::test_to_column_major ... ok [INFO] [stdout] test timeseries::tests::test_log_variance ... ok [INFO] [stdout] test utils::tests::test_close_matches ... ok [INFO] [stdout] test utils::tests::test_matches_entities ... ok [INFO] [stdout] test utils::tests::test_camel_to_snake ... ok [INFO] [stdout] test utils::tests::test_snake_to_camel ... ok [INFO] [stdout] test timeseries::tests::test_z_score ... ok [INFO] [stdout] test timeseries::tests::test_to_flat_vec ... ok [INFO] [stdout] test timeseries::tests::test_band_power ... ok [INFO] [stdout] test timeseries::tests::test_times ... ok [INFO] [stdout] test timeseries::tests::test_window ... ok [INFO] [stdout] test metadata::tests::test_metadata_source_file ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 44 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_dataset-b7ae4fbd59358dbd) [INFO] [stdout] [INFO] [stdout] running 38 tests [INFO] [stdout] test benchmark::tests::test_append_csv ... ok [INFO] [stdout] test aggregate::tests::test_file_entry_serde ... ok [INFO] [stdout] test evaluation::tests::test_cross_subject ... ok [INFO] [stdout] test evaluation::tests::test_within_session ... ok [INFO] [stdout] test filter::tests::test_filter_matches_path ... ok [INFO] [stdout] test benchmark::tests::test_summary ... ok [INFO] [stdout] test filter::tests::test_filter_tasks ... ok [INFO] [stdout] test filter::tests::test_filter_remote ... ok [INFO] [stdout] test ml::tests::test_epoch_spec ... ok [INFO] [stdout] test ml::tests::test_kfold ... ok [INFO] [stdout] test evaluation::tests::test_cross_subject_kfold ... ok [INFO] [stdout] test benchmark::tests::test_mean_scores ... ok [INFO] [stdout] test ml::tests::test_kfold_iter ... ok [INFO] [stdout] test ml::tests::test_dataset_iter_basic ... ok [INFO] [stdout] test ml::tests::test_label_distribution ... ok [INFO] [stdout] test openneuro::tests::test_s3_listing_parser ... ok [INFO] [stdout] test ml::tests::test_stratified_split ... ok [INFO] [stdout] test ml::tests::test_dataset_iter_with_epochs ... ok [INFO] [stdout] test paradigm::tests::test_fixed_interval ... ok [INFO] [stdout] test openneuro::tests::test_dataset_info_serde ... ok [INFO] [stdout] test ml::tests::test_dataset_iter_shuffle ... ok [INFO] [stdout] test paradigm::tests::test_resting_state ... ok [INFO] [stdout] test ratelimit::tests::test_parse_retry_after ... ok [INFO] [stdout] test paradigm::tests::test_motor_imagery_defaults ... ok [INFO] [stdout] test paradigm::tests::test_filter_bank ... ok [INFO] [stdout] test ml::tests::test_dataset_iter_with_subjects ... ok [INFO] [stdout] test ratelimit::tests::test_rate_limiter_unlimited ... ok [INFO] [stdout] test paradigm::tests::test_p300_defaults ... ok [INFO] [stdout] test benchmark::tests::test_csv_roundtrip ... ok [INFO] [stdout] test paradigm::tests::test_display ... ok [INFO] [stdout] test split::tests::test_split_small ... ok [INFO] [stdout] test split::tests::test_split_partition ... ok [INFO] [stdout] test cache::tests::test_blob_dedup ... ok [INFO] [stdout] test cache::tests::test_cache_store_and_resolve ... ok [INFO] [stdout] test evaluation::tests::test_cross_session ... ok [INFO] [stdout] test filter::tests::test_filter_subjects ... 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.13s [INFO] [stdout] [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] [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/live_openneuro.rs (/opt/rustwide/target/debug/deps/live_openneuro-ea23cb453389d266) [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_derive-6faa4540ef6c4228) [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_e2e_tests-4a99da357a1b1b64) [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 precision::test_lfilter_vs_scipy ... ok [INFO] [stdout] test precision::test_filtfilt_rms ... ok [INFO] [stdout] test precision::test_butter_all_orders_cutoffs ... ok [INFO] [stdout] test tests::test_butter_order1 ... ok [INFO] [stdout] test tests::benchmark_layout_indexing ... ok [INFO] [stdout] test precision::test_dc_gain ... ok [INFO] [stdout] test tests::test_inflect ... ok [INFO] [stdout] test precision::test_gamma_pdf_values ... ok [INFO] [stdout] test tests::test_path_building ... ok [INFO] [stdout] test tests::test_layout_eeg_cbm ... ok [INFO] [stdout] test tests::test_layout_eeg_rishikesh ... ok [INFO] [stdout] test tests::test_butter_coefficients ... ok [INFO] [stdout] test precision::test_hrf_values_all_configs ... ok [INFO] [stdout] test tests::test_schema_validation ... ok [INFO] [stdout] test tests::test_entity_parsing ... ok [INFO] [stdout] test tests::test_nifti_header ... ok [INFO] [stdout] test tests::test_filtfilt_energy ... ok [INFO] [stdout] test tests::test_formula_basic ... ok [INFO] [stdout] test tests::test_formula_interaction ... ok [INFO] [stdout] test tests::test_hrf_glover ... ok [INFO] [stdout] test tests::test_hrf_spm ... ok [INFO] [stdout] test fixtures::tests::test_require_returns_valid_root ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.28s [INFO] [stdout] [INFO] [stderr] Running tests/bids_examples.rs (/opt/rustwide/target/debug/deps/bids_examples-b47dd47141c6fb16) [INFO] [stdout] [INFO] [stdout] running 16 tests [INFO] [stdout] test test_all_datasets_have_subjects ... ok [INFO] [stdout] test test_ieeg_examples ... ok [INFO] [stdout] test test_nirs_examples ... ok [INFO] [stdout] test test_eeg_examples ... ok [INFO] [stdout] test test_metadata_inheritance ... ok [INFO] [stdout] test test_derivative_examples ... ok [INFO] [stdout] test test_pet_examples ... ok [INFO] [stdout] test test_validate_all_examples ... ok [INFO] [stdout] test test_mrs_examples ... ok [INFO] [stdout] test test_micr_examples ... ok [INFO] [stdout] test test_perf_examples ... ok [INFO] [stdout] test test_all_datasets_index_successfully ... ok [INFO] [stdout] test test_motion_examples ... ok [INFO] [stdout] test test_meg_examples ... ok [INFO] [stdout] test test_schema_validates_example_filenames ... ok [INFO] [stdout] test test_entity_parsing_on_examples ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.23s [INFO] [stdout] [INFO] [stderr] Running tests/round_trip.rs (/opt/rustwide/target/debug/deps/round_trip-40d974e40eacad9e) [INFO] [stdout] [INFO] [stdout] running 7 tests [INFO] [stdout] test test_bidsfile_builder ... ok [INFO] [stdout] test test_query_return_types ... ok [INFO] [stdout] test test_layout_round_trip ... ok [INFO] [stdout] test test_metadata_inheritance ... ok [INFO] [stdout] test test_regex_filter ... ok [INFO] [stdout] test test_parse_and_build_path ... ok [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_eeg-a695e08eab01fa2c) [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.20s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 52 tests [INFO] [stdout] test csp::tests::test_csp_not_fitted ... ok [INFO] [stdout] test coordsystem::tests::test_coordsystem_parse ... ok [INFO] [stdout] test csp::tests::test_symmetric_eigen ... ok [INFO] [stdout] test channels::tests::test_read_channels_tsv ... ok [INFO] [stdout] test data::tests::test_brainvision_header_parse ... ok [INFO] [stdout] test csp::tests::test_csp_fit_transform ... ok [INFO] [stdout] test data::tests::test_channel_by_name ... ok [INFO] [stdout] test csp::tests::test_csp_transform_all ... ok [INFO] [stdout] test data::tests::test_concatenate ... ok [INFO] [stdout] test data::tests::test_brainvision_with_markers ... ok [INFO] [stdout] test data::tests::test_convert_units ... 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_epoch_and_average ... 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_pick_types ... ok [INFO] [stdout] test data::tests::test_display_debug ... ok [INFO] [stdout] test data::tests::test_eeg_data_select_channels ... ok [INFO] [stdout] test data::tests::test_filter_lowpass ... ok [INFO] [stdout] test data::tests::test_read_edf_with_exclude ... ok [INFO] [stdout] test data::tests::test_read_eeg_data_dispatch ... ok [INFO] [stdout] test data::tests::test_reject_by_annotation ... ok [INFO] [stdout] test data::tests::test_read_edf_time_range ... ok [INFO] [stdout] test data::tests::test_notch_filter ... ok [INFO] [stdout] test data::tests::test_set_reference ... ok [INFO] [stdout] test data::tests::test_read_edf_basic ... ok [INFO] [stdout] test data::tests::test_set_average_reference ... ok [INFO] [stdout] test data::tests::test_read_edf_unknown_n_records ... ok [INFO] [stdout] test data::tests::test_compute_psd ... ok [INFO] [stdout] test data::tests::test_resample ... ok [INFO] [stdout] test data::tests::test_read_edf_channel_select ... 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_sr_shift ... ok [INFO] [stdout] test harmonize::tests::test_union_strategy ... ok [INFO] [stdout] test harmonize::tests::test_apply_harmonization ... ok [INFO] [stdout] test events::tests::test_read_events_tsv ... ok [INFO] [stdout] test data::tests::test_stim_channel_detection ... ok [INFO] [stdout] test data::tests::test_times ... ok [INFO] [stdout] test data::tests::test_vmrk_parse ... ok [INFO] [stdout] test eeg_layout::tests::test_companion ... ok [INFO] [stdout] test electrodes::tests::test_read_electrodes_tsv ... ok [INFO] [stdout] test pipeline::tests::test_no_epoch_pipeline ... ok [INFO] [stdout] test pipeline::tests::test_save_load_json_file ... ok [INFO] [stdout] test data::tests::test_read_brainvision ... ok [INFO] [stdout] test pipeline::tests::test_step_visibility ... ok [INFO] [stdout] test pipeline::tests::test_pipeline_result_helpers ... ok [INFO] [stdout] test pipeline::tests::test_pipeline_with_resample ... 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.13s [INFO] [stdout] [INFO] [stderr] Running tests/bench_regression.rs (/opt/rustwide/target/debug/deps/bench_regression-448133b6e1be8455) [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_brainvision_64ch_60s ... ok [INFO] [stdout] test regression_edf_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 23.43s [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_filter-45dfa9e0f6c61c13) [INFO] [stdout] [INFO] [stdout] running 10 tests [INFO] [stdout] test tests::test_butter_highpass ... ok [INFO] [stdout] test tests::test_butter_lowpass_order5 ... ok [INFO] [stdout] test tests::test_lfilter_passthrough ... ok [INFO] [stdout] test tests::test_butter_bandpass ... ok [INFO] [stdout] test tests::test_filtfilt_removes_high_freq ... ok [INFO] [stdout] test tests::test_butter_lowpass_order1 ... ok [INFO] [stdout] test tests::test_notch_filter ... ok [INFO] [stdout] test tests::test_resample_downsample ... ok [INFO] [stdout] test tests::test_resample_identity ... ok [INFO] [stdout] test tests::test_resample_upsample ... ok [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_formula-5b6a5f9b2cf7b4da) [INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 6 tests [INFO] [stdout] test tests::test_build_design_matrix ... ok [INFO] [stdout] test tests::test_interaction ... ok [INFO] [stdout] test tests::test_no_intercept ... ok [INFO] [stdout] test tests::test_star_expansion ... ok [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_ieeg-035e83e7b7b86329) [INFO] [stdout] test tests::test_simple_formula ... ok [INFO] [stdout] test tests::test_interaction_matrix ... 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] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_inflect-8c333632256d4554) [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.37s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 5 tests [INFO] [stdout] test tests::test_pluralize ... ok [INFO] [stdout] test tests::test_singularize ... ok [INFO] [stdout] test tests::test_singularize_already_singular ... ok [INFO] [stdout] test tests::test_is_plural ... ok [INFO] [stdout] test tests::test_roundtrip ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 5 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_io-9ce4df8664d2a93f) [INFO] [stdout] [INFO] [stdout] running 20 tests [INFO] [stdout] test gradient::tests::test_display ... 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_expand_options ... ok [INFO] [stdout] test gradient::tests::test_gradient_table_mismatch ... ok [INFO] [stdout] test gradient::tests::test_gradient_table ... ok [INFO] [stdout] test writer::tests::test_conflict_skip ... 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_conflict_fail ... ok [INFO] [stdout] test writer::tests::test_creates_parent_dirs ... 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_no_source_errors ... ok [INFO] [stdout] test writer::tests::test_write_contents ... ok [INFO] [stdout] test tsv::tests::test_read_tsv ... ok [INFO] [stdout] test path_builder::tests::test_cartesian_product ... ok [INFO] [stdout] test path_builder::tests::test_build_path_with_default ... ok [INFO] [stdout] test path_builder::tests::test_build_path_basic ... ok [INFO] [stdout] test path_builder::tests::test_build_paths_expanded ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.12s [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_layout-39ca556be651892a) [INFO] [stdout] [INFO] [stdout] running 5 tests [INFO] [stdout] test db::tests::test_transaction_rollback ... ok [INFO] [stdout] test db::tests::test_database_operations ... ok [INFO] [stdout] test db::tests::test_transactions ... ok [INFO] [stdout] test db::tests::test_query_none_any ... ok [INFO] [stdout] test db::tests::test_regexp_query ... 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-6b0e3b946d76b18f) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test ctf::tests::test_missing_res4 ... ok [INFO] [stdout] test tests::test_meg_metadata ... ok [INFO] [stdout] test headshape::tests::test_read_no_labels ... ok [INFO] [stdout] test headshape::tests::test_read_headshape_pos ... ok [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_micr-5ea209dc22d0f457) [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] [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-150063cf003921df) [INFO] [stdout] [INFO] [stdout] running 12 tests [INFO] [stdout] test hrf::tests::test_regressor_names ... ok [INFO] [stdout] test graph::tests::test_parse_model ... ok [INFO] [stdout] test hrf::tests::test_glover_hrf ... ok [INFO] [stdout] test auto_model::tests::test_auto_model_signature ... ok [INFO] [stdout] test spec::tests::test_compute_vif ... ok [INFO] [stdout] test hrf::tests::test_spm_hrf ... ok [INFO] [stdout] test spec::tests::test_dummies_to_vec ... ok [INFO] [stdout] test transformations::tests::test_factor ... ok [INFO] [stdout] test transformations::tests::test_rename ... ok [INFO] [stdout] test transformations::tests::test_scale ... ok [INFO] [stdout] test transformations::tests::test_threshold ... ok [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_motion-172271c4fe8eb1ed) [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.31s [INFO] [stdout] [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.00s [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_mrs-bb23ae4a670ae4a4) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bids_nifti-b2edd0b83548fea1) [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.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 16 tests [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_header_nifti2_synthetic ... ok [INFO] [stdout] test gifti::tests::test_not_gifti ... ok [INFO] [stdout] test mmap::tests::test_mmap_lazy_volume ... ok [INFO] [stdout] test qmri::tests::test_qmri_mp2rage ... ok [INFO] [stdout] test tests::test_load_single_volume ... ok [INFO] [stdout] test tests::test_int16_datatype ... ok [INFO] [stdout] test qmri::tests::test_qmri_metadata_parse ... 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_load_gzip ... ok [INFO] [stdout] test tests::test_load_3d_image ... ok [INFO] [stdout] test tests::test_header_nifti1 ... ok [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): 576.3ms (91 MB/s) [INFO] [stdout] [INFO] [stdout] thread 'tests::test_large_4d_performance' (314) panicked at crates/bids-nifti/src/lib.rs:1219:9: [INFO] [stdout] NIfTI read took 576ms, expected <500ms [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5fd8cb73cafa - std[31e582c13f4e914f]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5fd8cb73cafa - std[31e582c13f4e914f]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5fd8cb73cafa - std[31e582c13f4e914f]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x5fd8cb73cafa - <::print::DisplayBacktrace as core[fa0eadad68403074]::fmt::Display>::fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x5fd8cb7514ea - ::fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x5fd8cb7514ea - core[fa0eadad68403074]::fmt::write [INFO] [stdout] 6: 0x5fd8cb7414a2 - std[31e582c13f4e914f]::io::default_write_fmt::> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x5fd8cb7414a2 - as std[31e582c13f4e914f]::io::Write>::write_fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/io/mod.rs:1994:13 [INFO] [stdout] 8: 0x5fd8cb719f0f - ::print [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x5fd8cb719f0f - std[31e582c13f4e914f]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x5fd8cb734259 - std[31e582c13f4e914f]::panicking::default_hook [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x5fd8cb65bf3c - core[fa0eadad68403074]::ops::function::Fn<(&'a std[31e582c13f4e914f]::panic::PanicHookInfo<'b>,), Output = ()> + core[fa0eadad68403074]::marker::Sync + core[fa0eadad68403074]::marker::Send> as core[fa0eadad68403074]::ops::function::Fn<(&std[31e582c13f4e914f]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/alloc/src/boxed.rs:2254:9 [INFO] [stdout] 12: 0x5fd8cb65bf3c - test[7530e63dc052480e]::test_main_with_exit_callback::::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x5fd8cb734412 - core[fa0eadad68403074]::ops::function::Fn<(&'a std[31e582c13f4e914f]::panic::PanicHookInfo<'b>,), Output = ()> + core[fa0eadad68403074]::marker::Sync + core[fa0eadad68403074]::marker::Send> as core[fa0eadad68403074]::ops::function::Fn<(&std[31e582c13f4e914f]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/alloc/src/boxed.rs:2254:9 [INFO] [stdout] 14: 0x5fd8cb734412 - std[31e582c13f4e914f]::panicking::panic_with_hook [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x5fd8cb719fc8 - std[31e582c13f4e914f]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x5fd8cb70efa9 - std[31e582c13f4e914f]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x5fd8cb71acdd - __rustc[fc8e3a9f23f26cb]::rust_begin_unwind [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x5fd8cb751c7c - core[fa0eadad68403074]::panicking::panic_fmt [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x5fd8cb62edbf - bids_nifti[cf32bf4a9bf62a1]::tests::test_large_4d_performance [INFO] [stdout] at /opt/rustwide/workdir/crates/bids-nifti/src/lib.rs:1219:9 [INFO] [stdout] 20: 0x5fd8cb625cb7 - bids_nifti[cf32bf4a9bf62a1]::tests::test_large_4d_performance::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/crates/bids-nifti/src/lib.rs:1182:35 [INFO] [stdout] 21: 0x5fd8cb63d3d6 - >::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 22: 0x5fd8cb65001b - core[fa0eadad68403074]::result::Result<(), alloc[49b8922c36ca62de]::string::String> as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x5fd8cb65001b - test[7530e63dc052480e]::__rust_begin_short_backtrace::, fn() -> core[fa0eadad68403074]::result::Result<(), alloc[49b8922c36ca62de]::string::String>> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:663:18 [INFO] [stdout] 24: 0x5fd8cb65ca0b - test[7530e63dc052480e]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:686:74 [INFO] [stdout] 25: 0x5fd8cb65ca0b - as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 26: 0x5fd8cb65ca0b - std[31e582c13f4e914f]::panicking::catch_unwind::do_call::, core[fa0eadad68403074]::result::Result<(), alloc[49b8922c36ca62de]::string::String>> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:581:40 [INFO] [stdout] 27: 0x5fd8cb65ca0b - std[31e582c13f4e914f]::panicking::catch_unwind::, core[fa0eadad68403074]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:544:19 [INFO] [stdout] 28: 0x5fd8cb65ca0b - std[31e582c13f4e914f]::panic::catch_unwind::, core[fa0eadad68403074]::result::Result<(), alloc[49b8922c36ca62de]::string::String>> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panic.rs:359:14 [INFO] [stdout] 29: 0x5fd8cb65ca0b - test[7530e63dc052480e]::run_test_in_process [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:686:27 [INFO] [stdout] 30: 0x5fd8cb65ca0b - test[7530e63dc052480e]::run_test::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:607:43 [INFO] [stdout] 31: 0x5fd8cb656e64 - test[7530e63dc052480e]::run_test::{closure#1} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/test/src/lib.rs:637:41 [INFO] [stdout] 32: 0x5fd8cb656e64 - std[31e582c13f4e914f]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 33: 0x5fd8cb65f612 - std[31e582c13f4e914f]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/thread/lifecycle.rs:91:13 [INFO] [stdout] 34: 0x5fd8cb65f612 - ::{closure#1}::{closure#0}> as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 35: 0x5fd8cb65f612 - std[31e582c13f4e914f]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:581:40 [INFO] [stdout] 36: 0x5fd8cb65f612 - std[31e582c13f4e914f]::panicking::catch_unwind::<(), core[fa0eadad68403074]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panicking.rs:544:19 [INFO] [stdout] 37: 0x5fd8cb65f612 - std[31e582c13f4e914f]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/panic.rs:359:14 [INFO] [stdout] 38: 0x5fd8cb65f612 - std[31e582c13f4e914f]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/thread/lifecycle.rs:89:26 [INFO] [stdout] 39: 0x5fd8cb65f612 - ::{closure#1} as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 40: 0x5fd8cb73bbef - + core[fa0eadad68403074]::marker::Send> as core[fa0eadad68403074]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/alloc/src/boxed.rs:2240:9 [INFO] [stdout] 41: 0x5fd8cb73bbef - ::new::thread_start [INFO] [stdout] at /rustc/562dee4820c458d823175268e41601d4c060588a/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 42: 0x76d079eb7aa4 - [INFO] [stdout] 43: 0x76d079f44a64 - clone [INFO] [stdout] 44: 0x0 - [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 2.88s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `-p bids-nifti --lib` [INFO] running `Command { std: "docker" "inspect" "ebb88b23b09f05f4a1287a2ab0e073ddae5fc1dff6d12aea1901fea0f84c4a25", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "ebb88b23b09f05f4a1287a2ab0e073ddae5fc1dff6d12aea1901fea0f84c4a25", kill_on_drop: false }` [INFO] [stdout] ebb88b23b09f05f4a1287a2ab0e073ddae5fc1dff6d12aea1901fea0f84c4a25