[INFO] fetching crate sac-base 0.0.7...
[INFO] testing sac-base-0.0.7 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] extracting crate sac-base 0.0.7 into /workspace/builds/worker-3/source
[INFO] validating manifest of crates.io crate sac-base 0.0.7 on toolchain 722e1797249a965b6335aebd65d777f917e498f1
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate sac-base 0.0.7
[INFO] finished tweaking crates.io crate sac-base 0.0.7
[INFO] tweaked toml for crates.io crate sac-base 0.0.7 written to /workspace/builds/worker-3/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "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" "+722e1797249a965b6335aebd65d777f917e498f1" "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] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded graphlib v0.6.3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 422b13d092f7a385bd3a5e751a574e23ad0fb5af293beabf7a60cd7cd23b08ff
[INFO] running `Command { std: "docker" "start" "-a" "422b13d092f7a385bd3a5e751a574e23ad0fb5af293beabf7a60cd7cd23b08ff", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "422b13d092f7a385bd3a5e751a574e23ad0fb5af293beabf7a60cd7cd23b08ff", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "422b13d092f7a385bd3a5e751a574e23ad0fb5af293beabf7a60cd7cd23b08ff", kill_on_drop: false }`
[INFO] [stdout] 422b13d092f7a385bd3a5e751a574e23ad0fb5af293beabf7a60cd7cd23b08ff
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 28496926bc2dc4c04c7098676d1c9d8f68130cc73496b0ca0b319e507b49beac
[INFO] running `Command { std: "docker" "start" "-a" "28496926bc2dc4c04c7098676d1c9d8f68130cc73496b0ca0b319e507b49beac", kill_on_drop: false }`
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.15
[INFO] [stderr]    Compiling ahash v0.2.19
[INFO] [stderr]    Compiling hex v0.4.3
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling num-integer v0.1.44
[INFO] [stderr]    Compiling num-complex v0.2.4
[INFO] [stderr]    Compiling num-rational v0.2.4
[INFO] [stderr]    Compiling num-iter v0.1.42
[INFO] [stderr]    Compiling hashbrown v0.6.3
[INFO] [stderr]    Compiling rand_isaac v0.2.0
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling graphlib v0.6.3
[INFO] [stderr]    Compiling num v0.2.1
[INFO] [stderr]    Compiling sac-base v0.0.7 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.10s
[INFO] running `Command { std: "docker" "inspect" "28496926bc2dc4c04c7098676d1c9d8f68130cc73496b0ca0b319e507b49beac", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "28496926bc2dc4c04c7098676d1c9d8f68130cc73496b0ca0b319e507b49beac", kill_on_drop: false }`
[INFO] [stdout] 28496926bc2dc4c04c7098676d1c9d8f68130cc73496b0ca0b319e507b49beac
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9e351908daf0de105f5cfab5724a1893a6e4058be43d1123eac42cd1c33d0f49
[INFO] running `Command { std: "docker" "start" "-a" "9e351908daf0de105f5cfab5724a1893a6e4058be43d1123eac42cd1c33d0f49", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling assert_approx_eq v1.1.0
[INFO] [stderr]    Compiling sac-base v0.0.7 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.27s
[INFO] running `Command { std: "docker" "inspect" "9e351908daf0de105f5cfab5724a1893a6e4058be43d1123eac42cd1c33d0f49", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9e351908daf0de105f5cfab5724a1893a6e4058be43d1123eac42cd1c33d0f49", kill_on_drop: false }`
[INFO] [stdout] 9e351908daf0de105f5cfab5724a1893a6e4058be43d1123eac42cd1c33d0f49
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 2f31a56f2d4f16e97c9d7b48e3cc7b4a056fc30d330fe1314a38efae4fd082d9
[INFO] running `Command { std: "docker" "start" "-a" "2f31a56f2d4f16e97c9d7b48e3cc7b4a056fc30d330fe1314a38efae4fd082d9", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.54s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/sac_base-dacb8ab74b265a6d)
[INFO] [stdout] 
[INFO] [stdout] running 43 tests
[INFO] [stdout] test operations::math::add::tests::test_multiple ... ok
[INFO] [stdout] test operations::math::add::tests::test_add ... ok
[INFO] [stdout] test operations::math::add::tests::test_multiple_runs ... ok
[INFO] [stdout] test operations::math::add::tests::test_multiple_single ... ok
[INFO] [stdout] test operations::math::add::tests::test_variable_len ... ok
[INFO] [stdout] test network::network::tests::test_graph_slices ... ok
[INFO] [stdout] test operations::math::differentiate::tests::test_differentiate_constant ... ok
[INFO] [stdout] test network::network::tests::test_graph ... ok
[INFO] [stdout] test operations::math::differentiate::tests::test_differentiate_slope ... ok
[INFO] [stdout] test operations::math::differentiate::tests::test_long_slice ... ok
[INFO] [stdout] test operations::math::divide::tests::test_div ... ok
[INFO] [stdout] test operations::math::divide::tests::test_float_div_zero ... ok
[INFO] [stdout] test network::network::tests::test_graph_closed_loop ... ok
[INFO] [stdout] test operations::math::divide::tests::test_int_div_zero ... ok
[INFO] [stdout] test operations::math::divide::tests::test_multiple ... ok
[INFO] [stdout] test operations::math::divide::tests::test_multiple_runs ... ok
[INFO] [stdout] test operations::math::divide::tests::test_multiple_single ... ok
[INFO] [stdout] test operations::math::fir::tests::test_fir_integrate ... ok
[INFO] [stdout] test operations::math::fir::tests::test_fir_simple ... ok
[INFO] [stdout] test operations::math::iir::tests::test_iir_simple ... ok
[INFO] [stdout] test operations::math::integrate::tests::test_integrate_constant ... ok
[INFO] [stdout] test operations::math::iir::tests::test_iir_actual ... ok
[INFO] [stdout] test operations::math::integrate::tests::test_integrate_slope ... ok
[INFO] [stdout] test operations::math::integrate::tests::test_longer_slice_limited ... ok
[INFO] [stdout] test operations::math::integrate::tests::test_longer_slice ... ok
[INFO] [stdout] test operations::math::max::tests::test_max ... ok
[INFO] [stdout] test operations::math::max::tests::test_max_integer ... ok
[INFO] [stdout] test operations::math::max::tests::test_max_slice ... ok
[INFO] [stdout] test operations::math::min::tests::test_min ... ok
[INFO] [stdout] test operations::math::min::tests::test_min_integer ... ok
[INFO] [stdout] test operations::math::min::tests::test_min_slice ... ok
[INFO] [stdout] test operations::math::multiply::tests::test_long_slice ... ok
[INFO] [stdout] test operations::math::multiply::tests::test_mul ... ok
[INFO] [stdout] test operations::math::multiply::tests::test_multiple ... ok
[INFO] [stdout] test operations::math::multiply::tests::test_multiple_runs ... ok
[INFO] [stdout] test operations::math::subtract::tests::test_add ... ok
[INFO] [stdout] test operations::math::subtract::tests::test_long_slice ... ok
[INFO] [stdout] test operations::math::subtract::tests::test_multiple ... ok
[INFO] [stdout] test operations::math::subtract::tests::test_multiple_runs ... ok
[INFO] [stdout] test operations::miscellaneous::buffer::tests::test_buffer ... ok
[INFO] [stdout] test operations::miscellaneous::invert::tests::test_invert ... ok
[INFO] [stdout] test operations::miscellaneous::invert::tests::test_slice ... ok
[INFO] [stdout] test operations::miscellaneous::shift::tests::test_shift ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 43 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests sac-base
[INFO] [stdout] 
[INFO] [stdout] running 26 tests
[INFO] [stdout] test src/network/node.rs - network::node::Node<T>::new (line 43) ... ok
[INFO] [stdout] test src/network/network.rs - network::network::Network<T>::new (line 36) ... ok
[INFO] [stdout] test src/operations/math/add.rs - operations::math::add::Add::new (line 14) ... ok
[INFO] [stdout] test src/operations/math/divide.rs - operations::math::divide::IntegerDivide::new (line 41) ... ok
[INFO] [stdout] test src/operations/miscellaneous/buffer.rs - operations::miscellaneous::buffer::Buffer::new (line 14) ... ok
[INFO] [stdout] test src/operations/math/subtract.rs - operations::math::subtract::Subtract::new (line 15) ... ok
[INFO] [stdout] test src/operations/math/divide.rs - operations::math::divide::Divide::new (line 15) ... ok
[INFO] [stdout] test src/operations/math/multiply.rs - operations::math::multiply::Multiply::new (line 15) ... ok
[INFO] [stdout] test src/operations/math/differentiate.rs - operations::math::differentiate::Differentiate::new (line 14) ... ok
[INFO] [stdout] test src/operations/math/max.rs - operations::math::max::Max<T>::new (line 18) ... ok
[INFO] [stdout] test src/operations/math/integrate.rs - operations::math::integrate::Integrate<T>::new (line 17) ... ok
[INFO] [stdout] test src/operations/math/min.rs - operations::math::min::Min<T>::new (line 18) ... ok
[INFO] [stdout] test src/operations/math/fir.rs - operations::math::fir::FIR<T>::new (line 31) ... ok
[INFO] [stdout] test src/network/network.rs - network::network::Network<T>::set_input_sample (line 261) ... ok
[INFO] [stdout] test src/network/network.rs - network::network::Network<T>::close_loop (line 224) ... ok
[INFO] [stdout] test src/operations/miscellaneous/shift.rs - operations::miscellaneous::shift::Shift<T>::new (line 20) ... ok
[INFO] [stdout] test src/network/network.rs - network::network::Network<T>::process (line 98) ... ok
[INFO] [stdout] test src/network/network.rs - network::network::Network<T>::set_input_slice (line 287) ... ok
[INFO] [stdout] test src/operations/math/iir.rs - operations::math::iir::IIR<T>::new (line 36) ... ok
[INFO] [stdout] test src/operations/miscellaneous/invert.rs - operations::miscellaneous::invert::Invert::new (line 14) ... ok
[INFO] [stdout] test src/network/network.rs - network::network::Network<T>::add_operation (line 163) ... ok
[INFO] [stdout] test src/network/network.rs - network::network::Network<T>::add_connection (line 178) ... ok
[INFO] [stdout] test src/network/network.rs - network::network::Network<T>::build (line 56) ... ok
[INFO] [stdout] test src/lib.rs - (line 33) ... ok
[INFO] [stdout] test src/network/network.rs - network::network::Network<T>::get_output (line 312) ... ok
[INFO] [stdout] test src/lib.rs - (line 108) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.17s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "2f31a56f2d4f16e97c9d7b48e3cc7b4a056fc30d330fe1314a38efae4fd082d9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2f31a56f2d4f16e97c9d7b48e3cc7b4a056fc30d330fe1314a38efae4fd082d9", kill_on_drop: false }`
[INFO] [stdout] 2f31a56f2d4f16e97c9d7b48e3cc7b4a056fc30d330fe1314a38efae4fd082d9