[INFO] fetching crate algorithmplus 0.1.4...
[INFO] testing algorithmplus-0.1.4 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] extracting crate algorithmplus 0.1.4 into /workspace/builds/worker-110/source
[INFO] validating manifest of crates.io crate algorithmplus 0.1.4 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 algorithmplus 0.1.4
[INFO] finished tweaking crates.io crate algorithmplus 0.1.4
[INFO] tweaked toml for crates.io crate algorithmplus 0.1.4 written to /workspace/builds/worker-110/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] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/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] b0f04c42654f7eb6d0455ed543e7253be3e9b9ce77d2b578a0123bb2aa4bcb03
[INFO] running `Command { std: "docker" "start" "-a" "b0f04c42654f7eb6d0455ed543e7253be3e9b9ce77d2b578a0123bb2aa4bcb03", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b0f04c42654f7eb6d0455ed543e7253be3e9b9ce77d2b578a0123bb2aa4bcb03", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b0f04c42654f7eb6d0455ed543e7253be3e9b9ce77d2b578a0123bb2aa4bcb03", kill_on_drop: false }`
[INFO] [stdout] b0f04c42654f7eb6d0455ed543e7253be3e9b9ce77d2b578a0123bb2aa4bcb03
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/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] 3774c3ff693c8ef2ac18193580702bb43f16099501bf4e0201ebcde035779e16
[INFO] running `Command { std: "docker" "start" "-a" "3774c3ff693c8ef2ac18193580702bb43f16099501bf4e0201ebcde035779e16", kill_on_drop: false }`
[INFO] [stderr]    Compiling algorithmplus v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.22s
[INFO] running `Command { std: "docker" "inspect" "3774c3ff693c8ef2ac18193580702bb43f16099501bf4e0201ebcde035779e16", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3774c3ff693c8ef2ac18193580702bb43f16099501bf4e0201ebcde035779e16", kill_on_drop: false }`
[INFO] [stdout] 3774c3ff693c8ef2ac18193580702bb43f16099501bf4e0201ebcde035779e16
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/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] dafe79d051273e61cdfdb2d9c52fd9c617c38b5be4cf2107b32c23e11e08dd71
[INFO] running `Command { std: "docker" "start" "-a" "dafe79d051273e61cdfdb2d9c52fd9c617c38b5be4cf2107b32c23e11e08dd71", kill_on_drop: false }`
[INFO] [stderr]    Compiling algorithmplus v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.77s
[INFO] running `Command { std: "docker" "inspect" "dafe79d051273e61cdfdb2d9c52fd9c617c38b5be4cf2107b32c23e11e08dd71", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dafe79d051273e61cdfdb2d9c52fd9c617c38b5be4cf2107b32c23e11e08dd71", kill_on_drop: false }`
[INFO] [stdout] dafe79d051273e61cdfdb2d9c52fd9c617c38b5be4cf2107b32c23e11e08dd71
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-110/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] 08687b5e5a7c1dadbeff86a47e1ed3b6fc6abea2bd5e21c5761334447062216d
[INFO] running `Command { std: "docker" "start" "-a" "08687b5e5a7c1dadbeff86a47e1ed3b6fc6abea2bd5e21c5761334447062216d", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/algorithmplus-598e0f697b7c89fd)
[INFO] [stdout] 
[INFO] [stdout] running 55 tests
[INFO] [stdout] test search::test::test::binary_search_empty ... ok
[INFO] [stdout] test search::test::test::binary_search_float_search_sorted ... ok
[INFO] [stdout] test search::test::test::binary_search_int_search_sorted ... ok
[INFO] [stdout] test search::test::test::binary_search_string_search_sorted ... ok
[INFO] [stdout] test search::test::test::linear_search_empty ... ok
[INFO] [stdout] test search::test::test::linear_search_float_search_sorted ... ok
[INFO] [stdout] test search::test::test::linear_search_float_search_unsorted ... ok
[INFO] [stdout] test search::test::test::linear_search_int_search_sorted ... ok
[INFO] [stdout] test search::test::test::linear_search_int_search_unsorted ... ok
[INFO] [stdout] test search::test::test::linear_search_string_search_sorted ... ok
[INFO] [stdout] test search::test::test::linear_search_string_search_unsorted ... ok
[INFO] [stdout] test sort::test::test::bubble_sort_empty ... ok
[INFO] [stdout] test sort::test::test::bubble_sort_float_sort ... ok
[INFO] [stdout] test sort::test::test::bubble_sort_int_sort ... ok
[INFO] [stdout] test sort::test::test::bubble_sort_one_element ... ok
[INFO] [stdout] test sort::test::test::bubble_sort_pre_sorted ... ok
[INFO] [stdout] test sort::test::test::bubble_sort_string_sort ... ok
[INFO] [stdout] test sort::test::test::heap_sort_empty ... ok
[INFO] [stdout] test sort::test::test::heap_sort_int_sort ... ok
[INFO] [stdout] test sort::test::test::heap_sort_long_int_sort ... ok
[INFO] [stdout] test sort::test::test::heap_sort_pre_sorted ... ok
[INFO] [stdout] test sort::test::test::insertion_sort_empty ... ok
[INFO] [stdout] test sort::test::test::heap_sort_one_element ... ok
[INFO] [stdout] test sort::test::test::insertion_sort_float_sort ... ok
[INFO] [stdout] test sort::test::test::heap_sort_string_sort ... ok
[INFO] [stdout] test sort::test::test::insertion_sort_one_element ... ok
[INFO] [stdout] test sort::test::test::insertion_sort_pre_sorted ... ok
[INFO] [stdout] test sort::test::test::insertion_sort_int_sort ... ok
[INFO] [stdout] test sort::test::test::merge_sort_int_sort ... ok
[INFO] [stdout] test sort::test::test::merge_sort_empty ... ok
[INFO] [stdout] test sort::test::test::merge_sort_one_element ... ok
[INFO] [stdout] test sort::test::test::merge_sort_float_sort ... ok
[INFO] [stdout] test sort::test::test::quick_sort_one_element ... ok
[INFO] [stdout] test sort::test::test::quick_sort_pre_sorted ... ok
[INFO] [stdout] test sort::test::test::quick_sort_float_sort ... ok
[INFO] [stdout] test sort::test::test::quick_sort_int_sort ... ok
[INFO] [stdout] test sort::test::test::merge_sort_long_int_sort ... ok
[INFO] [stdout] test sort::test::test::merge_sort_pre_sorted ... ok
[INFO] [stdout] test sort::test::test::quick_sort_empty ... ok
[INFO] [stdout] test sort::test::test::quick_sort_long_int_sort ... ok
[INFO] [stdout] test sort::test::test::insertion_sort_long_int_sort ... ok
[INFO] [stdout] test sort::test::test::selection_sort_empty ... ok
[INFO] [stdout] test sort::test::test::selection_sort_float_sort ... ok
[INFO] [stdout] test sort::test::test::selection_sort_int_sort ... ok
[INFO] [stdout] test sort::test::test::selection_sort_one_element ... ok
[INFO] [stdout] test sort::test::test::selection_sort_string_sort ... ok
[INFO] [stdout] test sort::test::test::tim_sort_int_sort ... ok
[INFO] [stdout] test sort::test::test::tim_sort_one_element ... ok
[INFO] [stdout] test sort::test::test::tim_sort_empty ... ok
[INFO] [stdout] test sort::test::test::selection_sort_pre_sorted ... ok
[INFO] [stdout] test sort::test::test::tim_sort_pre_sorted ... ok
[INFO] [stdout] test sort::test::test::tim_sort_float_sort ... ok
[INFO] [stdout] test sort::test::test::tim_sort_long_int_sort ... ok
[INFO] [stdout] test sort::test::test::bubble_sort_long_int_sort ... ok
[INFO] [stdout] test sort::test::test::selection_sort_long_int_sort ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 55 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests algorithmplus
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test src/search/binary_search.rs - search::binary_search::binary_search (line 15) ... ok
[INFO] [stdout] test src/search/linear_search.rs - search::linear_search::linear_search (line 24) ... ok
[INFO] [stdout] test src/search/binary_search.rs - search::binary_search::binary_search (line 24) ... ok
[INFO] [stdout] test src/search/linear_search.rs - search::linear_search::linear_search (line 15) ... ok
[INFO] [stdout] test src/sort/selection_sort.rs - sort::selection_sort::selection_sort (line 14) ... ok
[INFO] [stdout] test src/sort/bubble_sort.rs - sort::bubble_sort::bubble_sort (line 14) ... ok
[INFO] [stdout] test src/sort/insertion_sort.rs - sort::insertion_sort::insertion_sort (line 18) ... ok
[INFO] [stdout] test src/sort/quick_sort.rs - sort::quick_sort::quick_sort (line 18) ... ok
[INFO] [stdout] test src/sort/merge_sort.rs - sort::merge_sort::merge_sort (line 18) ... ok
[INFO] [stdout] test src/sort/heap_sort.rs - sort::heap_sort::heap_sort (line 20) ... ok
[INFO] [stdout] test src/sort/tim_sort.rs - sort::tim_sort::tim_sort (line 22) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.50s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "08687b5e5a7c1dadbeff86a47e1ed3b6fc6abea2bd5e21c5761334447062216d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "08687b5e5a7c1dadbeff86a47e1ed3b6fc6abea2bd5e21c5761334447062216d", kill_on_drop: false }`
[INFO] [stdout] 08687b5e5a7c1dadbeff86a47e1ed3b6fc6abea2bd5e21c5761334447062216d