[INFO] fetching crate tallytree 0.2.2...
[INFO] testing tallytree-0.2.2 against beta-2022-02-22 for beta-1.60-1
[INFO] extracting crate tallytree 0.2.2 into /workspace/builds/worker-27/source
[INFO] validating manifest of crates.io crate tallytree 0.2.2 on toolchain beta-2022-02-22
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate tallytree 0.2.2
[INFO] finished tweaking crates.io crate tallytree 0.2.2
[INFO] tweaked toml for crates.io crate tallytree 0.2.2 written to /workspace/builds/worker-27/source/Cargo.toml
[INFO] crate crates.io crate tallytree 0.2.2 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 9f4cf983a0aead7eac85d2c2392a0662519401efe7fbd9c8795ccfbaec319099
[INFO] running `Command { std: "docker" "start" "-a" "9f4cf983a0aead7eac85d2c2392a0662519401efe7fbd9c8795ccfbaec319099", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9f4cf983a0aead7eac85d2c2392a0662519401efe7fbd9c8795ccfbaec319099", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9f4cf983a0aead7eac85d2c2392a0662519401efe7fbd9c8795ccfbaec319099", kill_on_drop: false }`
[INFO] [stdout] 9f4cf983a0aead7eac85d2c2392a0662519401efe7fbd9c8795ccfbaec319099
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/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=warn" "-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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] efadaee25967aaca6489c45d420d80d1a0ad6b3d501cb63f100b0c7237233c7e
[INFO] running `Command { std: "docker" "start" "-a" "efadaee25967aaca6489c45d420d80d1a0ad6b3d501cb63f100b0c7237233c7e", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling version_check v0.9.3
[INFO] [stderr]    Compiling typenum v1.14.0
[INFO] [stderr]    Compiling generic-array v0.14.4
[INFO] [stderr]    Compiling block-buffer v0.10.2
[INFO] [stderr]    Compiling crypto-common v0.1.3
[INFO] [stderr]    Compiling digest v0.10.3
[INFO] [stderr]    Compiling sha2 v0.10.2
[INFO] [stderr]    Compiling tallytree v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.67s
[INFO] running `Command { std: "docker" "inspect" "efadaee25967aaca6489c45d420d80d1a0ad6b3d501cb63f100b0c7237233c7e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "efadaee25967aaca6489c45d420d80d1a0ad6b3d501cb63f100b0c7237233c7e", kill_on_drop: false }`
[INFO] [stdout] efadaee25967aaca6489c45d420d80d1a0ad6b3d501cb63f100b0c7237233c7e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/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=warn" "-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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] b3c934df94653c42017f7ea5c70f797d4ccaa81ed0cbee2296a151602a385c56
[INFO] running `Command { std: "docker" "start" "-a" "b3c934df94653c42017f7ea5c70f797d4ccaa81ed0cbee2296a151602a385c56", kill_on_drop: false }`
[INFO] [stderr]    Compiling tallytree v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.04s
[INFO] running `Command { std: "docker" "inspect" "b3c934df94653c42017f7ea5c70f797d4ccaa81ed0cbee2296a151602a385c56", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b3c934df94653c42017f7ea5c70f797d4ccaa81ed0cbee2296a151602a385c56", kill_on_drop: false }`
[INFO] [stdout] b3c934df94653c42017f7ea5c70f797d4ccaa81ed0cbee2296a151602a385c56
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/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=warn" "-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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] dddea2ab1234c8d20b0fd82bca324ea4ecaadae06ad61e0fccbee93d9b74ea5f
[INFO] running `Command { std: "docker" "start" "-a" "dddea2ab1234c8d20b0fd82bca324ea4ecaadae06ad61e0fccbee93d9b74ea5f", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/tallytree-8b1416205ac2c94e)
[INFO] [stdout] 
[INFO] [stdout] running 34 tests
[INFO] [stdout] test generate::tests::test_generate_tree_one_vote ... ok
[INFO] [stdout] test navigate::tests::test_tree_depth ... ok
[INFO] [stdout] test node::tests::test_is_leaf_node ... ok
[INFO] [stdout] test node::tests::test_is_null_node ... ok
[INFO] [stdout] test proof::inclusion::tests::test_create_inclusion_proof ... ok
[INFO] [stdout] test proof::util::tests::test_collapse_branches_constraints ... ok
[INFO] [stdout] test navigate::tests::test_find_node_by_vote_reference ... ok
[INFO] [stdout] test node::tests::test_is_wrapper_node ... ok
[INFO] [stdout] test proof::util::tests::test_are_neighboors ... ok
[INFO] [stdout] test proof::votecount::tests::test_verify_proof_of_vote_count_2_votes ... ok
[INFO] [stdout] test generate::tests::test_generate_tree_rejects_dupes ... ok
[INFO] [stdout] test proof::util::tests::test_collapse_branches_directions ... ok
[INFO] [stdout] test proof::inclusion::tests::test_verify_invalid_exclusion_proof ... ok
[INFO] [stdout] test generate::tests::test_generate_tree_is_sorted ... ok
[INFO] [stdout] test navigate::tests::test_find_down_right_most_branch ... ok
[INFO] [stdout] test navigate::tests::test_find_closest_siblings ... ok
[INFO] [stdout] test proof::util::tests::test_directions_to_node_index ... ok
[INFO] [stdout] test proof::votecount::tests::test_verify_proof_of_vote_wrong_path ... ok
[INFO] [stdout] test proof::votecount::tests::test_verify_proof_with_invalid_inner_tally ... ok
[INFO] [stdout] test proof::votecount::tests::test_verify_proof_with_invalid_tally ... ok
[INFO] [stdout] test tally::tests::test_combine_tally ... ok
[INFO] [stdout] test proof::votecount::tests::proof_of_vote_count ... ok
[INFO] [stdout] test tally::tests::test_pretty_print ... ok
[INFO] [stdout] test proof::inclusion::tests::test_verify_valid_exclusion_proof_2 ... ok
[INFO] [stdout] test proof::votecount::tests::proof_of_vote_count_with_9_votes ... ok
[INFO] [stderr]    Doc-tests tallytree
[INFO] [stdout] test proof::inclusion::tests::test_verify_invalid_inclusion_proof ... ok
[INFO] [stdout] test proof::util::tests::test_create_merkle_proof ... ok
[INFO] [stdout] test proof::inclusion::tests::test_create_exclusion_proof ... ok
[INFO] [stdout] test proof::votecount::tests::test_verify_proof_of_vote_count_3_votes ... ok
[INFO] [stdout] test proof::inclusion::tests::test_verify_valid_exclusion_proof ... ok
[INFO] [stdout] test proof::votecount::tests::test_verify_proof_of_vote_count_1_vote ... ok
[INFO] [stdout] test proof::inclusion::tests::test_verify_valid_inclusion_proof ... ok
[INFO] [stdout] test proof::votecount::tests::test_verify_proof_of_vote_count_4_votes ... ok
[INFO] [stdout] test proof::util::tests::test_find_node_index ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 28 tests
[INFO] [stdout] test src/node.rs - node::is_null_node (line 110) ... ok
[INFO] [stdout] test src/proof/inclusion.rs - proof::inclusion::verify_exclusion_proof (line 169) ... ok
[INFO] [stdout] test src/proof/inclusion.rs - proof::inclusion::create_inclusion_exclusion_proof (line 57) ... ok
[INFO] [stdout] test src/generate.rs - generate::generate_tree (line 29) ... ok
[INFO] [stdout] test src/node.rs - node::is_leaf_node (line 53) ... ok
[INFO] [stdout] test src/navigate.rs - navigate::find_node_by_vote_reference (line 60) ... ok
[INFO] [stdout] test src/proof/util.rs - proof::util::create_merkle_proof (line 394) ... ok
[INFO] [stdout] test src/node.rs - node::null_node (line 121) ... ok
[INFO] [stdout] test src/node.rs - node::is_wrapper_node (line 72) ... ok
[INFO] [stdout] test src/proof/util.rs - proof::util::are_neighboors (line 58) ... ok
[INFO] [stdout] test src/tally.rs - tally::has_one_vote (line 53) ... ok
[INFO] [stdout] test src/navigate.rs - navigate::find_closest_siblings (line 114) ... ok
[INFO] [stdout] test src/node.rs - node::is_null_node_ref (line 91) ... ok
[INFO] [stdout] test src/utilstring.rs - utilstring::to_hex (line 6) ... ok
[INFO] [stdout] test src/proof/votecount.rs - proof::votecount::create_proof_of_vote_count (line 29) ... ok
[INFO] [stdout] test src/hash.rs - hash::hash_node_ref (line 121) ... ok
[INFO] [stdout] test src/hash.rs - hash::hash_node (line 73) ... ok
[INFO] [stdout] test src/proof/util.rs - proof::util::collapse_branches (line 160) ... ok
[INFO] [stdout] test src/tally.rs - tally::combine_tally (line 11) ... ok
[INFO] [stdout] test src/navigate.rs - navigate::find_down_right_most_branch (line 21) ... ok
[INFO] [stdout] test src/tally.rs - tally::tally_node_ref (line 157) ... ok
[INFO] [stdout] test src/proof/inclusion.rs - proof::inclusion::verify_inclusion_proof (line 105) ... ok
[INFO] [stdout] test src/proof/util.rs - proof::util::directions_to_node_index (line 357) ... ok
[INFO] [stdout] test src/proof/votecount.rs - proof::votecount::verify_proof_of_vote_count (line 55) ... ok
[INFO] [stdout] test src/tally.rs - tally::tally_node (line 122) ... ok
[INFO] [stdout] test src/proof/util.rs - proof::util::derive_wrapper_hash (line 319) ... ok
[INFO] [stdout] test src/proof/util.rs - proof::util::find_node_index (line 472) ... ok
[INFO] [stdout] test src/tally.rs - tally::pretty_print_tally (line 69) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 28 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.89s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "dddea2ab1234c8d20b0fd82bca324ea4ecaadae06ad61e0fccbee93d9b74ea5f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dddea2ab1234c8d20b0fd82bca324ea4ecaadae06ad61e0fccbee93d9b74ea5f", kill_on_drop: false }`
[INFO] [stdout] dddea2ab1234c8d20b0fd82bca324ea4ecaadae06ad61e0fccbee93d9b74ea5f