[INFO] crate pqcrypto-sphincsplus 0.5.0 is already in cache
[INFO] testing pqcrypto-sphincsplus-0.5.0 against master#28742a1146f10a4f09369baad027a464acb7a766 for pr-71274
[INFO] extracting crate pqcrypto-sphincsplus 0.5.0 into /workspace/builds/worker-5/source
[INFO] validating manifest of crates.io crate pqcrypto-sphincsplus 0.5.0 on toolchain 28742a1146f10a4f09369baad027a464acb7a766
[INFO] running `"/workspace/cargo-home/bin/cargo" "+28742a1146f10a4f09369baad027a464acb7a766" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started tweaking crates.io crate pqcrypto-sphincsplus 0.5.0
[INFO] finished tweaking crates.io crate pqcrypto-sphincsplus 0.5.0
[INFO] tweaked toml for crates.io crate pqcrypto-sphincsplus 0.5.0 written to /workspace/builds/worker-5/source/Cargo.toml
[INFO] running `"/workspace/cargo-home/bin/cargo" "+28742a1146f10a4f09369baad027a464acb7a766" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/workspace/cargo-home/bin/cargo" "+28742a1146f10a4f09369baad027a464acb7a766" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "MAP_USER_ID=0" "-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" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+28742a1146f10a4f09369baad027a464acb7a766" "build" "--frozen"`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 05ead12171a628be2e719bd433d18cc62e7faa97da777bf67e171206e199ee02
[INFO] running `"docker" "start" "-a" "05ead12171a628be2e719bd433d18cc62e7faa97da777bf67e171206e199ee02"`
[INFO] [stderr]    Compiling libc v0.2.69
[INFO] [stderr]    Compiling pqcrypto-traits v0.3.3
[INFO] [stderr]    Compiling jobserver v0.1.21
[INFO] [stderr]    Compiling cc v1.0.50
[INFO] [stderr]    Compiling pqcrypto-sphincsplus v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3m 33s
[INFO] running `"docker" "inspect" "05ead12171a628be2e719bd433d18cc62e7faa97da777bf67e171206e199ee02"`
[INFO] running `"docker" "rm" "-f" "05ead12171a628be2e719bd433d18cc62e7faa97da777bf67e171206e199ee02"`
[INFO] [stdout] 05ead12171a628be2e719bd433d18cc62e7faa97da777bf67e171206e199ee02
[INFO] running `"docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "MAP_USER_ID=0" "-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" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+28742a1146f10a4f09369baad027a464acb7a766" "test" "--frozen" "--no-run"`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] e44af94d09944f4d7c1da1c0aee03530aba085c5a5823c996bfd24f4a7d415fe
[INFO] running `"docker" "start" "-a" "e44af94d09944f4d7c1da1c0aee03530aba085c5a5823c996bfd24f4a7d415fe"`
[INFO] [stderr]    Compiling getrandom v0.1.14
[INFO] [stderr]    Compiling cfg-if v0.1.10
[INFO] [stderr]    Compiling ppv-lite86 v0.2.6
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling pqcrypto-sphincsplus v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 17.44s
[INFO] running `"docker" "inspect" "e44af94d09944f4d7c1da1c0aee03530aba085c5a5823c996bfd24f4a7d415fe"`
[INFO] running `"docker" "rm" "-f" "e44af94d09944f4d7c1da1c0aee03530aba085c5a5823c996bfd24f4a7d415fe"`
[INFO] [stdout] e44af94d09944f4d7c1da1c0aee03530aba085c5a5823c996bfd24f4a7d415fe
[INFO] running `"docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "MAP_USER_ID=0" "-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" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+28742a1146f10a4f09369baad027a464acb7a766" "test" "--frozen"`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 6afd864f8241ef39a8cd8daf5440f18ba6853d66fe4dbde3c1fcd797245f7303
[INFO] running `"docker" "start" "-a" "6afd864f8241ef39a8cd8daf5440f18ba6853d66fe4dbde3c1fcd797245f7303"`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.22s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/pqcrypto_sphincsplus-3951c431395745f5
[INFO] [stdout] 
[INFO] [stdout] running 142 tests
[INFO] [stdout] test ffi::test_sphincsharaka128fsimple_aesni::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka128frobust_aesni::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka192frobust_aesni::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka192fsimple_aesni::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka128fsimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka128ssimple_aesni::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka192fsimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka128frobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka256frobust_aesni::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka192frobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka256fsimple_aesni::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka192ssimple_aesni::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka256fsimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka192srobust_aesni::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka128srobust_clean::test_ffi ... test ffi::test_sphincsharaka128srobust_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsharaka128ssimple_clean::test_ffi ... test ffi::test_sphincsharaka128ssimple_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsharaka256frobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka192srobust_clean::test_ffi ... test ffi::test_sphincsharaka192srobust_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsharaka256srobust_aesni::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka256ssimple_aesni::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka192ssimple_clean::test_ffi ... test ffi::test_sphincsharaka192ssimple_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincssha256128frobust_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256128frobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256128fsimple_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256128fsimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka256srobust_clean::test_ffi ... test ffi::test_sphincsharaka256srobust_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsharaka256ssimple_clean::test_ffi ... test ffi::test_sphincsharaka256ssimple_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsharaka128ssimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256128srobust_avx2::test_ffi ... test ffi::test_sphincssha256128srobust_avx2::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincssha256128srobust_clean::test_ffi ... test ffi::test_sphincssha256128srobust_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincssha256128srobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256128srobust_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256128ssimple_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256192frobust_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256192frobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256192fsimple_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256192fsimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256128ssimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka128srobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256192srobust_avx2::test_ffi ... test ffi::test_sphincssha256192srobust_avx2::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincssha256192srobust_clean::test_ffi ... test ffi::test_sphincssha256192srobust_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincssha256192ssimple_avx2::test_ffi ... test ffi::test_sphincssha256192ssimple_avx2::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincssha256192ssimple_clean::test_ffi ... test ffi::test_sphincssha256192ssimple_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsharaka256ssimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256192ssimple_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka192ssimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256192ssimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256256frobust_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256256frobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256256fsimple_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256256fsimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256192srobust_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256256srobust_avx2::test_ffi ... test ffi::test_sphincssha256256srobust_avx2::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincssha256256srobust_clean::test_ffi ... test ffi::test_sphincssha256256srobust_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincssha256256ssimple_avx2::test_ffi ... test ffi::test_sphincssha256256ssimple_avx2::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincssha256192srobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256128frobust_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256256ssimple_clean::test_ffi ... test ffi::test_sphincssha256256ssimple_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincssha256256ssimple_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256256ssimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256128fsimple_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256128fsimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256128frobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsharaka256srobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256192frobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256192fsimple_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256128srobust_avx2::test_ffi ... test ffi::test_sphincsshake256128srobust_avx2::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsshake256128srobust_clean::test_ffi ... test ffi::test_sphincsshake256128srobust_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsshake256192fsimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256128ssimple_avx2::test_ffi ... test ffi::test_sphincsshake256128ssimple_avx2::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsshake256128ssimple_clean::test_ffi ... test ffi::test_sphincsshake256128ssimple_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsshake256128ssimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256256srobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256128ssimple_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256192srobust_avx2::test_ffi ... test ffi::test_sphincsshake256192srobust_avx2::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsharaka192srobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256192srobust_clean::test_ffi ... test ffi::test_sphincsshake256192srobust_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsshake256192ssimple_avx2::test_ffi ... test ffi::test_sphincsshake256192ssimple_avx2::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsshake256128srobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256192ssimple_clean::test_ffi ... test ffi::test_sphincsshake256192ssimple_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsshake256256frobust_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincssha256256srobust_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256256fsimple_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256256frobust_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256256fsimple_clean::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256128srobust_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256256srobust_avx2::test_ffi ... test ffi::test_sphincsshake256256srobust_avx2::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsshake256256srobust_clean::test_ffi ... test ffi::test_sphincsshake256256srobust_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsshake256256ssimple_avx2::test_ffi ... test ffi::test_sphincsshake256256ssimple_avx2::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsshake256256ssimple_clean::test_ffi ... test ffi::test_sphincsshake256256ssimple_clean::test_ffi has been running for over 60 seconds
[INFO] [stdout] test ffi::test_sphincsshake256192ssimple_clean::test_ffi ... ok
[INFO] [stdout] test sphincsharaka128frobust::test::test_sign ... ok
[INFO] [stdout] test sphincsharaka128frobust::test::test_sign_detached ... ok
[INFO] [stdout] test sphincsharaka128fsimple::test::test_sign ... ok
[INFO] [stdout] test sphincsharaka128fsimple::test::test_sign_detached ... ok
[INFO] [stdout] test ffi::test_sphincsshake256192ssimple_avx2::test_ffi ... ok
[INFO] [stdout] test ffi::test_sphincsshake256256ssimple_clean::test_ffi ... ok
[INFO] [stdout] test sphincsharaka128srobust::test::test_sign ... test sphincsharaka128srobust::test::test_sign has been running for over 60 seconds
[INFO] [stdout] test sphincsharaka128ssimple::test::test_sign ... ok
[INFO] [stdout] test sphincsharaka128ssimple::test::test_sign_detached ... ok
[INFO] [stdout] test sphincsharaka192frobust::test::test_sign ... ok
[INFO] [stdout] test sphincsharaka192frobust::test::test_sign_detached ... ok
[INFO] [stdout] test sphincsharaka192fsimple::test::test_sign ... ok
[INFO] [stdout] test sphincsharaka192fsimple::test::test_sign_detached ... ok
[INFO] [stdout] test ffi::test_sphincsshake256256ssimple_avx2::test_ffi ... ok
[INFO] [stdout] test sphincsharaka192srobust::test::test_sign ... ok
[INFO] [stdout] test sphincsharaka192srobust::test::test_sign_detached ... ok
[INFO] [stdout] test sphincsharaka128srobust::test::test_sign_detached ... test sphincsharaka128srobust::test::test_sign_detached has been running for over 60 seconds
[INFO] [stdout] test sphincsharaka192ssimple::test::test_sign_detached ... ok
[INFO] [stdout] test sphincsharaka256frobust::test::test_sign ... ok
[INFO] [stdout] test sphincsharaka192ssimple::test::test_sign ... ok
[INFO] [stdout] test sphincsharaka256fsimple::test::test_sign ... ok
[INFO] [stdout] test sphincsharaka256frobust::test::test_sign_detached ... ok
[INFO] [stdout] test sphincsharaka256fsimple::test::test_sign_detached ... ok
[INFO] [stdout] test sphincsharaka128srobust::test::test_sign ... ok
[INFO] [stdout] test ffi::test_sphincsshake256192srobust_clean::test_ffi ... ok
[INFO] [stdout] test sphincsharaka256ssimple::test::test_sign ... ok
[INFO] [stdout] test sphincsharaka256srobust::test::test_sign ... ok
[INFO] [stdout] test sphincsharaka256srobust::test::test_sign_detached ... ok
[INFO] [stdout] test sphincssha256128frobust::test::test_sign ... ok
[INFO] [stdout] test sphincssha256128frobust::test::test_sign_detached ... ok
[INFO] [stdout] test sphincssha256128fsimple::test::test_sign ... ok
[INFO] [stdout] test sphincsharaka256ssimple::test::test_sign_detached ... ok
[INFO] [stdout] test sphincssha256128fsimple::test::test_sign_detached ... ok
[INFO] [stdout] test sphincssha256128ssimple::test::test_sign ... ok
[INFO] [stdout] test sphincssha256128ssimple::test::test_sign_detached ... ok
[ERROR] error running command: command timed out after 900 seconds
[INFO] running `"docker" "inspect" "6afd864f8241ef39a8cd8daf5440f18ba6853d66fe4dbde3c1fcd797245f7303"`
[INFO] running `"docker" "rm" "-f" "6afd864f8241ef39a8cd8daf5440f18ba6853d66fe4dbde3c1fcd797245f7303"`
[INFO] [stdout] 6afd864f8241ef39a8cd8daf5440f18ba6853d66fe4dbde3c1fcd797245f7303