[INFO] crate heapless 0.4.0 is already in cache
[INFO] extracting crate heapless 0.4.0 into work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/reg/heapless/0.4.0
[INFO] extracting crate heapless 0.4.0 into work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/reg/heapless/0.4.0
[INFO] validating manifest of heapless-0.4.0 on toolchain master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of heapless-0.4.0 on toolchain try#7fea0229842e79db1159ea58ad9a653b288efee9
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing heapless-0.4.0
[INFO] finished frobbing heapless-0.4.0
[INFO] frobbed toml for heapless-0.4.0 written to work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/reg/heapless/0.4.0/Cargo.toml
[INFO] started frobbing heapless-0.4.0
[INFO] finished frobbing heapless-0.4.0
[INFO] frobbed toml for heapless-0.4.0 written to work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/reg/heapless/0.4.0/Cargo.toml
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing heapless-0.4.0 against try#7fea0229842e79db1159ea58ad9a653b288efee9 for pr-57967
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-57967/worker-2/try#7fea0229842e79db1159ea58ad9a653b288efee9:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/reg/heapless/0.4.0:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "build" "--frozen"`
[INFO] [stdout] 738936448c7760f00db801083bd8742357bc89bcbad378ef1a262bb51db8f96e
[INFO] running `"docker" "start" "-a" "738936448c7760f00db801083bd8742357bc89bcbad378ef1a262bb51db8f96e"`
[INFO] [stderr]    Compiling hash32 v0.1.0
[INFO] [stderr]    Compiling heapless v0.4.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.86s
[INFO] running `"docker" "inspect" "738936448c7760f00db801083bd8742357bc89bcbad378ef1a262bb51db8f96e"`
[INFO] running `"docker" "rm" "-f" "738936448c7760f00db801083bd8742357bc89bcbad378ef1a262bb51db8f96e"`
[INFO] [stdout] 738936448c7760f00db801083bd8742357bc89bcbad378ef1a262bb51db8f96e
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-57967/worker-2/try#7fea0229842e79db1159ea58ad9a653b288efee9:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/reg/heapless/0.4.0:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "test" "--frozen" "--no-run"`
[INFO] [stdout] aadcfa8e103c264dc53494c50d382bcb7edc509dc3897ccc3d7eb9f6abda5541
[INFO] running `"docker" "start" "-a" "aadcfa8e103c264dc53494c50d382bcb7edc509dc3897ccc3d7eb9f6abda5541"`
[INFO] [stderr]    Compiling heapless v0.4.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.95s
[INFO] running `"docker" "inspect" "aadcfa8e103c264dc53494c50d382bcb7edc509dc3897ccc3d7eb9f6abda5541"`
[INFO] running `"docker" "rm" "-f" "aadcfa8e103c264dc53494c50d382bcb7edc509dc3897ccc3d7eb9f6abda5541"`
[INFO] [stdout] aadcfa8e103c264dc53494c50d382bcb7edc509dc3897ccc3d7eb9f6abda5541
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-57967/worker-2/try#7fea0229842e79db1159ea58ad9a653b288efee9:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/reg/heapless/0.4.0:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "test" "--frozen"`
[INFO] [stdout] bcaa96099dbec8162aa213de8ae3e8e3e32afbd040f8e3dc7016c4006ecad677
[INFO] running `"docker" "start" "-a" "bcaa96099dbec8162aa213de8ae3e8e3e32afbd040f8e3dc7016c4006ecad677"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/heapless-a3135de7e6dcfc20
[INFO] [stdout] 
[INFO] [stdout] running 44 tests
[INFO] [stdout] test spsc::tests::iter_mut ... ok
[INFO] [stdout] test spsc::tests::iter ... ok
[INFO] [stdout] test spsc::tests::full ... ok
[INFO] [stdout] test spsc::tests::drop ... ok
[INFO] [stdout] test spsc::split::tests::sanity ... ok
[INFO] [stdout] test spsc::tests::sanity ... ok
[INFO] [stdout] test spsc::tests::wrap_around ... ok
[INFO] [stdout] test indexmap::tests::size ... ok
[INFO] [stdout] test string::tests::as_bytes ... ok
[INFO] [stdout] test string::tests::as_mut_str ... ok
[INFO] [stdout] test string::tests::as_str ... ok
[INFO] [stdout] test string::tests::clear ... ok
[INFO] [stdout] test string::tests::debug ... ok
[INFO] [stdout] test string::tests::empty ... ok
[INFO] [stdout] test string::tests::from ... ok
[INFO] [stdout] test string::tests::from_utf8 ... ok
[INFO] [stdout] test string::tests::from_utf8_uenc ... ok
[INFO] [stdout] test string::tests::from_utf8_uenc_err ... ok
[INFO] [stdout] test binary_heap::tests::min ... ok
[INFO] [stdout] test spsc::tests::ready_flag ... ok
[INFO] [stdout] test string::tests::into_bytes ... ok
[INFO] [stdout] test binary_heap::tests::max ... ok
[INFO] [stdout] test string::tests::from_utf8_unchecked ... ok
[INFO] [stdout] test string::tests::push_str ... ok
[INFO] [stdout] test string::tests::truncate ... ok
[INFO] [stdout] test string::tests::is_empty ... ok
[INFO] [stdout] test string::tests::pop ... ok
[INFO] [stdout] test vec::tests::eq ... ok
[INFO] [stdout] test vec::tests::collect_from_iter ... ok
[INFO] [stdout] test string::tests::pop_uenc ... ok
[INFO] [stdout] test string::tests::push ... ok
[INFO] [stdout] test vec::tests::iter ... ok
[INFO] [stdout] test vec::tests::iter_move ... ok
[INFO] [stdout] test vec::tests::iter_mut ... ok
[INFO] [stdout] test vec::tests::iter_move_drop ... ok
[INFO] [stdout] test vec::tests::resize_length_cases ... ok
[INFO] [stdout] test vec::tests::full ... ok
[INFO] [stdout] test vec::tests::drop ... ok
[INFO] [stdout] test vec::tests::resize_default ... ok
[INFO] [stdout] test vec::tests::resize_contents ... ok
[INFO] [stdout] test vec::tests::push_and_pop ... ok
[INFO] [stdout] test vec::tests::resize_size_limit ... ok
[INFO] [stdout] test string::tests::from_panic ... ok
[INFO] [stdout] test vec::tests::collect_from_iter_overfull ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 44 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/tsan-ca26871f4a10c877
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test unchecked ... ok
[INFO] [stdout] test iterator_properly_wraps ... ok
[INFO] [stdout] test len_properly_wraps ... ok
[INFO] [stdout] test twice ... ok
[INFO] [stdout] test scoped ... ok
[INFO] [stdout] test once ... ok
[INFO] [stdout] producer: 2096128
[INFO] [stdout] consumer: 261120
[INFO] [stdout] test contention ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests heapless
[INFO] [stdout] 
[INFO] [stdout] running 81 tests
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T, N, K>::len (line 157) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T, N, K>::is_empty (line 173) ... ok
[INFO] [stdout] test src/cfail.rs - cfail (line 26) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T, N, K>::clear (line 137) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T, N, K>::peek (line 224) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T, N, K>::push (line 277) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T, N, K>::pop (line 243) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap<T, N, K>::iter (line 193) ... ok
[INFO] [stdout] test src/cfail.rs - cfail (line 38) ... ok
[INFO] [stdout] test src/binary_heap.rs - binary_heap::BinaryHeap (line 54) ... ok
[INFO] [stdout] test src/cfail.rs - cfail (line 50) ... ok
[INFO] [stdout] test src/cfail.rs - cfail (line 61) ... ok
[INFO] [stdout] test src/cfail.rs - cfail (line 76) ... ok
[INFO] [stdout] test src/const_fn.rs - string::String<N>::new (line 28) ... ok
[INFO] [stdout] test src/cfail.rs - cfail (line 7) ... ok
[INFO] [stdout] test src/const_fn.rs - linear_map::LinearMap<K, V, N>::new (line 26) ... ok
[INFO] [stdout] test src/const_fn.rs - binary_heap::BinaryHeap<T, N, K>::new (line 24) ... ok
[INFO] [stdout] test src/indexmap.rs - indexmap::IndexMap (line 277) ... ok
[INFO] [stdout] test src/indexmap.rs - indexmap::IndexMap<K, V, N, S>::clear (line 500) ... ok
[INFO] [stdout] test src/indexmap.rs - indexmap::IndexMap<K, V, N, S>::contains_key (line 550) ... ok
[INFO] [stdout] test src/indexmap.rs - indexmap::IndexMap<K, V, N, S>::is_empty (line 483) ... ok
[INFO] [stdout] test src/indexmap.rs - indexmap::IndexMap<K, V, N, S>::get (line 523) ... ok
[INFO] [stdout] test src/indexmap.rs - indexmap::IndexMap<K, V, N, S>::get_mut (line 576) ... ok
[INFO] [stdout] test src/indexmap.rs - indexmap::IndexMap<K, V, N, S>::iter (line 415) ... ok
[INFO] [stdout] test src/indexmap.rs - indexmap::IndexMap<K, V, N, S>::keys (line 354) ... ok
[INFO] [stdout] test src/indexmap.rs - indexmap::IndexMap<K, V, N, S>::insert (line 615) ... ok
[INFO] [stdout] test src/indexmap.rs - indexmap::IndexMap<K, V, N, S>::iter_mut (line 436) ... ok
[INFO] [stdout] test src/indexmap.rs - indexmap::IndexMap<K, V, N, S>::len (line 466) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet (line 20) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::capacity (line 79) ... ok
[INFO] [stdout] test src/indexmap.rs - indexmap::IndexMap<K, V, N, S>::values (line 373) ... ok
[INFO] [stdout] test src/indexmap.rs - indexmap::IndexMap<K, V, N, S>::remove (line 648) ... ok
[INFO] [stdout] test src/indexmap.rs - indexmap::IndexMap<K, V, N, S>::values_mut (line 392) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::contains (line 309) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::clear (line 289) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::difference (line 118) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::is_empty (line 272) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::insert (line 414) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::intersection (line 191) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::is_disjoint (line 330) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::iter (line 94) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::is_superset (line 382) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::is_subset (line 356) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::len (line 255) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::symmetric_difference (line 157) ... ok
[INFO] [stdout] test src/linear_map.rs - linear_map::LinearMap<K, V, N>::capacity (line 46) ... ok
[INFO] [stdout] test src/lib.rs -  (line 11) ... ok
[INFO] [stdout] test src/linear_map.rs - linear_map::LinearMap<K, V, N>::clear (line 63) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::remove (line 438) ... ok
[INFO] [stdout] test src/indexset.rs - indexset::IndexSet<T, N, S>::union (line 225) ... ok
[INFO] [stdout] test src/linear_map.rs - linear_map::LinearMap<K, V, N>::get (line 101) ... ok
[INFO] [stdout] test src/linear_map.rs - linear_map::LinearMap<K, V, N>::contains_key (line 82) ... ok
[INFO] [stdout] test src/linear_map.rs - linear_map::LinearMap<K, V, N>::insert (line 176) ... ok
[INFO] [stdout] test src/linear_map.rs - linear_map::LinearMap<K, V, N>::get_mut (line 126) ... ok
[INFO] [stdout] test src/linear_map.rs - linear_map::LinearMap<K, V, N>::iter (line 221) ... ok
[INFO] [stdout] test src/linear_map.rs - linear_map::LinearMap<K, V, N>::is_empty (line 204) ... ok
[INFO] [stdout] test src/linear_map.rs - linear_map::LinearMap<K, V, N>::iter_mut (line 245) ... ok
[INFO] [stdout] test src/linear_map.rs - linear_map::LinearMap<K, V, N>::len (line 153) ... ok
[INFO] [stdout] test src/linear_map.rs - linear_map::LinearMap<K, V, N>::keys (line 273) ... ok
[INFO] [stdout] test src/linear_map.rs - linear_map::LinearMap<K, V, N>::remove (line 297) ... ok
[INFO] [stdout] test src/spsc/mod.rs - spsc::Queue (line 87) ... ok
[INFO] [stdout] test src/spsc/mod.rs - spsc::Queue (line 70) ... ok
[INFO] [stdout] test src/linear_map.rs - linear_map::LinearMap<K, V, N>::values_mut (line 345) ... ok
[INFO] [stdout] test src/string.rs - string::String<N>::as_mut_str (line 147) ... ok
[INFO] [stdout] test src/string.rs - string::String<N>::as_str (line 126) ... ok
[INFO] [stdout] test src/string.rs - string::String<N>::capacity (line 189) ... ok
[INFO] [stdout] test src/linear_map.rs - linear_map::LinearMap<K, V, N>::values (line 324) ... ok
[INFO] [stdout] test src/string.rs - string::String<N>::as_bytes (line 243) ... ok
[INFO] [stdout] test src/string.rs - string::String<N>::from_utf8 (line 53) ... ok
[INFO] [stdout] test src/string.rs - string::String<N>::from_utf8 (line 67) ... ok
[INFO] [stdout] test src/string.rs - string::String<N>::clear (line 357) ... ok
[INFO] [stdout] test src/string.rs - string::String<N>::into_bytes (line 105) ... ok
[INFO] [stdout] test src/string.rs - string::String<N>::is_empty (line 333) ... ok
[INFO] [stdout] test src/string.rs - string::String<N>::pop (line 301) ... ok
[INFO] [stdout] test src/string.rs - string::String<N>::len (line 380) ... ok
[INFO] [stdout] test src/string.rs - string::String<N>::push (line 209) ... ok
[INFO] [stdout] test src/string.rs - string::String<N>::truncate (line 273) ... ok
[INFO] [stdout] test src/string.rs - string::String<N>::push_str (line 166) ... ok
[INFO] [stdout] test src/vec.rs - vec::Vec (line 13) ... ok
[INFO] [stdout] test src/vec.rs - vec::Vec<T, N>::swap_remove (line 209) ... ok
[INFO] [stdout] test src/vec.rs - vec::Vec<T, N>::extend_from_slice (line 79) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 81 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "bcaa96099dbec8162aa213de8ae3e8e3e32afbd040f8e3dc7016c4006ecad677"`
[INFO] running `"docker" "rm" "-f" "bcaa96099dbec8162aa213de8ae3e8e3e32afbd040f8e3dc7016c4006ecad677"`
[INFO] [stdout] bcaa96099dbec8162aa213de8ae3e8e3e32afbd040f8e3dc7016c4006ecad677