[INFO] fetching crate ppar 0.3.1...
[INFO] testing ppar-0.3.1 against try#ddc023471205c186b40f4bf8ffb598008dbf4885 for pr-87041-1
[INFO] extracting crate ppar 0.3.1 into /workspace/builds/worker-98/source
[INFO] validating manifest of crates.io crate ppar 0.3.1 on toolchain ddc023471205c186b40f4bf8ffb598008dbf4885
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate ppar 0.3.1
[INFO] finished tweaking crates.io crate ppar 0.3.1
[INFO] tweaked toml for crates.io crate ppar 0.3.1 written to /workspace/builds/worker-98/source/Cargo.toml
[INFO] crate crates.io crate ppar 0.3.1 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "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-98/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-98/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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 9ed79dca0e3c97ff449e8ffc4529519501fbf0d2004c9080aedd9b1651e0074f
[INFO] running `Command { std: "docker" "start" "-a" "9ed79dca0e3c97ff449e8ffc4529519501fbf0d2004c9080aedd9b1651e0074f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9ed79dca0e3c97ff449e8ffc4529519501fbf0d2004c9080aedd9b1651e0074f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9ed79dca0e3c97ff449e8ffc4529519501fbf0d2004c9080aedd9b1651e0074f", kill_on_drop: false }`
[INFO] [stdout] 9ed79dca0e3c97ff449e8ffc4529519501fbf0d2004c9080aedd9b1651e0074f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-98/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-98/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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c1e9c2e59a42591cd896bbd3baafa6b0861a0bba4631559ff2db88570be94c88
[INFO] running `Command { std: "docker" "start" "-a" "c1e9c2e59a42591cd896bbd3baafa6b0861a0bba4631559ff2db88570be94c88", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling proc-macro2 v1.0.24
[INFO] [stderr]    Compiling unicode-xid v0.2.1
[INFO] [stderr]    Compiling syn v1.0.54
[INFO] [stderr]    Compiling quote v1.0.7
[INFO] [stderr]    Compiling derive_arbitrary v0.4.7
[INFO] [stderr]    Compiling arbitrary v0.4.7
[INFO] [stderr]    Compiling ppar v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 17.54s
[INFO] running `Command { std: "docker" "inspect" "c1e9c2e59a42591cd896bbd3baafa6b0861a0bba4631559ff2db88570be94c88", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c1e9c2e59a42591cd896bbd3baafa6b0861a0bba4631559ff2db88570be94c88", kill_on_drop: false }`
[INFO] [stdout] c1e9c2e59a42591cd896bbd3baafa6b0861a0bba4631559ff2db88570be94c88
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-98/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-98/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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] cb1b7728e2e1e9a523d79d2b6f69d56f3946a6b3f3d962aa2bd4164d05e28824
[INFO] running `Command { std: "docker" "start" "-a" "cb1b7728e2e1e9a523d79d2b6f69d56f3946a6b3f3d962aa2bd4164d05e28824", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.81
[INFO] [stderr]    Compiling getrandom v0.1.15
[INFO] [stderr]    Compiling ppv-lite86 v0.2.10
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling rand_pcg v0.2.1
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling ppar v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 5.17s
[INFO] running `Command { std: "docker" "inspect" "cb1b7728e2e1e9a523d79d2b6f69d56f3946a6b3f3d962aa2bd4164d05e28824", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cb1b7728e2e1e9a523d79d2b6f69d56f3946a6b3f3d962aa2bd4164d05e28824", kill_on_drop: false }`
[INFO] [stdout] cb1b7728e2e1e9a523d79d2b6f69d56f3946a6b3f3d962aa2bd4164d05e28824
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-98/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-98/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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 2deb5e1ef7f4f01da8bb4231d380f22f4e52d40baab4dcd12106051537c28e15
[INFO] running `Command { std: "docker" "start" "-a" "2deb5e1ef7f4f01da8bb4231d380f22f4e52d40baab4dcd12106051537c28e15", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.81s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/ppar-a62ee73a3856de27)
[INFO] [stdout] 
[INFO] [stdout] running 24 tests
[INFO] [stdout] test arc::ppar::ppar_test::test_new ... ok
[INFO] [stdout] test rc::ppar::ppar_test::test_new ... ok
[INFO] [stdout] test arc::ppar::fuzzy_test::test_fuzzy ... ok
[INFO] [stdout] test arc::ppar::ppar_test::test_to_vec ... ok
[INFO] [stdout] test rc::ppar::ppar_test::test_crud ... ok
[INFO] [stdout] test rc::ppar::ppar_test::test_to_vec ... ok
[INFO] [stdout] test arc::ppar::ppar_test::test_crud ... ok
[INFO] [stdout] test arc::ppar::ppar_test::test_from_slice ... ok
[INFO] [stdout] test rc::ppar::ppar_test::test_from_slice ... ok
[INFO] [stdout] test rc::ppar::ppar_test::test_iter ... ok
[INFO] [stdout] test rc::ppar::ppar_test::test_into_iter ... ok
[INFO] [stdout] test arc::ppar::ppar_test::test_into_iter ... ok
[INFO] [stdout] test arc::ppar::ppar_test::test_iter ... ok
[INFO] [stdout] test arc::ppar::ppar_test::test_append ... ok
[INFO] [stdout] test rc::ppar::ppar_test::test_append ... ok
[INFO] [stdout] test arc::ppar::ppar_test::test_delete_skew ... ok
[INFO] [stdout] test rc::ppar::ppar_test::test_delete_skew ... ok
[INFO] [stdout] test arc::ppar::ppar_test::test_rebalance ... ok
[INFO] [stdout] test rc::ppar::ppar_test::test_rebalance ... ok
[INFO] [stdout] test arc::ppar::ppar_test::test_split_off ... ok
[INFO] [stdout] test arc::ppar::ppar_test::test_prepend ... ok
[INFO] [stdout] test rc::ppar::ppar_test::test_prepend ... ok
[INFO] [stdout] test rc::ppar::ppar_test::test_split_off ... ok
[INFO] [stdout] test rc::ppar::fuzzy_test::test_fuzzy has been running for over 60 seconds
[ERROR] error running command: no output for 300 seconds
[INFO] running `Command { std: "docker" "inspect" "2deb5e1ef7f4f01da8bb4231d380f22f4e52d40baab4dcd12106051537c28e15", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2deb5e1ef7f4f01da8bb4231d380f22f4e52d40baab4dcd12106051537c28e15", kill_on_drop: false }`
[INFO] [stdout] 2deb5e1ef7f4f01da8bb4231d380f22f4e52d40baab4dcd12106051537c28e15