[INFO] fetching crate heapless 0.7.5...
[INFO] testing heapless-0.7.5 against beta-2021-09-08 for beta-1.56-1
[INFO] extracting crate heapless 0.7.5 into /workspace/builds/worker-11/source
[INFO] validating manifest of crates.io crate heapless 0.7.5 on toolchain beta-2021-09-08
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate heapless 0.7.5
[INFO] finished tweaking crates.io crate heapless 0.7.5
[INFO] tweaked toml for crates.io crate heapless 0.7.5 written to /workspace/builds/worker-11/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "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-2021-09-08" "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-11/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8fc92ed86be00e9be4a5a0c59932f8573cc4d23c6b60be4020871ccc14d37104
[INFO] running `Command { std: "docker" "start" "-a" "8fc92ed86be00e9be4a5a0c59932f8573cc4d23c6b60be4020871ccc14d37104", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8fc92ed86be00e9be4a5a0c59932f8573cc4d23c6b60be4020871ccc14d37104", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8fc92ed86be00e9be4a5a0c59932f8573cc4d23c6b60be4020871ccc14d37104", kill_on_drop: false }`
[INFO] [stdout] 8fc92ed86be00e9be4a5a0c59932f8573cc4d23c6b60be4020871ccc14d37104
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c2c83220d8b69580c302a1276993947e7dd6e94e8501202898a97b4cd0515933
[INFO] running `Command { std: "docker" "start" "-a" "c2c83220d8b69580c302a1276993947e7dd6e94e8501202898a97b4cd0515933", kill_on_drop: false }`
[INFO] [stderr]    Compiling byteorder v1.4.3
[INFO] [stderr]    Compiling heapless v0.7.5 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling stable_deref_trait v1.2.0
[INFO] [stderr]    Compiling hash32 v0.2.1
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.45s
[INFO] running `Command { std: "docker" "inspect" "c2c83220d8b69580c302a1276993947e7dd6e94e8501202898a97b4cd0515933", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c2c83220d8b69580c302a1276993947e7dd6e94e8501202898a97b4cd0515933", kill_on_drop: false }`
[INFO] [stdout] c2c83220d8b69580c302a1276993947e7dd6e94e8501202898a97b4cd0515933
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6c2296c092e0b0e2844727faafdf30338e6394f9913636dcf108730007b8df76
[INFO] running `Command { std: "docker" "start" "-a" "6c2296c092e0b0e2844727faafdf30338e6394f9913636dcf108730007b8df76", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling syn v1.0.76
[INFO] [stderr]    Compiling defmt-parser v0.2.2
[INFO] [stderr]    Compiling ufmt-write v0.1.0
[INFO] [stderr]    Compiling scoped_threadpool v0.1.9
[INFO] [stderr]    Compiling defmt v0.2.3
[INFO] [stderr]    Compiling defmt-macros v0.2.3
[INFO] [stderr]    Compiling ufmt-macros v0.1.1
[INFO] [stderr]    Compiling ufmt v0.1.0
[INFO] [stderr]    Compiling heapless v0.7.5 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 21.41s
[INFO] running `Command { std: "docker" "inspect" "6c2296c092e0b0e2844727faafdf30338e6394f9913636dcf108730007b8df76", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6c2296c092e0b0e2844727faafdf30338e6394f9913636dcf108730007b8df76", kill_on_drop: false }`
[INFO] [stdout] 6c2296c092e0b0e2844727faafdf30338e6394f9913636dcf108730007b8df76
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 40a8757e5b5fdff6fdd0bdeda9e5a8f33f79b7cb2bbedf653090be4e8d92cd2a
[INFO] running `Command { std: "docker" "start" "-a" "40a8757e5b5fdff6fdd0bdeda9e5a8f33f79b7cb2bbedf653090be4e8d92cd2a", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.11s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/heapless-86d95ce7115a0153)
[INFO] [stdout] 
[INFO] [stdout] running 105 tests
[INFO] [stdout] test binary_heap::tests::max ... ok
[INFO] [stdout] test binary_heap::tests::min ... ok
[INFO] [stdout] test binary_heap::tests::static_new ... ok
[INFO] [stdout] test deque::tests::as_slices ... ok
[INFO] [stdout] test deque::tests::clear ... ok
[INFO] [stdout] test deque::tests::drop ... ok
[INFO] [stdout] test deque::tests::empty ... ok
[INFO] [stdout] test deque::tests::front_back ... ok
[INFO] [stdout] test deque::tests::full ... ok
[INFO] [stdout] test deque::tests::iter ... ok
[INFO] [stdout] test deque::tests::iter_move ... ok
[INFO] [stdout] test deque::tests::iter_move_drop ... ok
[INFO] [stdout] test deque::tests::iter_mut ... ok
[INFO] [stdout] test deque::tests::push_and_pop ... ok
[INFO] [stdout] test deque::tests::stack_new ... ok
[INFO] [stdout] test deque::tests::static_new ... ok
[INFO] [stdout] test histbuf::tests::as_slice ... ok
[INFO] [stdout] test histbuf::tests::clear ... ok
[INFO] [stdout] test histbuf::tests::new ... ok
[INFO] [stdout] test histbuf::tests::recent ... ok
[INFO] [stdout] test histbuf::tests::write ... ok
[INFO] [stdout] test indexmap::tests::partial_eq ... ok
[INFO] [stdout] test indexmap::tests::size ... ok
[INFO] [stdout] test linear_map::test::partial_eq ... ok
[INFO] [stdout] test linear_map::test::static_new ... ok
[INFO] [stdout] test mpmc::tests::drain_at_pos255 ... ok
[INFO] [stdout] test mpmc::tests::sanity ... ok
[INFO] [stdout] test mpmc::tests::full_at_wrapped_pos0 ... ok
[INFO] [stdout] test pool::singleton::tests::destructors ... ok
[INFO] [stdout] test pool::singleton::tests::sanity ... ok
[INFO] [stdout] test pool::tests::destructors ... ok
[INFO] [stdout] test pool::tests::grow ... ok
[INFO] [stdout] test pool::tests::grow_exact ... ok
[INFO] [stdout] test pool::tests::sanity ... ok
[INFO] [stdout] test sorted_linked_list::tests::const_new ... ok
[INFO] [stdout] test sorted_linked_list::tests::test_empty ... ok
[INFO] [stdout] test sorted_linked_list::tests::test_full ... ok
[INFO] [stdout] test sorted_linked_list::tests::test_peek ... ok
[INFO] [stdout] test sorted_linked_list::tests::test_rejected_push ... ok
[INFO] [stdout] test sorted_linked_list::tests::test_updating ... ok
[INFO] [stdout] test sorted_linked_list::tests::test_updating_1 ... ok
[INFO] [stdout] test sorted_linked_list::tests::test_updating_2 ... ok
[INFO] [stdout] test sorted_linked_list::tests::test_zero_size ... ok
[INFO] [stdout] test spsc::tests::clone ... ok
[INFO] [stdout] test spsc::tests::drop ... ok
[INFO] [stdout] test spsc::tests::empty ... ok
[INFO] [stdout] test spsc::tests::eq ... ok
[INFO] [stdout] test spsc::tests::full ... ok
[INFO] [stdout] test spsc::tests::hash_equality ... ok
[INFO] [stdout] test spsc::tests::iter ... ok
[INFO] [stdout] test spsc::tests::iter_double_ended ... ok
[INFO] [stdout] test spsc::tests::iter_mut ... ok
[INFO] [stdout] test spsc::tests::iter_mut_double_ended ... ok
[INFO] [stdout] test spsc::tests::ready_flag ... ok
[INFO] [stdout] test spsc::tests::sanity ... ok
[INFO] [stdout] test spsc::tests::static_new ... ok
[INFO] [stdout] test spsc::tests::wrap_around ... ok
[INFO] [stdout] test string::tests::as_bytes ... ok
[INFO] [stdout] test string::tests::as_str ... ok
[INFO] [stdout] test string::tests::as_mut_str ... ok
[INFO] [stdout] test string::tests::clear ... ok
[INFO] [stdout] test string::tests::clone ... ok
[INFO] [stdout] test string::tests::cmp_heterogenous_size ... ok
[INFO] [stdout] test string::tests::debug ... ok
[INFO] [stdout] test string::tests::cmp ... ok
[INFO] [stdout] test string::tests::display ... ok
[INFO] [stdout] test string::tests::empty ... ok
[INFO] [stdout] test string::tests::from ... ok
[INFO] [stdout] test string::tests::from_num ... ok
[INFO] [stdout] test string::tests::from_str ... ok
[INFO] [stdout] test string::tests::into_bytes ... ok
[INFO] [stdout] test string::tests::is_empty ... ok
[INFO] [stdout] test string::tests::pop ... ok
[INFO] [stdout] test string::tests::pop_uenc ... ok
[INFO] [stdout] test string::tests::push_str ... ok
[INFO] [stdout] test string::tests::static_new ... ok
[INFO] [stdout] test string::tests::push ... ok
[INFO] [stdout] test string::tests::truncate ... ok
[INFO] [stdout] test vec::tests::cmp_heterogenous_size ... ok
[INFO] [stdout] test vec::tests::collect_from_iter ... ok
[INFO] [stdout] test vec::tests::cmp ... ok
[INFO] [stdout] test vec::tests::drop ... ok
[INFO] [stdout] test vec::tests::ends_with ... ok
[INFO] [stdout] test vec::tests::eq ... ok
[INFO] [stdout] test vec::tests::extend_from_slice ... ok
[INFO] [stdout] test vec::tests::from_slice ... ok
[INFO] [stdout] test vec::tests::full ... ok
[INFO] [stdout] test vec::tests::is_full_empty ... ok
[INFO] [stdout] test vec::tests::iter ... ok
[INFO] [stdout] test vec::tests::iter_move ... ok
[INFO] [stdout] test vec::tests::iter_move_drop ... ok
[INFO] [stdout] test vec::tests::iter_mut ... ok
[INFO] [stdout] test vec::tests::push_and_pop ... ok
[INFO] [stdout] test vec::tests::resize_contents ... ok
[INFO] [stdout] test vec::tests::resize_default ... ok
[INFO] [stdout] test vec::tests::resize_length_cases ... ok
[INFO] [stdout] test vec::tests::resize_size_limit ... ok
[INFO] [stdout] test vec::tests::stack_new ... ok
[INFO] [stdout] test vec::tests::starts_with ... ok
[INFO] [stdout] test vec::tests::static_new ... ok
[INFO] [stdout] test vec::tests::write ... ok
[INFO] [stdout] test string::tests::from_panic - should panic ... ok
[INFO] [stdout] test vec::tests::collect_from_iter_overfull - should panic ... ok
[INFO] [stdout] test spsc::tests::len ... ok
[INFO] [stdout] test spsc::tests::try_overflow ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 105 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.08s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/cpass.rs (/opt/rustwide/target/debug/deps/cpass-fddc5a54271a948d)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test send ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/tsan.rs (/opt/rustwide/target/debug/deps/tsan-800c49e040cd6601)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test iterator_properly_wraps ... ok
[INFO] [stdout] test len_properly_wraps ... ok
[INFO] [stdout] test once ... ok
[INFO] [stdout] test contention ... ok
[INFO] [stdout] test scoped ... ok
[INFO] [stdout] test twice ... ok
[INFO] [stdout] test unchecked ... ok
[INFO] [stdout] test mpmc_contention ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests heapless
[INFO] [stdout] 
[INFO] [stdout] running 105 tests
[INFO] [stdout] test src/mpmc.rs - mpmc (line 10) ... ignored
[INFO] [stdout] test src/pool/mod.rs - pool (line 13) ... ignored
[INFO] [stdout] test src/pool/mod.rs - pool (line 73) ... ignored
[INFO] [stderr] error: test failed, to rerun pass '--doc'
[INFO] [stderr] 
[INFO] [stderr] Caused by:
[INFO] [stderr]   process didn't exit successfully: `rustdoc --edition=2018 --crate-type lib --crate-name heapless --test /opt/rustwide/workdir/src/lib.rs -L dependency=/opt/rustwide/target/debug/deps -L dependency=/opt/rustwide/target/debug/deps -L /opt/rustwide/target/debug/build/defmt-82ee9e049d72e6ff/out --extern defmt=/opt/rustwide/target/debug/deps/libdefmt-91f3b6423026b975.rlib --extern hash32=/opt/rustwide/target/debug/deps/libhash32-8b1705e3d0998e12.rlib --extern heapless=/opt/rustwide/target/debug/deps/libheapless-b34d65f11d5e9861.rlib --extern scoped_threadpool=/opt/rustwide/target/debug/deps/libscoped_threadpool-0a9edc57bfe4f517.rlib --extern stable_deref_trait=/opt/rustwide/target/debug/deps/libstable_deref_trait-741e8a55e1a3965a.rlib --extern ufmt=/opt/rustwide/target/debug/deps/libufmt-8f0b01e263af60d6.rlib -C embed-bitcode=no --cfg 'feature="atomic-polyfill"' --cfg 'feature="cas"' --cfg 'feature="default"' --cfg has_cas --cfg has_atomics --error-format human` (signal: 9, SIGKILL: kill)
[INFO] running `Command { std: "docker" "inspect" "40a8757e5b5fdff6fdd0bdeda9e5a8f33f79b7cb2bbedf653090be4e8d92cd2a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "40a8757e5b5fdff6fdd0bdeda9e5a8f33f79b7cb2bbedf653090be4e8d92cd2a", kill_on_drop: false }`
[INFO] [stdout] 40a8757e5b5fdff6fdd0bdeda9e5a8f33f79b7cb2bbedf653090be4e8d92cd2a