[INFO] fetching crate bellman 0.11.0... [INFO] testing bellman-0.11.0 against beta-2021-09-08 for beta-1.56-1 [INFO] extracting crate bellman 0.11.0 into /workspace/builds/worker-22/source [INFO] validating manifest of crates.io crate bellman 0.11.0 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] removed /workspace/builds/worker-22/source/rust-toolchain [INFO] started tweaking crates.io crate bellman 0.11.0 [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate bellman 0.11.0 [INFO] tweaked toml for crates.io crate bellman 0.11.0 written to /workspace/builds/worker-22/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-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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] 51b6b229a7de30790183da5ff631280a6b6572ade6b1466bec4a25b1c2ca4f58 [INFO] running `Command { std: "docker" "start" "-a" "51b6b229a7de30790183da5ff631280a6b6572ade6b1466bec4a25b1c2ca4f58", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "51b6b229a7de30790183da5ff631280a6b6572ade6b1466bec4a25b1c2ca4f58", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "51b6b229a7de30790183da5ff631280a6b6572ade6b1466bec4a25b1c2ca4f58", kill_on_drop: false }` [INFO] [stdout] 51b6b229a7de30790183da5ff631280a6b6572ade6b1466bec4a25b1c2ca4f58 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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] 8ffcab35c7ba3ccfaaa866ed7497dfac430ad63904c903e35a813e9ca4fb821f [INFO] running `Command { std: "docker" "start" "-a" "8ffcab35c7ba3ccfaaa866ed7497dfac430ad63904c903e35a813e9ca4fb821f", kill_on_drop: false }` [INFO] [stderr] Compiling crossbeam-utils v0.8.5 [INFO] [stderr] Compiling radium v0.6.2 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling crossbeam-epoch v0.9.5 [INFO] [stderr] Compiling tap v1.0.1 [INFO] [stderr] Compiling funty v1.2.0 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling rayon-core v1.9.1 [INFO] [stderr] Compiling subtle v2.4.1 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling arrayref v0.3.6 [INFO] [stderr] Compiling constant_time_eq v0.1.5 [INFO] [stderr] Compiling arrayvec v0.5.2 [INFO] [stderr] Compiling rayon v1.5.1 [INFO] [stderr] Compiling getrandom v0.2.3 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling wyz v0.4.0 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling blake2s_simd v0.5.11 [INFO] [stderr] Compiling bitvec v0.22.3 [INFO] [stderr] Compiling crossbeam-channel v0.5.1 [INFO] [stderr] Compiling ff v0.11.0 [INFO] [stderr] Compiling crossbeam-deque v0.8.1 [INFO] [stderr] Compiling group v0.11.0 [INFO] [stderr] Compiling pairing v0.21.0 [INFO] [stderr] Compiling bellman v0.11.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 44.81s [INFO] running `Command { std: "docker" "inspect" "8ffcab35c7ba3ccfaaa866ed7497dfac430ad63904c903e35a813e9ca4fb821f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8ffcab35c7ba3ccfaaa866ed7497dfac430ad63904c903e35a813e9ca4fb821f", kill_on_drop: false }` [INFO] [stdout] 8ffcab35c7ba3ccfaaa866ed7497dfac430ad63904c903e35a813e9ca4fb821f [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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] 01e4c671939cb3ed941a1bd0d7f09112837cd01bbf0c5fb598ae510516097dc0 [INFO] running `Command { std: "docker" "start" "-a" "01e4c671939cb3ed941a1bd0d7f09112837cd01bbf0c5fb598ae510516097dc0", 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] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling typenum v1.14.0 [INFO] [stderr] Compiling syn v1.0.76 [INFO] [stderr] Compiling itoa v0.4.8 [INFO] [stderr] Compiling unicode-width v0.1.8 [INFO] [stderr] Compiling plotters-backend v0.3.2 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling half v1.7.1 [INFO] [stderr] Compiling ppv-lite86 v0.2.10 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling oorandom v11.1.3 [INFO] [stderr] Compiling opaque-debug v0.3.0 [INFO] [stderr] Compiling cpufeatures v0.2.1 [INFO] [stderr] Compiling hex-literal v0.3.3 [INFO] [stderr] Compiling generic-array v0.14.4 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling cast v0.2.7 [INFO] [stderr] Compiling rand_xorshift v0.3.0 [INFO] [stderr] Compiling bls12_381 v0.6.0 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling walkdir v2.3.2 [INFO] [stderr] Compiling serde_json v1.0.67 [INFO] [stderr] Compiling serde_cbor v0.11.2 [INFO] [stderr] Compiling plotters-svg v0.3.1 [INFO] [stderr] Compiling clap v2.33.3 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling criterion-plot v0.4.4 [INFO] [stderr] Compiling rand v0.8.4 [INFO] [stderr] Compiling bstr v0.2.16 [INFO] [stderr] Compiling csv-core v0.1.10 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling plotters v0.3.1 [INFO] [stderr] Compiling csv v1.1.6 [INFO] [stderr] Compiling block-buffer v0.9.0 [INFO] [stderr] Compiling digest v0.9.0 [INFO] [stderr] Compiling sha2 v0.9.8 [INFO] [stderr] Compiling serde_derive v1.0.130 [INFO] [stderr] Compiling criterion v0.3.5 [INFO] [stderr] Compiling bellman v0.11.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 31.69s [INFO] running `Command { std: "docker" "inspect" "01e4c671939cb3ed941a1bd0d7f09112837cd01bbf0c5fb598ae510516097dc0", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "01e4c671939cb3ed941a1bd0d7f09112837cd01bbf0c5fb598ae510516097dc0", kill_on_drop: false }` [INFO] [stdout] 01e4c671939cb3ed941a1bd0d7f09112837cd01bbf0c5fb598ae510516097dc0 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-22/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] 591e29413e6d0fff07162ab755b447f8be1fb5d0f9d3b49234707e5eb17cc5f8 [INFO] running `Command { std: "docker" "start" "-a" "591e29413e6d0fff07162ab755b447f8be1fb5d0f9d3b49234707e5eb17cc5f8", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.25s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/bellman-f72a4f68c9c11b5b) [INFO] [stdout] [INFO] [stdout] running 53 tests [INFO] [stdout] test gadgets::boolean::test::test_and ... ok [INFO] [stdout] test gadgets::boolean::test::test_allocated_bit ... ok [INFO] [stdout] test gadgets::boolean::test::test_and_not ... ok [INFO] [stdout] test gadgets::boolean::test::test_boolean_and ... ok [INFO] [stdout] test gadgets::boolean::test::test_alloc_conditionally ... ok [INFO] [stdout] test gadgets::boolean::test::test_boolean_negation ... ok [INFO] [stdout] test gadgets::boolean::test::test_enforce_equal ... ok [INFO] [stdout] test gadgets::boolean::test::test_u64_into_boolean_vec_le ... ok [INFO] [stdout] test gadgets::boolean::test::test_boolean_xor ... ok [INFO] [stdout] test gadgets::boolean::test::test_boolean_sha256_maj ... ok [INFO] [stdout] test gadgets::boolean::test::test_nor ... ok [INFO] [stdout] test gadgets::boolean::test::test_xor ... ok [INFO] [stdout] test gadgets::boolean::test::test_boolean_sha256_ch ... ok [INFO] [stdout] test gadgets::num::test::test_allocated_num ... ok [INFO] [stdout] test gadgets::lookup::test::test_synth ... ok [INFO] [stdout] test gadgets::lookup::test::test_lookup3_xy ... ok [INFO] [stdout] test gadgets::lookup::test::test_lookup3_xy_with_conditional_negation ... ok [INFO] [stdout] test gadgets::num::test::test_num_conditional_reversal ... ok [INFO] [stdout] test gadgets::boolean::test::test_field_into_allocated_bits_le ... ok [INFO] [stdout] test gadgets::num::test::test_num_multiplication ... ok [INFO] [stdout] test gadgets::num::test::test_num_nonzero ... ok [INFO] [stdout] test gadgets::uint32::test::test_uint32_rotr ... ok [INFO] [stdout] test gadgets::num::test::test_num_squaring ... ok [INFO] [stdout] test gadgets::uint32::test::test_uint32_from_bits_be ... ok [INFO] [stdout] test gadgets::uint32::test::test_uint32_from_bits ... ok [INFO] [stdout] test gadgets::test::test_cs ... ok [INFO] [stdout] test multicore::implementation::test_log2_floor ... ok [INFO] [stdout] test gadgets::uint32::test::test_uint32_shr ... ok [INFO] [stdout] test gadgets::uint32::test::test_uint32_addmany_constants ... ok [INFO] [stdout] test gadgets::num::test::test_into_bits_strict ... ok [INFO] [stdout] test domain::parallel_fft_consistency ... ok [INFO] [stdout] test groth16::tests::test_xordemo ... ok [INFO] [stdout] test gadgets::blake2s::test::test_blake2s_constant_constraints ... ok [INFO] [stdout] test gadgets::sha256::test::test_blank_hash ... ok [INFO] [stdout] test gadgets::blake2s::test::test_blank_hash ... ok [INFO] [stdout] test domain::fft_composition ... ok [INFO] [stdout] test gadgets::uint32::test::test_uint32_sha256_maj ... ok [INFO] [stdout] test gadgets::uint32::test::test_uint32_sha256_ch ... ok [INFO] [stdout] test gadgets::uint32::test::test_uint32_addmany ... ok [INFO] [stdout] test gadgets::uint32::test::test_uint32_xor ... ok [INFO] [stdout] test gadgets::blake2s::test::test_blake2s_constraints ... ok [INFO] [stdout] test gadgets::blake2s::test::test_blake2s_precomp_constraints ... ok [INFO] [stdout] test gadgets::sha256::test::test_full_block ... ok [INFO] [stdout] test domain::polynomial_arith has been running for over 60 seconds [INFO] [stdout] test gadgets::blake2s::test::test_blake2s has been running for over 60 seconds [INFO] [stdout] test gadgets::blake2s::test::test_blake2s_256_vars has been running for over 60 seconds [INFO] [stdout] test gadgets::blake2s::test::test_blake2s_700_vars has been running for over 60 seconds [INFO] [stdout] test gadgets::blake2s::test::test_blake2s_test_vectors has been running for over 60 seconds [INFO] [stdout] test gadgets::multipack::test_multipacking has been running for over 60 seconds [INFO] [stdout] test gadgets::num::test::test_into_bits has been running for over 60 seconds [INFO] [stdout] test gadgets::sha256::test::test_against_vectors has been running for over 60 seconds [INFO] [stdout] test groth16::test_with_bls12_381::serialization has been running for over 60 seconds [INFO] [stdout] test multiexp::test_with_bls12 has been running for over 60 seconds [INFO] [stdout] test gadgets::blake2s::test::test_blake2s_256_vars ... ok [INFO] [stdout] test gadgets::multipack::test_multipacking ... ok [INFO] [stdout] test gadgets::blake2s::test::test_blake2s_700_vars ... ok [INFO] [stdout] test groth16::test_with_bls12_381::serialization ... ok [INFO] [stdout] test gadgets::blake2s::test::test_blake2s_test_vectors ... ok [INFO] [stdout] test gadgets::num::test::test_into_bits ... ok [INFO] [stdout] test gadgets::blake2s::test::test_blake2s ... ok [INFO] [stdout] test multiexp::test_with_bls12 ... ok [INFO] [stdout] test gadgets::sha256::test::test_against_vectors ... ok [ERROR] error running command: no output for 300 seconds [INFO] running `Command { std: "docker" "inspect" "591e29413e6d0fff07162ab755b447f8be1fb5d0f9d3b49234707e5eb17cc5f8", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "591e29413e6d0fff07162ab755b447f8be1fb5d0f9d3b49234707e5eb17cc5f8", kill_on_drop: false }` [INFO] [stdout] 591e29413e6d0fff07162ab755b447f8be1fb5d0f9d3b49234707e5eb17cc5f8