[INFO] fetching crate mset 0.1.0...
[INFO] testing mset-0.1.0 against beta-2022-02-22 for beta-1.60-1
[INFO] extracting crate mset 0.1.0 into /workspace/builds/worker-112/source
[INFO] validating manifest of crates.io crate mset 0.1.0 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 mset 0.1.0
[INFO] finished tweaking crates.io crate mset 0.1.0
[INFO] tweaked toml for crates.io crate mset 0.1.0 written to /workspace/builds/worker-112/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "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-02-22" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded version-sync v0.9.4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-112/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-112/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] f2d5556e4fabbd7eaa6d57135f62396d0764db0037809f8740286a562a18814f
[INFO] running `Command { std: "docker" "start" "-a" "f2d5556e4fabbd7eaa6d57135f62396d0764db0037809f8740286a562a18814f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f2d5556e4fabbd7eaa6d57135f62396d0764db0037809f8740286a562a18814f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f2d5556e4fabbd7eaa6d57135f62396d0764db0037809f8740286a562a18814f", kill_on_drop: false }`
[INFO] [stdout] f2d5556e4fabbd7eaa6d57135f62396d0764db0037809f8740286a562a18814f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-112/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-112/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] 9f4ed18df66fec43605a03e13c808ce51e57fb1a6e708261609a27ac744078b3
[INFO] running `Command { std: "docker" "start" "-a" "9f4ed18df66fec43605a03e13c808ce51e57fb1a6e708261609a27ac744078b3", kill_on_drop: false }`
[INFO] [stderr]    Compiling mset v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.37s
[INFO] running `Command { std: "docker" "inspect" "9f4ed18df66fec43605a03e13c808ce51e57fb1a6e708261609a27ac744078b3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9f4ed18df66fec43605a03e13c808ce51e57fb1a6e708261609a27ac744078b3", kill_on_drop: false }`
[INFO] [stdout] 9f4ed18df66fec43605a03e13c808ce51e57fb1a6e708261609a27ac744078b3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-112/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-112/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] 24607ddd043b8ad0813255f97dbcd9b326a234a23e1a6be05c26629549b51f0a
[INFO] running `Command { std: "docker" "start" "-a" "24607ddd043b8ad0813255f97dbcd9b326a234a23e1a6be05c26629549b51f0a", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling proc-macro2 v1.0.36
[INFO] [stderr]    Compiling tinyvec_macros v0.1.0
[INFO] [stderr]    Compiling matches v0.1.9
[INFO] [stderr]    Compiling percent-encoding v2.1.0
[INFO] [stderr]    Compiling unicode-bidi v0.3.7
[INFO] [stderr]    Compiling semver v1.0.6
[INFO] [stderr]    Compiling pulldown-cmark v0.8.0
[INFO] [stderr]    Compiling syn v1.0.86
[INFO] [stderr]    Compiling regex-syntax v0.6.25
[INFO] [stderr]    Compiling unicase v2.6.0
[INFO] [stderr]    Compiling toml v0.5.8
[INFO] [stderr]    Compiling tinyvec v1.5.1
[INFO] [stderr]    Compiling form_urlencoded v1.0.1
[INFO] [stderr]    Compiling quote v1.0.15
[INFO] [stderr]    Compiling unicode-normalization v0.1.19
[INFO] [stderr]    Compiling idna v0.2.3
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling url v2.2.2
[INFO] [stderr]    Compiling version-sync v0.9.4
[INFO] [stderr]    Compiling mset v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 7.52s
[INFO] running `Command { std: "docker" "inspect" "24607ddd043b8ad0813255f97dbcd9b326a234a23e1a6be05c26629549b51f0a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "24607ddd043b8ad0813255f97dbcd9b326a234a23e1a6be05c26629549b51f0a", kill_on_drop: false }`
[INFO] [stdout] 24607ddd043b8ad0813255f97dbcd9b326a234a23e1a6be05c26629549b51f0a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-112/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-112/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] 731e339864adcd7d3f034c17c58b3ee320e1cd3a47017012137801a4eac51cbb
[INFO] running `Command { std: "docker" "start" "-a" "731e339864adcd7d3f034c17c58b3ee320e1cd3a47017012137801a4eac51cbb", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/mset-7efdb5da242b51a8)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test-lib.rs (/opt/rustwide/target/debug/deps/test_lib-6b4332b3ae78b60e)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test test_difference ... ok
[INFO] [stdout] test test_disjoint ... ok
[INFO] [stdout] test test_drain_trivial ... ok
[INFO] [stdout] test test_eq ... ok
[INFO] [stdout] test test_extend_ref ... ok
[INFO] [stdout] test test_insert_and_retrieve_elements ... ok
[INFO] [stdout] test test_intersection ... ok
[INFO] [stdout] test test_iterator_over_element_counts ... ok
[INFO] [stdout] test test_move_iter ... ok
[INFO] [stdout] test test_iterator_over_elements ... ok
[INFO] [stdout] test test_mset_clear ... ok
[INFO] [stdout] test test_retain ... ok
[INFO] [stdout] test test_retrieving_mset_values ... ok
[INFO] [stdout] test test_show_nontrivial ... ok
[INFO] [stdout] test test_show_trivial ... ok
[INFO] [stdout] test test_drain_nontrivial ... ok
[INFO] [stdout] test test_subset_and_superset ... ok
[INFO] [stdout] test test_symmetric_difference ... ok
[INFO] [stdout] test test_zero_capacity ... ok
[INFO] [stdout] test test_union ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/version-numbers.rs (/opt/rustwide/target/debug/deps/version_numbers-8264528036802926)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_readme_deps ... ok
[INFO] [stderr]    Doc-tests mset
[INFO] [stdout] test test_html_root_url ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 40 tests
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::distinct_elements (line 219) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::remove (line 587) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::capacity (line 182) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::with_capacity_and_hasher (line 328) ... ok
[INFO] [stdout] test src/lib.rs - &'_MultiSet<T,S>::bitand (line 981) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::is_subset (line 481) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::hasher (line 348) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,RandomState>::new (line 143) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet (line 90) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::contains (line 838) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::element_counts (line 197) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet (line 114) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,RandomState>::with_capacity (line 164) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::difference (line 725) ... ok
[INFO] [stdout] test src/lib.rs - &'_MultiSet<T,S>::bitxor (line 1014) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::get_element_multiplicity (line 889) ... ok
[INFO] [stdout] test src/lib.rs - &'_MultiSet<T,S>::bitor (line 949) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::is_empty (line 263) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::len (line 243) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::insert (line 535) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::iter (line 410) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::insert_times (line 557) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::reserve (line 372) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::clear (line 281) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::remove_times (line 617) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::symmetric_difference (line 757) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::union (line 813) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet (line 55) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::take (line 660) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::is_disjoint (line 455) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::shrink_to_fit (line 388) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::intersection (line 785) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::retain (line 681) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::with_hasher (line 306) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::drain (line 701) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::iter_with_multiplicity (line 432) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::get (line 867) ... ok
[INFO] [stdout] test src/lib.rs - &'_MultiSet<T,S>::sub (line 1044) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T> (line 911) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::is_superset (line 505) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 40 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.40s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "731e339864adcd7d3f034c17c58b3ee320e1cd3a47017012137801a4eac51cbb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "731e339864adcd7d3f034c17c58b3ee320e1cd3a47017012137801a4eac51cbb", kill_on_drop: false }`
[INFO] [stdout] 731e339864adcd7d3f034c17c58b3ee320e1cd3a47017012137801a4eac51cbb