[INFO] fetching crate mset 0.0.4...
[INFO] testing mset-0.0.4 against try#ddc023471205c186b40f4bf8ffb598008dbf4885 for pr-87041-1
[INFO] extracting crate mset 0.0.4 into /workspace/builds/worker-43/source
[INFO] validating manifest of crates.io crate mset 0.0.4 on toolchain ddc023471205c186b40f4bf8ffb598008dbf4885
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate mset 0.0.4
[INFO] finished tweaking crates.io crate mset 0.0.4
[INFO] tweaked toml for crates.io crate mset 0.0.4 written to /workspace/builds/worker-43/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "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" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "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-43/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 6441acace217a6bbfd08f58cfd60d3f03afd7d07a0a34016579234cb58af10b5
[INFO] running `Command { std: "docker" "start" "-a" "6441acace217a6bbfd08f58cfd60d3f03afd7d07a0a34016579234cb58af10b5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "6441acace217a6bbfd08f58cfd60d3f03afd7d07a0a34016579234cb58af10b5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6441acace217a6bbfd08f58cfd60d3f03afd7d07a0a34016579234cb58af10b5", kill_on_drop: false }`
[INFO] [stdout] 6441acace217a6bbfd08f58cfd60d3f03afd7d07a0a34016579234cb58af10b5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/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" "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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8d23cd7091d744e0f8b61fa70f661c2f3d2b594fab0898f9c14688e360efd1c6
[INFO] running `Command { std: "docker" "start" "-a" "8d23cd7091d744e0f8b61fa70f661c2f3d2b594fab0898f9c14688e360efd1c6", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling mset v0.0.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.49s
[INFO] running `Command { std: "docker" "inspect" "8d23cd7091d744e0f8b61fa70f661c2f3d2b594fab0898f9c14688e360efd1c6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8d23cd7091d744e0f8b61fa70f661c2f3d2b594fab0898f9c14688e360efd1c6", kill_on_drop: false }`
[INFO] [stdout] 8d23cd7091d744e0f8b61fa70f661c2f3d2b594fab0898f9c14688e360efd1c6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/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" "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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f98abc1a4aeff1594dfb20c0924d527a12ac956a0770b1a52eabd9c39b6dc2ae
[INFO] running `Command { std: "docker" "start" "-a" "f98abc1a4aeff1594dfb20c0924d527a12ac956a0770b1a52eabd9c39b6dc2ae", kill_on_drop: false }`
[INFO] [stderr]    Compiling tinyvec_macros v0.1.0
[INFO] [stderr]    Compiling version_check v0.9.3
[INFO] [stderr]    Compiling proc-macro2 v0.4.30
[INFO] [stderr]    Compiling serde v1.0.131
[INFO] [stderr]    Compiling unicode-xid v0.1.0
[INFO] [stderr]    Compiling syn v0.15.44
[INFO] [stderr]    Compiling unicode-bidi v0.3.7
[INFO] [stderr]    Compiling matches v0.1.9
[INFO] [stderr]    Compiling pulldown-cmark v0.4.1
[INFO] [stderr]    Compiling percent-encoding v1.0.1
[INFO] [stderr]    Compiling bitflags v1.3.2
[INFO] [stderr]    Compiling semver-parser v0.9.0
[INFO] [stderr]    Compiling itertools v0.8.2
[INFO] [stderr]    Compiling tinyvec v1.5.1
[INFO] [stderr]    Compiling unicase v2.6.0
[INFO] [stderr]    Compiling unicode-normalization v0.1.19
[INFO] [stderr]    Compiling quote v0.6.13
[INFO] [stderr]    Compiling idna v0.1.5
[INFO] [stderr]    Compiling url v1.7.2
[INFO] [stderr]    Compiling toml v0.5.8
[INFO] [stderr]    Compiling version-sync v0.8.1
[INFO] [stderr]    Compiling mset v0.0.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 9.05s
[INFO] running `Command { std: "docker" "inspect" "f98abc1a4aeff1594dfb20c0924d527a12ac956a0770b1a52eabd9c39b6dc2ae", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f98abc1a4aeff1594dfb20c0924d527a12ac956a0770b1a52eabd9c39b6dc2ae", kill_on_drop: false }`
[INFO] [stdout] f98abc1a4aeff1594dfb20c0924d527a12ac956a0770b1a52eabd9c39b6dc2ae
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-43/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" "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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 4a9ab19ef5448d47aa4b6a6b546a0a9666d372a39ddc492b5292df48f8488ed9
[INFO] running `Command { std: "docker" "start" "-a" "4a9ab19ef5448d47aa4b6a6b546a0a9666d372a39ddc492b5292df48f8488ed9", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.48s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/mset-858eb464472c531c)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test test_mset::test_difference ... ok
[INFO] [stdout] test test_mset::test_eq ... ok
[INFO] [stdout] test test_mset::test_extend_ref ... ok
[INFO] [stdout] test test_mset::test_drain_trivial ... ok
[INFO] [stdout] test test_mset::test_intersection ... ok
[INFO] [stdout] test test_mset::test_insert_and_retrieve_elements ... ok
[INFO] [stdout] test test_mset::test_disjoint ... ok
[INFO] [stdout] test test_mset::test_iterator_over_element_counts ... ok
[INFO] [stdout] test test_mset::test_move_iter ... ok
[INFO] [stdout] test test_mset::test_iterator_over_elements ... ok
[INFO] [stdout] test test_mset::test_drain_nontrivial ... ok
[INFO] [stdout] test test_mset::test_mset_clear ... ok
[INFO] [stdout] test test_mset::test_show_nontrivial ... ok
[INFO] [stdout] test test_mset::test_retrieving_mset_values ... ok
[INFO] [stdout] test test_mset::test_show_trivial ... ok
[INFO] [stdout] test test_mset::test_symmetric_difference ... ok
[INFO] [stdout] test test_mset::test_subset_and_superset ... ok
[INFO] [stdout] test test_mset::test_retain ... ok
[INFO] [stdout] test test_mset::test_union ... ok
[INFO] [stdout] test test_mset::test_zero_capacity ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/version-numbers.rs (/opt/rustwide/target/debug/deps/version_numbers-8cbd396f1335740d)
[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.33s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 40 tests
[INFO] [stdout] test src/lib.rs - MultiSet<T,RandomState>::new (line 143) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::capacity (line 182) ... ok
[INFO] [stdout] test src/lib.rs - &'_MultiSet<T,S>::sub (line 1043) ... FAILED
[INFO] [stdout] test src/lib.rs - &'_MultiSet<T,S>::bitxor (line 1013) ... FAILED
[INFO] [stdout] test src/lib.rs - MultiSet (line 90) ... FAILED
[INFO] [stdout] test src/lib.rs - &'_MultiSet<T,S>::bitand (line 980) ... FAILED
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::element_counts (line 197) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,RandomState>::with_capacity (line 164) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::is_empty (line 263) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::reserve (line 372) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::hasher (line 348) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::get_element_multiplicity (line 888) ... 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>::clear (line 281) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::insert_times (line 557) ... ok
[INFO] [stdout] test src/lib.rs - &'_MultiSet<T,S>::bitor (line 948) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::intersection (line 785) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet (line 55) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::contains (line 838) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::elements (line 219) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::is_subset (line 481) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::iter (line 410) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet (line 114) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::retain (line 681) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::take (line 660) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::drain (line 701) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::get (line 866) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::insert (line 535) ... 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>::is_superset (line 505) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::is_disjoint (line 455) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::with_hasher (line 306) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::len (line 243) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::union (line 813) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T> (line 910) ... 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>::remove (line 587) ... 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>::difference (line 725) ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- src/lib.rs - &'_MultiSet<T,S>::sub (line 1043) stdout ----
[INFO] [stdout] Couldn't compile the test.
[INFO] [stdout] ---- src/lib.rs - &'_MultiSet<T,S>::bitxor (line 1013) stdout ----
[INFO] [stdout] Couldn't compile the test.
[INFO] [stdout] ---- src/lib.rs - MultiSet (line 90) stdout ----
[INFO] [stdout] Couldn't compile the test.
[INFO] [stdout] ---- src/lib.rs - &'_MultiSet<T,S>::bitand (line 980) stdout ----
[INFO] [stdout] Couldn't compile the test.
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     src/lib.rs - &'_MultiSet<T,S>::bitand (line 980)
[INFO] [stdout]     src/lib.rs - &'_MultiSet<T,S>::bitxor (line 1013)
[INFO] [stdout]     src/lib.rs - &'_MultiSet<T,S>::sub (line 1043)
[INFO] [stdout]     src/lib.rs - MultiSet (line 90)
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 36 passed; 4 failed; 0 ignored; 0 measured; 0 filtered out; finished in 11.00s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass '--doc'
[INFO] running `Command { std: "docker" "inspect" "4a9ab19ef5448d47aa4b6a6b546a0a9666d372a39ddc492b5292df48f8488ed9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4a9ab19ef5448d47aa4b6a6b546a0a9666d372a39ddc492b5292df48f8488ed9", kill_on_drop: false }`
[INFO] [stdout] 4a9ab19ef5448d47aa4b6a6b546a0a9666d372a39ddc492b5292df48f8488ed9