[INFO] fetching crate binary-heap-plus 0.4.1...
[INFO] testing binary-heap-plus-0.4.1 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] extracting crate binary-heap-plus 0.4.1 into /workspace/builds/worker-96/source
[INFO] validating manifest of crates.io crate binary-heap-plus 0.4.1 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 binary-heap-plus 0.4.1
[INFO] finished tweaking crates.io crate binary-heap-plus 0.4.1
[INFO] tweaked toml for crates.io crate binary-heap-plus 0.4.1 written to /workspace/builds/worker-96/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 compare v0.1.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/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] 022719ebd74853c5034bbf3a38791c1ee9c2c9ee4009b76b4c0dc026118b4bb8
[INFO] running `Command { std: "docker" "start" "-a" "022719ebd74853c5034bbf3a38791c1ee9c2c9ee4009b76b4c0dc026118b4bb8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "022719ebd74853c5034bbf3a38791c1ee9c2c9ee4009b76b4c0dc026118b4bb8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "022719ebd74853c5034bbf3a38791c1ee9c2c9ee4009b76b4c0dc026118b4bb8", kill_on_drop: false }`
[INFO] [stdout] 022719ebd74853c5034bbf3a38791c1ee9c2c9ee4009b76b4c0dc026118b4bb8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/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] ba4bd297ed8a402df28975117fa44d120494ca91d2f04445caebce6ed7b42536
[INFO] running `Command { std: "docker" "start" "-a" "ba4bd297ed8a402df28975117fa44d120494ca91d2f04445caebce6ed7b42536", kill_on_drop: false }`
[INFO] [stderr]    Compiling compare v0.1.0
[INFO] [stderr]    Compiling binary-heap-plus v0.4.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.54s
[INFO] running `Command { std: "docker" "inspect" "ba4bd297ed8a402df28975117fa44d120494ca91d2f04445caebce6ed7b42536", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ba4bd297ed8a402df28975117fa44d120494ca91d2f04445caebce6ed7b42536", kill_on_drop: false }`
[INFO] [stdout] ba4bd297ed8a402df28975117fa44d120494ca91d2f04445caebce6ed7b42536
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/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] b43ee7e45aae3f3a35868e463519372a943fbefc5c84d9f143037fbd9a9d063f
[INFO] running `Command { std: "docker" "start" "-a" "b43ee7e45aae3f3a35868e463519372a943fbefc5c84d9f143037fbd9a9d063f", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.107
[INFO] [stderr]    Compiling getrandom v0.1.16
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling ryu v1.0.5
[INFO] [stderr]    Compiling serde v1.0.130
[INFO] [stderr]    Compiling ppv-lite86 v0.2.15
[INFO] [stderr]    Compiling serde_json v1.0.71
[INFO] [stderr]    Compiling itoa v0.4.8
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling binary-heap-plus v0.4.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 12.39s
[INFO] running `Command { std: "docker" "inspect" "b43ee7e45aae3f3a35868e463519372a943fbefc5c84d9f143037fbd9a9d063f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b43ee7e45aae3f3a35868e463519372a943fbefc5c84d9f143037fbd9a9d063f", kill_on_drop: false }`
[INFO] [stdout] b43ee7e45aae3f3a35868e463519372a943fbefc5c84d9f143037fbd9a9d063f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-96/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] 0eb7e71d6a44c5ad24f07cca1d43f04ddd007b68fcf74b2e3c43a1b9a29407a2
[INFO] running `Command { std: "docker" "start" "-a" "0eb7e71d6a44c5ad24f07cca1d43f04ddd007b68fcf74b2e3c43a1b9a29407a2", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/binary_heap_plus-4f46c27ad0aa00c2)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test from_liballoc::test_append_to_empty ... ok
[INFO] [stdout] test from_liballoc::test_empty_pop ... ok
[INFO] [stdout] test from_liballoc::test_extend_ref ... ok
[INFO] [stdout] test from_liballoc::test_append ... ok
[INFO] [stdout] test from_liballoc::test_empty_peek ... ok
[INFO] [stdout] test from_liballoc::test_extend_specialization ... ok
[INFO] [stdout] test from_liballoc::test_empty_peek_mut ... ok
[INFO] [stdout] test from_liballoc::test_iterator ... ok
[INFO] [stdout] test from_liballoc::test_iterator_reverse ... ok
[INFO] [stdout] test from_liballoc::test_move_iter_reverse ... ok
[INFO] [stdout] test from_liballoc::test_from_iter ... ok
[INFO] [stdout] test from_liballoc::test_into_iter_sorted_collect ... ok
[INFO] [stdout] test from_liballoc::test_move_iter ... ok
[INFO] [stdout] test from_liballoc::test_move_iter_size_hint ... ok
[INFO] [stdout] test from_liballoc::test_push ... ok
[INFO] [stdout] test from_liballoc::test_to_vec ... ok
[INFO] [stdout] test from_liballoc::test_peek_and_pop ... ok
[INFO] [stdout] test from_liballoc::test_peek_mut ... ok
[INFO] [stdout] test from_liballoc::test_drain ... ok
[INFO] [stdout] test from_liballoc::test_peek_mut_pop ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests binary-heap-plus
[INFO] [stdout] 
[INFO] [stdout] running 33 tests
[INFO] [stdout] test src/binary_heap.rs - binary_heap (line 33) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap (line 195) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,FnComparator<F>>::with_capacity_by (line 547) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::reserve (line 817) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::clear (line 1113) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::replace_cmp (line 617) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::pop (line 855) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::into_iter (line 1488) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T>::with_capacity (line 451) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::reserve_exact (line 792) ... ok
[INFO] [stdout] test src/lib.rs - (line 27) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::append (line 1142) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::len (line 1045) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T>::new (line 427) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,MinComparator>::with_capacity_min (line 498) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::iter (line 668) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::is_empty (line 1062) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,KeyComparator<F>>::with_capacity_by_key (line 596) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::shrink_to_fit (line 835) ... ok
[INFO] [stdout] test src/lib.rs - (line 13) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::peek (line 708) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,KeyComparator<F>>::new_by_key (line 573) ... ok
[INFO] [stdout] test src/lib.rs - (line 43) ... ok
[INFO] [stdout] test src/lib.rs - (line 61) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,FnComparator<F>>::new_by (line 524) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::drain (line 1087) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::peek_mut (line 734) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::push (line 880) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::into_vec (line 904) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::into_sorted_vec (line 926) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::into_iter_sorted (line 691) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,C>::capacity (line 766) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T,MinComparator>::new_min (line 475) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 33 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.10s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "0eb7e71d6a44c5ad24f07cca1d43f04ddd007b68fcf74b2e3c43a1b9a29407a2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0eb7e71d6a44c5ad24f07cca1d43f04ddd007b68fcf74b2e3c43a1b9a29407a2", kill_on_drop: false }`
[INFO] [stdout] 0eb7e71d6a44c5ad24f07cca1d43f04ddd007b68fcf74b2e3c43a1b9a29407a2