[INFO] fetching crate mset 0.1.0...
[INFO] testing mset-0.1.0 against try#1b74e096b9bfb06f84a3007193dcd2f059cbdf6a for pr-96025
[INFO] extracting crate mset 0.1.0 into /workspace/builds/worker-108/source
[INFO] validating manifest of crates.io crate mset 0.1.0 on toolchain 1b74e096b9bfb06f84a3007193dcd2f059cbdf6a
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "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-108/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "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-108/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-108/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" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 98c875b71c53e97becab13c041c0eaa517c62451ad5d967197c1ae052f5867ae
[INFO] running `Command { std: "docker" "start" "-a" "98c875b71c53e97becab13c041c0eaa517c62451ad5d967197c1ae052f5867ae", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "98c875b71c53e97becab13c041c0eaa517c62451ad5d967197c1ae052f5867ae", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "98c875b71c53e97becab13c041c0eaa517c62451ad5d967197c1ae052f5867ae", kill_on_drop: false }`
[INFO] [stdout] 98c875b71c53e97becab13c041c0eaa517c62451ad5d967197c1ae052f5867ae
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-108/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-108/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9d74fa10f50db1832261dc4fa8064efe2f1c9ed649343b49f75d0e176edc34df
[INFO] running `Command { std: "docker" "start" "-a" "9d74fa10f50db1832261dc4fa8064efe2f1c9ed649343b49f75d0e176edc34df", kill_on_drop: false }`
[INFO] [stderr]    Compiling mset v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.34s
[INFO] running `Command { std: "docker" "inspect" "9d74fa10f50db1832261dc4fa8064efe2f1c9ed649343b49f75d0e176edc34df", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9d74fa10f50db1832261dc4fa8064efe2f1c9ed649343b49f75d0e176edc34df", kill_on_drop: false }`
[INFO] [stdout] 9d74fa10f50db1832261dc4fa8064efe2f1c9ed649343b49f75d0e176edc34df
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-108/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-108/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1cb36b1fc3b533c55ad1f6302972194d45397632dd047d9475dfbe6246af230b
[INFO] running `Command { std: "docker" "start" "-a" "1cb36b1fc3b533c55ad1f6302972194d45397632dd047d9475dfbe6246af230b", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling version_check v0.9.4
[INFO] [stderr]    Compiling proc-macro2 v1.0.37
[INFO] [stderr]    Compiling tinyvec_macros v0.1.0
[INFO] [stderr]    Compiling memchr v2.4.1
[INFO] [stderr]    Compiling matches v0.1.9
[INFO] [stderr]    Compiling serde v1.0.136
[INFO] [stderr]    Compiling unicode-xid v0.2.2
[INFO] [stderr]    Compiling semver v1.0.7
[INFO] [stderr]    Compiling unicode-bidi v0.3.7
[INFO] [stderr]    Compiling percent-encoding v2.1.0
[INFO] [stderr]    Compiling syn v1.0.91
[INFO] [stderr]    Compiling pulldown-cmark v0.8.0
[INFO] [stderr]    Compiling regex-syntax v0.6.25
[INFO] [stderr]    Compiling bitflags v1.3.2
[INFO] [stderr]    Compiling tinyvec v1.5.1
[INFO] [stderr]    Compiling form_urlencoded v1.0.1
[INFO] [stderr]    Compiling unicase v2.6.0
[INFO] [stderr]    Compiling quote v1.0.18
[INFO] [stderr]    Compiling unicode-normalization v0.1.19
[INFO] [stderr]    Compiling idna v0.2.3
[INFO] [stderr]    Compiling regex v1.5.5
[INFO] [stderr]    Compiling url v2.2.2
[INFO] [stderr]    Compiling toml v0.5.9
[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 10.45s
[INFO] [stderr]   Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/mset-4cfeabc33e47630e)
[INFO] [stderr]   Executable tests/test-lib.rs (/opt/rustwide/target/debug/deps/test_lib-78b199fcb386fa52)
[INFO] [stderr]   Executable tests/version-numbers.rs (/opt/rustwide/target/debug/deps/version_numbers-80a40eb8dc97144a)
[INFO] running `Command { std: "docker" "inspect" "1cb36b1fc3b533c55ad1f6302972194d45397632dd047d9475dfbe6246af230b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1cb36b1fc3b533c55ad1f6302972194d45397632dd047d9475dfbe6246af230b", kill_on_drop: false }`
[INFO] [stdout] 1cb36b1fc3b533c55ad1f6302972194d45397632dd047d9475dfbe6246af230b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-108/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-108/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a47ec1e39ff06eae8d70f724591416dc0ed0fddb0fdb35f5ee21e55696850d8c
[INFO] running `Command { std: "docker" "start" "-a" "a47ec1e39ff06eae8d70f724591416dc0ed0fddb0fdb35f5ee21e55696850d8c", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stdout] running 0 tests
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/mset-4cfeabc33e47630e)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test-lib.rs (/opt/rustwide/target/debug/deps/test_lib-78b199fcb386fa52)
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stderr]      Running tests/version-numbers.rs (/opt/rustwide/target/debug/deps/version_numbers-80a40eb8dc97144a)
[INFO] [stdout] 
[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_iterator_over_elements ... ok
[INFO] [stdout] test test_move_iter ... 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_subset_and_superset ... ok
[INFO] [stdout] test test_symmetric_difference ... ok
[INFO] [stdout] test test_union ... ok
[INFO] [stdout] test test_zero_capacity ... ok
[INFO] [stdout] test test_drain_nontrivial ... 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] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_readme_deps ... ok
[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.12s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests mset
[INFO] [stdout] 
[INFO] [stdout] running 40 tests
[INFO] [stdout] test src/lib.rs - MultiSet (line 114) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::get_element_multiplicity (line 889) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,RandomState>::new (line 143) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::take (line 660) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::hasher (line 348) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::capacity (line 182) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::with_hasher (line 306) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::is_empty (line 263) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,RandomState>::with_capacity (line 164) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::iter (line 410) ... 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>::bitxor (line 1014) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::distinct_elements (line 219) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet (line 90) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T> (line 911) ... 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>::is_disjoint (line 455) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::insert (line 535) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::insert_times (line 557) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::element_counts (line 197) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::retain (line 681) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::remove (line 587) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::drain (line 701) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::is_superset (line 505) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet (line 55) ... ok
[INFO] [stdout] test src/lib.rs - &'_MultiSet<T,S>::bitand (line 981) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::len (line 243) ... ok
[INFO] [stdout] test src/lib.rs - &'_MultiSet<T,S>::bitor (line 949) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::symmetric_difference (line 757) ... ok
[INFO] [stdout] test src/lib.rs - &'_MultiSet<T,S>::sub (line 1044) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::contains (line 838) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::clear (line 281) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::reserve (line 372) ... 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>::intersection (line 785) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::difference (line 725) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::remove_times (line 617) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::get (line 867) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::union (line 813) ... ok
[INFO] [stdout] test src/lib.rs - MultiSet<T,S>::is_subset (line 481) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 40 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.11s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "a47ec1e39ff06eae8d70f724591416dc0ed0fddb0fdb35f5ee21e55696850d8c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a47ec1e39ff06eae8d70f724591416dc0ed0fddb0fdb35f5ee21e55696850d8c", kill_on_drop: false }`
[INFO] [stdout] a47ec1e39ff06eae8d70f724591416dc0ed0fddb0fdb35f5ee21e55696850d8c