[INFO] fetching crate counter 0.5.4...
[INFO] testing counter-0.5.4 against beta-2022-04-10 for beta-1.61-1
[INFO] extracting crate counter 0.5.4 into /workspace/builds/worker-20/source
[INFO] validating manifest of crates.io crate counter 0.5.4 on toolchain beta-2022-04-10
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate counter 0.5.4
[INFO] finished tweaking crates.io crate counter 0.5.4
[INFO] tweaked toml for crates.io crate counter 0.5.4 written to /workspace/builds/worker-20/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 9b688d622b58b0e5cda2676e6126252834e96c99b85cd326ddfa12745568fca0
[INFO] running `Command { std: "docker" "start" "-a" "9b688d622b58b0e5cda2676e6126252834e96c99b85cd326ddfa12745568fca0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9b688d622b58b0e5cda2676e6126252834e96c99b85cd326ddfa12745568fca0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9b688d622b58b0e5cda2676e6126252834e96c99b85cd326ddfa12745568fca0", kill_on_drop: false }`
[INFO] [stdout] 9b688d622b58b0e5cda2676e6126252834e96c99b85cd326ddfa12745568fca0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7866c6ad15bf0df91517d9eefb6badb7d9afdf83248f3031daa17904060a83b5
[INFO] running `Command { std: "docker" "start" "-a" "7866c6ad15bf0df91517d9eefb6badb7d9afdf83248f3031daa17904060a83b5", kill_on_drop: false }`
[INFO] [stderr]    Compiling counter v0.5.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.68s
[INFO] running `Command { std: "docker" "inspect" "7866c6ad15bf0df91517d9eefb6badb7d9afdf83248f3031daa17904060a83b5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7866c6ad15bf0df91517d9eefb6badb7d9afdf83248f3031daa17904060a83b5", kill_on_drop: false }`
[INFO] [stdout] 7866c6ad15bf0df91517d9eefb6badb7d9afdf83248f3031daa17904060a83b5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 83ca4d6dfddb4d8150511a03b74d972bd1f1d64da0ed0416f480e459d7fc5d68
[INFO] running `Command { std: "docker" "start" "-a" "83ca4d6dfddb4d8150511a03b74d972bd1f1d64da0ed0416f480e459d7fc5d68", kill_on_drop: false }`
[INFO] [stderr]    Compiling counter v0.5.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.92s
[INFO] [stderr]   Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/counter-bea5e81a6b97e68f)
[INFO] running `Command { std: "docker" "inspect" "83ca4d6dfddb4d8150511a03b74d972bd1f1d64da0ed0416f480e459d7fc5d68", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "83ca4d6dfddb4d8150511a03b74d972bd1f1d64da0ed0416f480e459d7fc5d68", kill_on_drop: false }`
[INFO] [stdout] 83ca4d6dfddb4d8150511a03b74d972bd1f1d64da0ed0416f480e459d7fc5d68
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 7b9882e6213ecf79f041f2e38d44175bda6b3b5a1c69fd71e3ab38b95bba435f
[INFO] running `Command { std: "docker" "start" "-a" "7b9882e6213ecf79f041f2e38d44175bda6b3b5a1c69fd71e3ab38b95bba435f", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/counter-bea5e81a6b97e68f)
[INFO] [stdout] 
[INFO] [stdout] running 26 tests
[INFO] [stdout] test tests::test_add ... ok
[INFO] [stdout] test tests::test_add_update_counter ... ok
[INFO] [stdout] test tests::test_collect ... ok
[INFO] [stdout] test tests::test_add_update_iterable ... ok
[INFO] [stdout] test tests::test_composite_add_sub ... ok
[INFO] [stdout] test tests::test_count_minimal_type ... ok
[INFO] [stdout] test tests::test_creation ... ok
[INFO] [stdout] test tests::test_delete_key_from_backing_map ... ok
[INFO] [stdout] test tests::test_extend_simple ... ok
[INFO] [stdout] test tests::test_extend_tuple ... ok
[INFO] [stdout] test tests::test_from_iter_simple ... ok
[INFO] [stdout] test tests::test_extend_tuple_with_duplicates ... ok
[INFO] [stdout] test tests::test_from_iter_tuple ... ok
[INFO] [stdout] test tests::test_from_iter_tuple_with_duplicates ... ok
[INFO] [stdout] test tests::test_intersection ... ok
[INFO] [stdout] test tests::test_most_common ... ok
[INFO] [stdout] test tests::test_most_common_ordered ... ok
[INFO] [stdout] test tests::test_most_common_tiebreaker ... ok
[INFO] [stdout] test tests::test_most_common_tiebreaker_reversed ... ok
[INFO] [stdout] test tests::test_non_usize_count ... ok
[INFO] [stdout] test tests::test_sub ... ok
[INFO] [stdout] test tests::test_sub_update_counter ... ok
[INFO] [stdout] test tests::test_sub_update_iterable ... ok
[INFO] [stdout] test tests::test_subtract ... ok
[INFO] [stdout] test tests::test_union ... ok
[INFO] [stdout] test tests::test_update ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests counter
[INFO] [stdout] 
[INFO] [stdout] running 36 tests
[INFO] [stdout] test src/lib.rs - (line 150) ... ok
[INFO] [stdout] test src/lib.rs - (line 24) ... ok
[INFO] [stdout] test src/lib.rs - (line 17) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::extend (line 849) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::extend (line 870) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::add (line 730) ... ok
[INFO] [stdout] test src/lib.rs - (line 108) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::from_iter (line 802) ... ok
[INFO] [stdout] test src/lib.rs - &'amutCounter<T,N>::into_iter (line 610) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::index_mut (line 674) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::extend (line 895) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::from_iter (line 823) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::index (line 642) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::into_iter (line 578) ... ok
[INFO] [stdout] test src/lib.rs - (line 71) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::add (line 373) ... ok
[INFO] [stdout] test src/lib.rs - (line 49) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::add_assign (line 343) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::sub (line 443) ... ok
[INFO] [stdout] test src/lib.rs - (line 94) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::sub_assign (line 755) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::subtract (line 218) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::index_mut (line 685) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::most_common_ordered (line 310) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::add_assign (line 705) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::bitor (line 513) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::index (line 653) ... ok
[INFO] [stdout] test src/lib.rs - (line 37) ... ok
[INFO] [stdout] test src/lib.rs - (line 9) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::bitand (line 471) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::sub (line 779) ... ok
[INFO] [stdout] test src/lib.rs - (line 85) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::most_common_tiebreaker (line 272) ... ok
[INFO] [stdout] test src/lib.rs - (line 60) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::sub_assign (line 400) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::most_common (line 252) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 36 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.95s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "7b9882e6213ecf79f041f2e38d44175bda6b3b5a1c69fd71e3ab38b95bba435f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7b9882e6213ecf79f041f2e38d44175bda6b3b5a1c69fd71e3ab38b95bba435f", kill_on_drop: false }`
[INFO] [stdout] 7b9882e6213ecf79f041f2e38d44175bda6b3b5a1c69fd71e3ab38b95bba435f