[INFO] fetching crate counter 0.6.0...
[INFO] testing counter-0.6.0 against master#9e136a30a965bf4e63f03095c57df7257bf96fd6 for pr-134530
[INFO] extracting crate counter 0.6.0 into /workspace/builds/worker-2-tc1/source
[INFO] validating manifest of crates.io crate counter 0.6.0 on toolchain 9e136a30a965bf4e63f03095c57df7257bf96fd6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate counter 0.6.0
[INFO] finished tweaking crates.io crate counter 0.6.0
[INFO] tweaked toml for crates.io crate counter 0.6.0 written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]      Locking 24 packages to latest compatible versions
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "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-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 233e7212123b1ab6d40046c2a3eee0d4a19309658ef2309d438178e02b1806ca
[INFO] running `Command { std: "docker" "start" "-a" "233e7212123b1ab6d40046c2a3eee0d4a19309658ef2309d438178e02b1806ca", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "233e7212123b1ab6d40046c2a3eee0d4a19309658ef2309d438178e02b1806ca", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "233e7212123b1ab6d40046c2a3eee0d4a19309658ef2309d438178e02b1806ca", kill_on_drop: false }`
[INFO] [stdout] 233e7212123b1ab6d40046c2a3eee0d4a19309658ef2309d438178e02b1806ca
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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" "RUSTDOCFLAGS=--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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1fe2ec2ca3ab378c38dc5543ba88d52fefdc88f1ec6fe851f3adc7b957351365
[INFO] running `Command { std: "docker" "start" "-a" "1fe2ec2ca3ab378c38dc5543ba88d52fefdc88f1ec6fe851f3adc7b957351365", kill_on_drop: false }`
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling counter v0.6.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.56s
[INFO] running `Command { std: "docker" "inspect" "1fe2ec2ca3ab378c38dc5543ba88d52fefdc88f1ec6fe851f3adc7b957351365", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1fe2ec2ca3ab378c38dc5543ba88d52fefdc88f1ec6fe851f3adc7b957351365", kill_on_drop: false }`
[INFO] [stdout] 1fe2ec2ca3ab378c38dc5543ba88d52fefdc88f1ec6fe851f3adc7b957351365
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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" "RUSTDOCFLAGS=--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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 543094a957323cd55ca496accd0cadc7cbabaaab4cddca44a3eb531f2be648c7
[INFO] running `Command { std: "docker" "start" "-a" "543094a957323cd55ca496accd0cadc7cbabaaab4cddca44a3eb531f2be648c7", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.169
[INFO] [stderr]    Compiling serde v1.0.216
[INFO] [stderr]    Compiling maplit v1.0.2
[INFO] [stderr]    Compiling zerocopy-derive v0.7.35
[INFO] [stderr]    Compiling zerocopy v0.7.35
[INFO] [stderr]    Compiling getrandom v0.2.15
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling ppv-lite86 v0.2.20
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling serde_json v1.0.133
[INFO] [stderr]    Compiling counter v0.6.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 8.70s
[INFO] running `Command { std: "docker" "inspect" "543094a957323cd55ca496accd0cadc7cbabaaab4cddca44a3eb531f2be648c7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "543094a957323cd55ca496accd0cadc7cbabaaab4cddca44a3eb531f2be648c7", kill_on_drop: false }`
[INFO] [stdout] 543094a957323cd55ca496accd0cadc7cbabaaab4cddca44a3eb531f2be648c7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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" "RUSTDOCFLAGS=--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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+9e136a30a965bf4e63f03095c57df7257bf96fd6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] fa181e6abc595385c8b2c7e979052fe39c0f2acc5fdb06dbd4265991b8eb753c
[INFO] running `Command { std: "docker" "start" "-a" "fa181e6abc595385c8b2c7e979052fe39c0f2acc5fdb06dbd4265991b8eb753c", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/counter-4d7c430d52751c9e)
[INFO] [stdout] 
[INFO] [stdout] running 17 tests
[INFO] [stdout] test unit_tests::test_add_update_counter ... ok
[INFO] [stdout] test unit_tests::test_add_update_iterable ... ok
[INFO] [stdout] test unit_tests::test_count_minimal_type ... ok
[INFO] [stdout] test unit_tests::test_collect ... ok
[INFO] [stdout] test unit_tests::test_creation_with_capacity ... ok
[INFO] [stdout] test unit_tests::test_creation ... ok
[INFO] [stdout] test unit_tests::test_extend_simple ... ok
[INFO] [stdout] test unit_tests::test_extend_tuple ... ok
[INFO] [stdout] test unit_tests::test_extend_tuple_with_duplicates ... ok
[INFO] [stdout] test unit_tests::test_from_iter_tuple ... ok
[INFO] [stdout] test unit_tests::test_from_iter_simple ... ok
[INFO] [stdout] test unit_tests::test_from_iter_tuple_with_duplicates ... ok
[INFO] [stdout] test unit_tests::test_non_usize_count ... ok
[INFO] [stdout] test unit_tests::test_sub_update_counter ... ok
[INFO] [stdout] test unit_tests::test_sub_update_iterable ... ok
[INFO] [stdout] test unit_tests::test_subtract ... ok
[INFO] [stdout] test unit_tests::test_update ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/tests.rs (/opt/rustwide/target/debug/deps/tests-41ca24845fab253f)
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test tests::test_add ... ok
[INFO] [stdout] test tests::test_composite_add_sub ... 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_intersection ... ok
[INFO] [stdout] test tests::test_k_most_common_ordered ... ok
[INFO] [stdout] test tests::test_delete_key_from_backing_map ... ok
[INFO] [stdout] test tests::test_most_common ... ok
[INFO] [stdout] test tests::test_superset_non_usize_count ... ok
[INFO] [stdout] test tests::test_total ... ok
[INFO] [stdout] test tests::test_union ... ok
[INFO] [stdout] test tests::test_subset_non_usize_count ... ok
[INFO] [stdout] test tests::test_most_common_ordered ... ok
[INFO] [stdout] test tests::test_most_common_tiebreaker_fn_mut ... ok
[INFO] [stdout] test tests::test_sub ... ok
[INFO] [stdout] test tests::test_k_most_common_ordered_heavy ... ok
[INFO] [stderr]    Doc-tests counter
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.18s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 47 tests
[INFO] [stdout] test src/impls/extend.rs - impls::extend::Counter<T,N>::extend (line 36) ... ok
[INFO] [stdout] test src/impls/index.rs - impls::index::Counter<T,N>::index (line 40) ... ok
[INFO] [stdout] test src/impls/add_iterable.rs - impls::add_iterable::Counter<T,N>::add_assign (line 42) ... ok
[INFO] [stdout] test src/impls/index.rs - impls::index::Counter<T,N>::index (line 24) ... ok
[INFO] [stdout] test src/impls/index.rs - impls::index::Counter<T,N>::index_mut (line 65) ... ok
[INFO] [stdout] test src/impls/into_iterator.rs - impls::into_iterator::&'amutCounter<T,N>::into_iter (line 59) ... ok
[INFO] [stdout] test src/impls/add_iterable.rs - impls::add_iterable::Counter<T,N>::add (line 18) ... ok
[INFO] [stdout] test src/impls/extend.rs - impls::extend::Counter<T,N>::extend (line 15) ... ok
[INFO] [stdout] test src/impls/index.rs - impls::index::Counter<T,N>::index_mut (line 81) ... ok
[INFO] [stdout] test src/impls/intersection.rs - impls::intersection::Counter<T,N>::bitand (line 19) ... ok
[INFO] [stdout] test src/impls/add_self.rs - impls::add_self::Counter<T,N>::add (line 19) ... ok
[INFO] [stdout] test src/impls/from_iterator.rs - impls::from_iterator::Counter<T,N>::from_iter (line 35) ... ok
[INFO] [stdout] test src/impls/add_self.rs - impls::add_self::Counter<T,N>::add_assign (line 45) ... ok
[INFO] [stdout] test src/impls/extend.rs - impls::extend::Counter<T,N>::extend (line 61) ... ok
[INFO] [stdout] test src/impls/from_iterator.rs - impls::from_iterator::Counter<T,N>::from_iter (line 58) ... ok
[INFO] [stdout] test src/impls/intersection.rs - impls::intersection::Counter<T,N>::bitand_assign (line 53) ... ok
[INFO] [stdout] test src/lib.rs - (line 139) ... ok
[INFO] [stdout] test src/lib.rs - (line 100) ... ok
[INFO] [stdout] test src/impls/sub_self.rs - impls::sub_self::Counter<T,N>::sub_assign (line 53) ... ok
[INFO] [stdout] test src/impls/sub_iterable.rs - impls::sub_iterable::Counter<T,N>::sub (line 18) ... ok
[INFO] [stdout] test src/lib.rs - (line 194) ... ok
[INFO] [stdout] test src/impls/into_iterator.rs - impls::into_iterator::Counter<T,N>::into_iter (line 27) ... ok
[INFO] [stdout] test src/lib.rs - (line 126) ... ok
[INFO] [stdout] test src/impls/union.rs - impls::union::Counter<T,N>::bitor_assign (line 66) ... ok
[INFO] [stdout] test src/impls/sub_iterable.rs - impls::sub_iterable::Counter<T,N>::sub_assign (line 45) ... ok
[INFO] [stdout] test src/lib.rs - (line 207) ... ok
[INFO] [stdout] test src/impls/sub_self.rs - impls::sub_self::Counter<T,N>::sub (line 23) ... ok
[INFO] [stdout] test src/lib.rs - (line 20) ... ok
[INFO] [stdout] test src/lib.rs - (line 160) ... ok
[INFO] [stdout] test src/lib.rs - (line 115) ... ok
[INFO] [stdout] test src/impls/union.rs - impls::union::Counter<T,N>::bitor (line 19) ... ok
[INFO] [stdout] test src/lib.rs - (line 28) ... ok
[INFO] [stdout] test src/lib.rs - (line 269) ... ok
[INFO] [stdout] test src/lib.rs - (line 224) ... ok
[INFO] [stdout] test src/lib.rs - (line 35) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::k_most_common_ordered (line 477) ... ok
[INFO] [stdout] test src/lib.rs - (line 48) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::subtract (line 358) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::most_common_tiebreaker (line 412) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::is_subset (line 583) ... ok
[INFO] [stdout] test src/lib.rs - (line 74) ... ok
[INFO] [stdout] test src/lib.rs - (line 60) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::total (line 318) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::most_common_ordered (line 449) ... ok
[INFO] [stdout] test src/lib.rs - (line 86) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::is_superset (line 558) ... ok
[INFO] [stdout] test src/lib.rs - Counter<T,N>::most_common (line 392) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 47 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.99s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "fa181e6abc595385c8b2c7e979052fe39c0f2acc5fdb06dbd4265991b8eb753c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fa181e6abc595385c8b2c7e979052fe39c0f2acc5fdb06dbd4265991b8eb753c", kill_on_drop: false }`
[INFO] [stdout] fa181e6abc595385c8b2c7e979052fe39c0f2acc5fdb06dbd4265991b8eb753c