[INFO] fetching crate multimap 0.8.3...
[INFO] testing multimap-0.8.3 against beta-2022-04-10 for beta-1.61-1
[INFO] extracting crate multimap 0.8.3 into /workspace/builds/worker-106/source
[INFO] validating manifest of crates.io crate multimap 0.8.3 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 multimap 0.8.3
[INFO] finished tweaking crates.io crate multimap 0.8.3
[INFO] tweaked toml for crates.io crate multimap 0.8.3 written to /workspace/builds/worker-106/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] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/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] 3b7b17185ab7aedd421c2c0fb6e01b81912d72166f7d6fb51cd3069ca7825d31
[INFO] running `Command { std: "docker" "start" "-a" "3b7b17185ab7aedd421c2c0fb6e01b81912d72166f7d6fb51cd3069ca7825d31", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3b7b17185ab7aedd421c2c0fb6e01b81912d72166f7d6fb51cd3069ca7825d31", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3b7b17185ab7aedd421c2c0fb6e01b81912d72166f7d6fb51cd3069ca7825d31", kill_on_drop: false }`
[INFO] [stdout] 3b7b17185ab7aedd421c2c0fb6e01b81912d72166f7d6fb51cd3069ca7825d31
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/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] e19eef8179270cc3d2f7db5382bcb91b0dba6ec6c13f1a71d7d8bee61935b88e
[INFO] running `Command { std: "docker" "start" "-a" "e19eef8179270cc3d2f7db5382bcb91b0dba6ec6c13f1a71d7d8bee61935b88e", kill_on_drop: false }`
[INFO] [stderr]    Compiling multimap v0.8.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.71s
[INFO] running `Command { std: "docker" "inspect" "e19eef8179270cc3d2f7db5382bcb91b0dba6ec6c13f1a71d7d8bee61935b88e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e19eef8179270cc3d2f7db5382bcb91b0dba6ec6c13f1a71d7d8bee61935b88e", kill_on_drop: false }`
[INFO] [stdout] e19eef8179270cc3d2f7db5382bcb91b0dba6ec6c13f1a71d7d8bee61935b88e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/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] 509040f928a46fbf072c05183e73c63f3dca7f4b45e99d4f9d06bb59740f8c4a
[INFO] running `Command { std: "docker" "start" "-a" "509040f928a46fbf072c05183e73c63f3dca7f4b45e99d4f9d06bb59740f8c4a", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_test v1.0.136
[INFO] [stderr]    Compiling multimap v0.8.3 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused borrow that must be used
[INFO] [stdout]    --> src/lib.rs:962:9
[INFO] [stdout]     |
[INFO] [stdout] 962 |         &m[&1];
[INFO] [stdout]     |         ^^^^^^ the borrow produces a value
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_must_use)]` on by default
[INFO] [stdout] help: use `let _ = ...` to ignore the resulting value
[INFO] [stdout]     |
[INFO] [stdout] 962 |         let _ = &m[&1];
[INFO] [stdout]     |         +++++++
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 8.36s
[INFO] [stderr]   Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/multimap-b47f2be840d9d724)
[INFO] running `Command { std: "docker" "inspect" "509040f928a46fbf072c05183e73c63f3dca7f4b45e99d4f9d06bb59740f8c4a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "509040f928a46fbf072c05183e73c63f3dca7f4b45e99d4f9d06bb59740f8c4a", kill_on_drop: false }`
[INFO] [stdout] 509040f928a46fbf072c05183e73c63f3dca7f4b45e99d4f9d06bb59740f8c4a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/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] 3cc9bfd920689b4445d915635d0e8fa192d666d9ed657603ce28584fbf9db38a
[INFO] running `Command { std: "docker" "start" "-a" "3cc9bfd920689b4445d915635d0e8fa192d666d9ed657603ce28584fbf9db38a", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr] warning: unused borrow that must be used
[INFO] [stderr]    --> src/lib.rs:962:9
[INFO] [stderr]     |
[INFO] [stderr] 962 |         &m[&1];
[INFO] [stderr]     |         ^^^^^^ the borrow produces a value
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_must_use)]` on by default
[INFO] [stderr] help: use `let _ = ...` to ignore the resulting value
[INFO] [stderr]     |
[INFO] [stderr] 962 |         let _ = &m[&1];
[INFO] [stderr]     |         +++++++
[INFO] [stderr] 
[INFO] [stderr] warning: `multimap` (lib test) generated 1 warning
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.61s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/multimap-b47f2be840d9d724)
[INFO] [stdout] 
[INFO] [stdout] running 48 tests
[INFO] [stdout] test serde::tests::test_empty ... ok
[INFO] [stdout] test serde::tests::test_multiple ... ok
[INFO] [stdout] test serde::tests::test_single ... ok
[INFO] [stdout] test tests::capacity ... ok
[INFO] [stdout] test tests::clear ... ok
[INFO] [stdout] test tests::create ... ok
[INFO] [stdout] test tests::contains_key_true ... ok
[INFO] [stdout] test tests::get_present ... ok
[INFO] [stdout] test tests::get_vec_mut ... ok
[INFO] [stdout] test tests::get_not_present ... ok
[INFO] [stdout] test tests::contains_key_false ... ok
[INFO] [stdout] test tests::get_vec_not_present ... ok
[INFO] [stdout] test tests::get_vec_present ... ok
[INFO] [stdout] test tests::get_mut ... ok
[INFO] [stdout] test tests::index ... ok
[INFO] [stdout] test tests::insert_existing ... ok
[INFO] [stdout] test tests::insert_many_again ... ok
[INFO] [stdout] test tests::insert ... ok
[INFO] [stdout] test tests::intoiterator_consuming ... ok
[INFO] [stdout] test tests::remove_not_present ... ok
[INFO] [stdout] test tests::intoiterator_for_mutable_reference_type ... ok
[INFO] [stdout] test tests::intoiterator_for_reference_type ... ok
[INFO] [stdout] test tests::is_empty_true ... ok
[INFO] [stdout] test tests::len ... ok
[INFO] [stdout] test tests::keys ... ok
[INFO] [stdout] test tests::insert_many_from_slice_again ... ok
[INFO] [stdout] test tests::insert_many_from_slice ... ok
[INFO] [stdout] test tests::remove_present ... ok
[INFO] [stdout] test tests::is_empty_false ... ok
[INFO] [stdout] test tests::new ... ok
[INFO] [stdout] test tests::iter ... ok
[INFO] [stdout] test tests::insert_many ... ok
[INFO] [stdout] test tests::retain_also_removes_empty_vector ... ok
[INFO] [stdout] test tests::retain_removes_element ... ok
[INFO] [stdout] test tests::test_extend_consuming_hashmap ... ok
[INFO] [stdout] test tests::test_entry_vec ... ok
[INFO] [stdout] test tests::test_extend_consuming_multimap ... ok
[INFO] [stdout] test tests::test_extend_ref_multimap ... ok
[INFO] [stdout] test tests::test_eq ... ok
[INFO] [stdout] test tests::test_from_iterator ... ok
[INFO] [stdout] test tests::test_is_vec ... ok
[INFO] [stdout] test tests::test_fmt_debug ... ok
[INFO] [stdout] test tests::test_extend_ref_hashmap ... ok
[INFO] [stdout] test tests::test_entry ... ok
[INFO] [stdout] test tests::test_macro ... ok
[INFO] [stdout] test tests::test_default ... ok
[INFO] [stdout] test tests::with_capacity ... ok
[INFO] [stdout] test tests::index_no_entry - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 48 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.25s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests multimap
[INFO] [stdout] 
[INFO] [stdout] running 27 tests
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::with_capacity_and_hasher (line 145) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::capacity (line 427) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V>::new (line 97) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::iter_mut (line 520) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::is_empty (line 441) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::is_vec (line 400) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::iter_all_mut (line 570) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::with_hasher (line 128) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::retain (line 635) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::keys (line 475) ... ok
[INFO] [stdout] test src/lib.rs - (line 21) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::contains_key (line 241) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::get_vec (line 352) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::get_mut (line 327) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::iter_all (line 547) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::get_vec_mut (line 374) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::insert (line 164) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::clear (line 458) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::entry (line 599) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::insert_many_from_slice (line 214) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::insert_many (line 189) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::get (line 304) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::remove (line 280) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::len (line 260) ... ok
[INFO] [stdout] test src/lib.rs - multimap (line 863) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V>::with_capacity (line 110) ... ok
[INFO] [stdout] test src/lib.rs - MultiMap<K,V,S>::iter (line 497) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.84s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "3cc9bfd920689b4445d915635d0e8fa192d666d9ed657603ce28584fbf9db38a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3cc9bfd920689b4445d915635d0e8fa192d666d9ed657603ce28584fbf9db38a", kill_on_drop: false }`
[INFO] [stdout] 3cc9bfd920689b4445d915635d0e8fa192d666d9ed657603ce28584fbf9db38a