[INFO] cloning repository https://github.com/HEnquist/rustfir [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/HEnquist/rustfir" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FHEnquist%2Frustfir", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FHEnquist%2Frustfir'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 0bb52349399aedde6468168f30be5a5b8c78af54 [INFO] testing HEnquist/rustfir against master#99e3aef02079e9c10583638520cd0c134dc3a01d for pr-85530 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FHEnquist%2Frustfir" "/workspace/builds/worker-12/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-12/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/HEnquist/rustfir on toolchain 99e3aef02079e9c10583638520cd0c134dc3a01d [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/HEnquist/rustfir [INFO] finished tweaking git repo https://github.com/HEnquist/rustfir [INFO] tweaked toml for git repo https://github.com/HEnquist/rustfir written to /workspace/builds/worker-12/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] d1852eb3edddd963a773102d60f5d1386c82513e4b56e39bf9e87aed5bc41c40 [INFO] running `Command { std: "docker" "start" "-a" "d1852eb3edddd963a773102d60f5d1386c82513e4b56e39bf9e87aed5bc41c40", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "d1852eb3edddd963a773102d60f5d1386c82513e4b56e39bf9e87aed5bc41c40", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "d1852eb3edddd963a773102d60f5d1386c82513e4b56e39bf9e87aed5bc41c40", kill_on_drop: false }` [INFO] [stdout] d1852eb3edddd963a773102d60f5d1386c82513e4b56e39bf9e87aed5bc41c40 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 18a47ac5747cb36046d968bdeb04b4ebdd6a64f9cbb03c57a2c34153806f57af [INFO] running `Command { std: "docker" "start" "-a" "18a47ac5747cb36046d968bdeb04b4ebdd6a64f9cbb03c57a2c34153806f57af", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.95 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling libm v0.2.1 [INFO] [stderr] Compiling pkg-config v0.3.19 [INFO] [stderr] Compiling version_check v0.9.3 [INFO] [stderr] Compiling serde_derive v1.0.126 [INFO] [stderr] Compiling serde v1.0.126 [INFO] [stderr] Compiling slog v2.7.0 [INFO] [stderr] Compiling ppv-lite86 v0.2.10 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling strength_reduce v0.2.3 [INFO] [stderr] Compiling crossbeam-utils v0.8.5 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling rustversion v1.0.5 [INFO] [stderr] Compiling bytes v1.0.1 [INFO] [stderr] Compiling percent-encoding v2.1.0 [INFO] [stderr] Compiling serde_json v1.0.64 [INFO] [stderr] Compiling unicode-width v0.1.8 [INFO] [stderr] Compiling signal-hook v0.3.9 [INFO] [stderr] Compiling cpufeatures v0.1.4 [INFO] [stderr] Compiling vec_map v0.8.2 [INFO] [stderr] Compiling strsim v0.8.0 [INFO] [stderr] Compiling utf-8 v0.7.6 [INFO] [stderr] Compiling arc-swap v1.3.0 [INFO] [stderr] Compiling take_mut v0.2.2 [INFO] [stderr] Compiling dtoa v0.4.8 [INFO] [stderr] Compiling thread_local v1.1.3 [INFO] [stderr] Compiling idna v0.2.3 [INFO] [stderr] Compiling form_urlencoded v1.0.1 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling proc-macro2 v1.0.27 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling generic-array v0.14.4 [INFO] [stderr] Compiling camilladsp v0.5.2 (/opt/rustwide/workdir) [INFO] [stderr] Compiling http v0.2.4 [INFO] [stderr] Compiling input_buffer v0.4.0 [INFO] [stderr] Compiling crossbeam-channel v0.5.1 [INFO] [stderr] Compiling url v2.2.2 [INFO] [stderr] Compiling slog-scope v4.4.0 [INFO] [stderr] Compiling libpulse-sys v1.18.0 [INFO] [stderr] Compiling alsa-sys v0.3.1 [INFO] [stderr] Compiling libpulse-simple-sys v1.16.1 [INFO] [stderr] Compiling quote v1.0.9 [INFO] [stderr] Compiling slog-async v2.6.0 [INFO] [stderr] Compiling syn v1.0.72 [INFO] [stderr] Compiling block-buffer v0.9.0 [INFO] [stderr] Compiling digest v0.9.0 [INFO] [stderr] Compiling sha-1 v0.9.6 [INFO] [stderr] Compiling num-complex v0.4.0 [INFO] [stderr] Compiling transpose v0.2.1 [INFO] [stderr] Compiling primal-check v0.3.1 [INFO] [stderr] Compiling getrandom v0.2.3 [INFO] [stderr] Compiling dirs-sys-next v0.1.2 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling time v0.1.43 [INFO] [stderr] Compiling nix v0.20.0 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling clap v2.33.3 [INFO] [stderr] Compiling rand_core v0.6.2 [INFO] [stderr] Compiling rustfft v6.0.1 [INFO] [stderr] Compiling rand_chacha v0.3.0 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling dirs-next v2.0.0 [INFO] [stderr] Compiling term v0.7.0 [INFO] [stderr] Compiling rand v0.8.3 [INFO] [stderr] Compiling rand_distr v0.4.0 [INFO] [stderr] Compiling slog-term v2.8.0 [INFO] [stderr] Compiling darling_core v0.12.4 [INFO] [stderr] Compiling alsa v0.5.0 [INFO] [stderr] Compiling realfft v2.0.1 [INFO] [stderr] Compiling num-derive v0.3.3 [INFO] [stderr] Compiling thiserror-impl v1.0.25 [INFO] [stderr] Compiling rubato v0.8.1 [INFO] [stderr] Compiling darling_macro v0.12.4 [INFO] [stderr] Compiling thiserror v1.0.25 [INFO] [stderr] Compiling tungstenite v0.13.0 [INFO] [stderr] Compiling darling v0.12.4 [INFO] [stderr] Compiling serde_with_macros v1.4.1 [INFO] [stderr] Compiling libpulse-binding v2.23.1 [INFO] [stderr] Compiling libpulse-simple-binding v2.23.0 [INFO] [stderr] Compiling serde_with v1.9.1 [INFO] [stderr] Compiling serde_yaml v0.8.17 [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1m 30s [INFO] running `Command { std: "docker" "inspect" "18a47ac5747cb36046d968bdeb04b4ebdd6a64f9cbb03c57a2c34153806f57af", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "18a47ac5747cb36046d968bdeb04b4ebdd6a64f9cbb03c57a2c34153806f57af", kill_on_drop: false }` [INFO] [stdout] 18a47ac5747cb36046d968bdeb04b4ebdd6a64f9cbb03c57a2c34153806f57af [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 3880a5596d40dd2e3b82036e4a66f119e9e25253abacda12c02e66f33767ee0d [INFO] running `Command { std: "docker" "start" "-a" "3880a5596d40dd2e3b82036e4a66f119e9e25253abacda12c02e66f33767ee0d", kill_on_drop: false }` [INFO] [stderr] Compiling ucd-trie v0.1.3 [INFO] [stderr] Compiling crossbeam-epoch v0.9.5 [INFO] [stderr] Compiling memchr v2.4.0 [INFO] [stderr] Compiling rayon-core v1.9.1 [INFO] [stderr] Compiling either v1.6.1 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling plotters-backend v0.3.0 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling half v1.7.1 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling oorandom v11.1.3 [INFO] [stderr] Compiling memoffset v0.6.4 [INFO] [stderr] Compiling rayon v1.5.1 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling pest v2.1.3 [INFO] [stderr] Compiling walkdir v2.3.2 [INFO] [stderr] Compiling itertools v0.9.0 [INFO] [stderr] Compiling itertools v0.10.0 [INFO] [stderr] Compiling serde_cbor v0.11.1 [INFO] [stderr] Compiling plotters-svg v0.3.0 [INFO] [stderr] Compiling plotters v0.3.1 [INFO] [stderr] Compiling crossbeam-deque v0.8.0 [INFO] [stderr] Compiling bstr v0.2.16 [INFO] [stderr] Compiling csv-core v0.1.10 [INFO] [stderr] Compiling csv v1.1.6 [INFO] [stderr] Compiling semver-parser v0.10.2 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling semver v0.11.0 [INFO] [stderr] Compiling rustc_version v0.3.3 [INFO] [stderr] Compiling cast v0.2.6 [INFO] [stderr] Compiling criterion-plot v0.4.3 [INFO] [stderr] Compiling criterion v0.3.4 [INFO] [stderr] Compiling camilladsp v0.5.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 50.35s [INFO] running `Command { std: "docker" "inspect" "3880a5596d40dd2e3b82036e4a66f119e9e25253abacda12c02e66f33767ee0d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3880a5596d40dd2e3b82036e4a66f119e9e25253abacda12c02e66f33767ee0d", kill_on_drop: false }` [INFO] [stdout] 3880a5596d40dd2e3b82036e4a66f119e9e25253abacda12c02e66f33767ee0d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 8e40dee6c71a6a60031bf69f8358fb0c1cdd340be79aa982f19cde9294e73bfb [INFO] running `Command { std: "docker" "start" "-a" "8e40dee6c71a6a60031bf69f8358fb0c1cdd340be79aa982f19cde9294e73bfb", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.17s [INFO] [stdout] [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/camillalib-0ec3cd46cf774e0e) [INFO] [stdout] running 92 tests [INFO] [stdout] test audiodevice::tests::chunk_rms_and_peak ... ok [INFO] [stdout] test basicfilters::tests::delay_fraction ... ok [INFO] [stdout] test basicfilters::tests::gain_invert ... ok [INFO] [stdout] test biquad::tests::allpass_bw_vs_q ... ok [INFO] [stdout] test biquad::tests::check_result ... ok [INFO] [stdout] test biquad::tests::lowshelf_slope_vs_q ... ok [INFO] [stdout] test biquad::tests::make_allpass ... ok [INFO] [stdout] test biquad::tests::make_allpass_fo ... ok [INFO] [stdout] test biquad::tests::make_bandpass ... ok [INFO] [stdout] test biquad::tests::make_highpass_fo ... ok [INFO] [stdout] test biquad::tests::make_highshelf_fo ... ok [INFO] [stdout] test basicfilters::tests::gain_ampl ... ok [INFO] [stdout] test biquad::tests::notch_bw_vs_q ... ok [INFO] [stdout] test audiodevice::tests::vec_rms_and_peak ... ok [INFO] [stdout] test basicfilters::tests::delay_small ... ok [INFO] [stdout] test audiodevice::tests::rms_and_peak_to_db ... ok [INFO] [stdout] test biquad::tests::check_slope ... ok [INFO] [stdout] test conversions::tests::from_buffer_int24_4 ... ok [INFO] [stdout] test biquadcombo::tests::make_butterworth_2 ... ok [INFO] [stdout] test biquad::tests::make_highpass ... ok [INFO] [stdout] test biquad::tests::highshelf_slope_vs_q ... ok [INFO] [stdout] test basicfilters::tests::delay_large ... ok [INFO] [stdout] test biquad::tests::bandpass_bw_vs_q ... ok [INFO] [stdout] test biquad::tests::make_highshelf ... ok [INFO] [stdout] test biquad::tests::make_lowshelf ... ok [INFO] [stdout] test conversions::tests::to_buffer_float64 ... ok [INFO] [stdout] test biquadcombo::tests::make_butterworth_5 ... ok [INFO] [stdout] test biquadcombo::tests::make_lr6 ... ok [INFO] [stdout] test conversions::tests::to_buffer_ignored_int24 ... ok [INFO] [stdout] test conversions::tests::clipping_24 ... ok [INFO] [stdout] test conversions::tests::to_buffer_int16 ... ok [INFO] [stdout] test biquad::tests::check_freq_q ... ok [INFO] [stdout] test biquad::tests::make_peaking ... ok [INFO] [stdout] test conversions::tests::to_buffer_float32 ... ok [INFO] [stdout] test biquadcombo::tests::make_lr4 ... ok [INFO] [stdout] test biquadcombo::tests::make_butterworth_8 ... ok [INFO] [stdout] test biquadcombo::tests::check_butterworth ... ok [INFO] [stdout] test biquad::tests::make_lt ... ok [INFO] [stdout] test biquadcombo::tests::check_lr ... ok [INFO] [stdout] test biquad::tests::make_notch ... ok [INFO] [stdout] test biquad::tests::make_lowshelf_fo ... ok [INFO] [stdout] test conversions::tests::to_buffer_int24_3 ... ok [INFO] [stdout] test conversions::tests::clipping_16 ... ok [INFO] [stdout] test conversions::tests::clipping_32 ... ok [INFO] [stdout] test conversions::tests::from_buffer_int24_3 ... ok [INFO] [stdout] test biquad::tests::make_lowpass ... ok [INFO] [stdout] test conversions::tests::to_from_buffer_float32 ... ok [INFO] [stdout] test conversions::tests::to_from_buffer_float64 ... ok [INFO] [stdout] test conversions::tests::to_from_queue_i16 ... ok [INFO] [stdout] test dither::tests::test_quantize ... ok [INFO] [stdout] test dither::tests::test_simple ... ok [INFO] [stdout] test conversions::tests::to_from_buffer_16 ... ok [INFO] [stdout] test conversions::tests::to_from_buffer_24 ... ok [INFO] [stdout] test biquad::tests::make_lowpass_fo ... ok [INFO] [stdout] test filters::tests::read_int24 ... ok [INFO] [stdout] test conversions::tests::to_from_buffer_24_3 ... ok [INFO] [stdout] test fifoqueue::tests::wrap_around ... ok [INFO] [stdout] test conversions::tests::to_buffer_int24_4 ... ok [INFO] [stdout] test filters::tests::read_text ... ok [INFO] [stdout] test conversions::tests::to_from_buffer_32 ... ok [INFO] [stdout] test countertimer::tests::averager ... ok [INFO] [stdout] test filters::tests::read_float32 ... ok [INFO] [stdout] test conversions::tests::to_buffer_int32 ... ok [INFO] [stdout] test countertimer::tests::silencecounter ... ok [INFO] [stdout] test filters::tests::read_float64 ... ok [INFO] [stdout] test fifoqueue::tests::add_few ... ok [INFO] [stdout] test filters::tests::read_int16 ... ok [INFO] [stdout] test fifoqueue::tests::make_empty ... ok [INFO] [stdout] test dither::tests::test_uniform ... ok [INFO] [stdout] test fifoqueue::tests::prefilled ... ok [INFO] [stdout] test diffeq::tests::check_result ... ok [INFO] [stdout] test fifoqueue::tests::overfill ... ok [INFO] [stdout] test dither::tests::test_lip ... ok [INFO] [stdout] test fftconv::tests::check_result_segmented ... ok [INFO] [stdout] test conversions::tests::to_from_queue_f32 ... ok [INFO] [stdout] test filters::tests::test_analyze_wav ... ok [INFO] [stdout] test countertimer::tests::silencecounter_largechunksize ... ok [INFO] [stdout] test filters::tests::test_padding ... ok [INFO] [stdout] test filters::tests::test_read_wav ... ok [INFO] [stdout] test filters::tests::read_int24_3 ... ok [INFO] [stdout] test filters::tests::read_int32 ... ok [INFO] [stdout] test mixer::tests::check_mute_source ... ok [INFO] [stdout] test mixer::tests::check_all_used ... ok [INFO] [stdout] test mixer::tests::check_make_mixer ... ok [INFO] [stdout] test mixer::tests::check_mute_mapping ... ok [INFO] [stdout] test fftconv::tests::check_result ... ok [INFO] [stdout] test socketserver::tests::parse_commands ... ok [INFO] [stdout] test mixer::tests::check_not_mapped ... ok [INFO] [stdout] test mixer::tests::check_make_mixer_muted ... ok [INFO] [stdout] test countertimer::tests::stopwatch_as_timer ... FAILED [INFO] [stdout] test countertimer::tests::stopwatch ... ok [INFO] [stdout] test countertimer::tests::timeaverage ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- countertimer::tests::stopwatch_as_timer stdout ---- [INFO] [stdout] thread 'countertimer::tests::stopwatch_as_timer' panicked at 'assertion failed: `(left == right)` [INFO] [stdout] left: `true`, [INFO] [stdout] right: `false`', src/countertimer.rs:187:9 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x562134abc670 - std::backtrace_rs::backtrace::libunwind::trace::h1037ca7e6eeef65c [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5 [INFO] [stdout] 1: 0x562134abc670 - std::backtrace_rs::backtrace::trace_unsynchronized::haaefac1bc3669450 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x562134abc670 - std::sys_common::backtrace::_print_fmt::h863a6f5e6d995885 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/sys_common/backtrace.rs:67:5 [INFO] [stdout] 3: 0x562134abc670 - ::fmt::h767e17e1aa7df6a8 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/sys_common/backtrace.rs:46:22 [INFO] [stdout] 4: 0x562134ae088c - core::fmt::write::h7aa6cd0067dca82a [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/core/src/fmt/mod.rs:1110:17 [INFO] [stdout] 5: 0x562134ab9695 - std::io::Write::write_fmt::h6f1a9b91376a1376 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/io/mod.rs:1584:15 [INFO] [stdout] 6: 0x562134abe7db - std::sys_common::backtrace::_print::h2769edb26a7eb606 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/sys_common/backtrace.rs:49:5 [INFO] [stdout] 7: 0x562134abe7db - std::sys_common::backtrace::print::ha71f3549862b4cb6 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/sys_common/backtrace.rs:36:9 [INFO] [stdout] 8: 0x562134abe7db - std::panicking::default_hook::{{closure}}::h95488a3bade217f6 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:208:50 [INFO] [stdout] 9: 0x562134abe2ec - std::panicking::default_hook::h290aa602c0fb11df [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:222:9 [INFO] [stdout] 10: 0x562134abee81 - std::panicking::rust_panic_with_hook::hf32c4fa635e215f2 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:622:17 [INFO] [stdout] 11: 0x562134abe987 - std::panicking::begin_panic_handler::{{closure}}::h95197ccd88846f7a [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:519:13 [INFO] [stdout] 12: 0x562134abcb4c - std::sys_common::backtrace::__rust_end_short_backtrace::h7641df9566f7b7d0 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/sys_common/backtrace.rs:141:18 [INFO] [stdout] 13: 0x562134abe8e9 - rust_begin_unwind [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:515:5 [INFO] [stdout] 14: 0x5621341ac921 - core::panicking::panic_fmt::hbe99dddd3092ba3c [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/core/src/panicking.rs:92:14 [INFO] [stdout] 15: 0x562134ade938 - core::panicking::assert_failed_inner::h4fdb1013d187f202 [INFO] [stdout] 16: 0x562134a9753a - core::panicking::assert_failed::h61a9c664c77bcbbd [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/core/src/panicking.rs:117:5 [INFO] [stdout] 17: 0x56213497adb4 - camillalib::countertimer::tests::stopwatch_as_timer::hd8c6ce7f5e27b20f [INFO] [stdout] at /opt/rustwide/workdir/src/countertimer.rs:187:9 [INFO] [stdout] 18: 0x56213497ac3a - camillalib::countertimer::tests::stopwatch_as_timer::{{closure}}::haa4a2ac03b4f54e4 [INFO] [stdout] at /opt/rustwide/workdir/src/countertimer.rs:183:5 [INFO] [stdout] 19: 0x5621343db89e - core::ops::function::FnOnce::call_once::hc0db9429fd7c9235 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 20: 0x5621349f4893 - core::ops::function::FnOnce::call_once::h673fbe3f96486fd2 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 21: 0x5621349f4893 - test::__rust_begin_short_backtrace::h8eedc24e104ef6a0 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/test/src/lib.rs:577:5 [INFO] [stdout] 22: 0x5621349f3340 - as core::ops::function::FnOnce>::call_once::h028d0969d3f94d78 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/alloc/src/boxed.rs:1575:9 [INFO] [stdout] 23: 0x5621349f3340 - as core::ops::function::FnOnce<()>>::call_once::h7634b01590b1722b [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panic.rs:346:9 [INFO] [stdout] 24: 0x5621349f3340 - std::panicking::try::do_call::hf74f869706dec63b [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:401:40 [INFO] [stdout] 25: 0x5621349f3340 - std::panicking::try::hd0b7346ebfaaae44 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:365:19 [INFO] [stdout] 26: 0x5621349f3340 - std::panic::catch_unwind::hdbf6904f7c253080 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panic.rs:433:14 [INFO] [stdout] 27: 0x5621349f3340 - test::run_test_in_process::h87e95a014ac91067 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/test/src/lib.rs:600:18 [INFO] [stdout] 28: 0x5621349f3340 - test::run_test::run_test_inner::{{closure}}::hdd69ae44aaab3470 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/test/src/lib.rs:492:39 [INFO] [stdout] 29: 0x5621349ce612 - test::run_test::run_test_inner::{{closure}}::hc159305704d5b68a [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/test/src/lib.rs:519:37 [INFO] [stdout] 30: 0x5621349ce612 - std::sys_common::backtrace::__rust_begin_short_backtrace::h33d8a8ad5f788fcc [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/sys_common/backtrace.rs:125:18 [INFO] [stdout] 31: 0x5621349d2388 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h6181011ddf4b8353 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/thread/mod.rs:481:17 [INFO] [stdout] 32: 0x5621349d2388 - as core::ops::function::FnOnce<()>>::call_once::hf924ea0a0f25a1c0 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panic.rs:346:9 [INFO] [stdout] 33: 0x5621349d2388 - std::panicking::try::do_call::hd58061792d05fa5c [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:401:40 [INFO] [stdout] 34: 0x5621349d2388 - std::panicking::try::h3080747417e5af37 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:365:19 [INFO] [stdout] 35: 0x5621349d2388 - std::panic::catch_unwind::hfeba515dcf36cb66 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panic.rs:433:14 [INFO] [stdout] 36: 0x5621349d2388 - std::thread::Builder::spawn_unchecked::{{closure}}::h29d57a62faff749b [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/thread/mod.rs:480:30 [INFO] [stdout] 37: 0x5621349d2388 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h44709d312d2a9c59 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 38: 0x562134ac3967 - as core::ops::function::FnOnce>::call_once::h902e2cf6655e1b0c [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/alloc/src/boxed.rs:1575:9 [INFO] [stdout] 39: 0x562134ac3967 - as core::ops::function::FnOnce>::call_once::h893a5452154309d1 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/alloc/src/boxed.rs:1575:9 [INFO] [stdout] 40: 0x562134ac3967 - std::sys::unix::thread::Thread::new::thread_start::hdedcb57c96ab37cd [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/sys/unix/thread.rs:71:17 [INFO] [stdout] 41: 0x7fd452d40609 - start_thread [INFO] [stdout] 42: 0x7fd452b10293 - clone [INFO] [stdout] 43: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- countertimer::tests::timeaverage stdout ---- [INFO] [stdout] thread 'countertimer::tests::timeaverage' panicked at 'assertion failed: a.get_average() > 7000.0', src/countertimer.rs:232:9 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x562134abc670 - std::backtrace_rs::backtrace::libunwind::trace::h1037ca7e6eeef65c [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5 [INFO] [stdout] 1: 0x562134abc670 - std::backtrace_rs::backtrace::trace_unsynchronized::haaefac1bc3669450 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x562134abc670 - std::sys_common::backtrace::_print_fmt::h863a6f5e6d995885 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/sys_common/backtrace.rs:67:5 [INFO] [stdout] 3: 0x562134abc670 - ::fmt::h767e17e1aa7df6a8 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/sys_common/backtrace.rs:46:22 [INFO] [stdout] 4: 0x562134ae088c - core::fmt::write::h7aa6cd0067dca82a [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/core/src/fmt/mod.rs:1110:17 [INFO] [stdout] 5: 0x562134ab9695 - std::io::Write::write_fmt::h6f1a9b91376a1376 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/io/mod.rs:1584:15 [INFO] [stdout] 6: 0x562134abe7db - std::sys_common::backtrace::_print::h2769edb26a7eb606 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/sys_common/backtrace.rs:49:5 [INFO] [stdout] 7: 0x562134abe7db - std::sys_common::backtrace::print::ha71f3549862b4cb6 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/sys_common/backtrace.rs:36:9 [INFO] [stdout] 8: 0x562134abe7db - std::panicking::default_hook::{{closure}}::h95488a3bade217f6 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:208:50 [INFO] [stdout] 9: 0x562134abe2ec - std::panicking::default_hook::h290aa602c0fb11df [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:222:9 [INFO] [stdout] 10: 0x562134abee81 - std::panicking::rust_panic_with_hook::hf32c4fa635e215f2 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:622:17 [INFO] [stdout] 11: 0x562134abe957 - std::panicking::begin_panic_handler::{{closure}}::h95197ccd88846f7a [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:517:13 [INFO] [stdout] 12: 0x562134abcb4c - std::sys_common::backtrace::__rust_end_short_backtrace::h7641df9566f7b7d0 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/sys_common/backtrace.rs:141:18 [INFO] [stdout] 13: 0x562134abe8e9 - rust_begin_unwind [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:515:5 [INFO] [stdout] 14: 0x5621341ac921 - core::panicking::panic_fmt::hbe99dddd3092ba3c [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/core/src/panicking.rs:92:14 [INFO] [stdout] 15: 0x5621341ac86d - core::panicking::panic::h3de4db67bd397eb3 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/core/src/panicking.rs:50:5 [INFO] [stdout] 16: 0x56213497b5fe - camillalib::countertimer::tests::timeaverage::h519a131d37ce2a0e [INFO] [stdout] at /opt/rustwide/workdir/src/countertimer.rs:232:9 [INFO] [stdout] 17: 0x56213497b46a - camillalib::countertimer::tests::timeaverage::{{closure}}::h5ddf5184e1a60df6 [INFO] [stdout] at /opt/rustwide/workdir/src/countertimer.rs:220:5 [INFO] [stdout] 18: 0x5621343dbade - core::ops::function::FnOnce::call_once::hd2d16e9cae59b706 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 19: 0x5621349f4893 - core::ops::function::FnOnce::call_once::h673fbe3f96486fd2 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 20: 0x5621349f4893 - test::__rust_begin_short_backtrace::h8eedc24e104ef6a0 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/test/src/lib.rs:577:5 [INFO] [stdout] 21: 0x5621349f3340 - as core::ops::function::FnOnce>::call_once::h028d0969d3f94d78 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/alloc/src/boxed.rs:1575:9 [INFO] [stdout] 22: 0x5621349f3340 - as core::ops::function::FnOnce<()>>::call_once::h7634b01590b1722b [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panic.rs:346:9 [INFO] [stdout] 23: 0x5621349f3340 - std::panicking::try::do_call::hf74f869706dec63b [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:401:40 [INFO] [stdout] 24: 0x5621349f3340 - std::panicking::try::hd0b7346ebfaaae44 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:365:19 [INFO] [stdout] 25: 0x5621349f3340 - std::panic::catch_unwind::hdbf6904f7c253080 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panic.rs:433:14 [INFO] [stdout] 26: 0x5621349f3340 - test::run_test_in_process::h87e95a014ac91067 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/test/src/lib.rs:600:18 [INFO] [stdout] 27: 0x5621349f3340 - test::run_test::run_test_inner::{{closure}}::hdd69ae44aaab3470 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/test/src/lib.rs:492:39 [INFO] [stdout] 28: 0x5621349ce612 - test::run_test::run_test_inner::{{closure}}::hc159305704d5b68a [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/test/src/lib.rs:519:37 [INFO] [stdout] 29: 0x5621349ce612 - std::sys_common::backtrace::__rust_begin_short_backtrace::h33d8a8ad5f788fcc [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/sys_common/backtrace.rs:125:18 [INFO] [stdout] 30: 0x5621349d2388 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h6181011ddf4b8353 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/thread/mod.rs:481:17 [INFO] [stdout] 31: 0x5621349d2388 - as core::ops::function::FnOnce<()>>::call_once::hf924ea0a0f25a1c0 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panic.rs:346:9 [INFO] [stdout] 32: 0x5621349d2388 - std::panicking::try::do_call::hd58061792d05fa5c [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:401:40 [INFO] [stdout] 33: 0x5621349d2388 - std::panicking::try::h3080747417e5af37 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panicking.rs:365:19 [INFO] [stdout] 34: 0x5621349d2388 - std::panic::catch_unwind::hfeba515dcf36cb66 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/panic.rs:433:14 [INFO] [stdout] 35: 0x5621349d2388 - std::thread::Builder::spawn_unchecked::{{closure}}::h29d57a62faff749b [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/thread/mod.rs:480:30 [INFO] [stdout] 36: 0x5621349d2388 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h44709d312d2a9c59 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 37: 0x562134ac3967 - as core::ops::function::FnOnce>::call_once::h902e2cf6655e1b0c [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/alloc/src/boxed.rs:1575:9 [INFO] [stdout] 38: 0x562134ac3967 - as core::ops::function::FnOnce>::call_once::h893a5452154309d1 [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/alloc/src/boxed.rs:1575:9 [INFO] [stdout] 39: 0x562134ac3967 - std::sys::unix::thread::Thread::new::thread_start::hdedcb57c96ab37cd [INFO] [stdout] at /rustc/99e3aef02079e9c10583638520cd0c134dc3a01d/library/std/src/sys/unix/thread.rs:71:17 [INFO] [stdout] 40: 0x7fd452d40609 - start_thread [INFO] [stdout] 41: 0x7fd452b10293 - clone [INFO] [stdout] 42: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] countertimer::tests::stopwatch_as_timer [INFO] [stdout] countertimer::tests::timeaverage [INFO] [stdout] [INFO] [stdout] test result: FAILED. 90 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass '--lib' [INFO] running `Command { std: "docker" "inspect" "8e40dee6c71a6a60031bf69f8358fb0c1cdd340be79aa982f19cde9294e73bfb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8e40dee6c71a6a60031bf69f8358fb0c1cdd340be79aa982f19cde9294e73bfb", kill_on_drop: false }` [INFO] [stdout] 8e40dee6c71a6a60031bf69f8358fb0c1cdd340be79aa982f19cde9294e73bfb