[INFO] fetching crate ark-bw6-761 0.4.0... [INFO] testing ark-bw6-761-0.4.0 against master#d7bd9cd469ff6871420007f091ef52fc32d2ca99 for pr-121417 [INFO] extracting crate ark-bw6-761 0.4.0 into /workspace/builds/worker-0-tc1/source [INFO] validating manifest of crates.io crate ark-bw6-761 0.4.0 on toolchain d7bd9cd469ff6871420007f091ef52fc32d2ca99 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+d7bd9cd469ff6871420007f091ef52fc32d2ca99" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate ark-bw6-761 0.4.0 [INFO] finished tweaking crates.io crate ark-bw6-761 0.4.0 [INFO] tweaked toml for crates.io crate ark-bw6-761 0.4.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+d7bd9cd469ff6871420007f091ef52fc32d2ca99" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Updating crates.io index [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+d7bd9cd469ff6871420007f091ef52fc32d2ca99" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded ark-bls12-377 v0.4.0 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+d7bd9cd469ff6871420007f091ef52fc32d2ca99" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] b1dcea91f10f087518362dbf3e2713901e6e3c9a9c76b35b20966305ea0504de [INFO] running `Command { std: "docker" "start" "-a" "b1dcea91f10f087518362dbf3e2713901e6e3c9a9c76b35b20966305ea0504de", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "b1dcea91f10f087518362dbf3e2713901e6e3c9a9c76b35b20966305ea0504de", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b1dcea91f10f087518362dbf3e2713901e6e3c9a9c76b35b20966305ea0504de", kill_on_drop: false }` [INFO] [stdout] b1dcea91f10f087518362dbf3e2713901e6e3c9a9c76b35b20966305ea0504de [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+d7bd9cd469ff6871420007f091ef52fc32d2ca99" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 4e35252a9f523dc8f5149454e81d20a84ac471e068ba5627ea6daaeaff47303f [INFO] running `Command { std: "docker" "start" "-a" "4e35252a9f523dc8f5149454e81d20a84ac471e068ba5627ea6daaeaff47303f", kill_on_drop: false }` [INFO] [stderr] Compiling ppv-lite86 v0.2.17 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling zerocopy v0.7.32 [INFO] [stderr] Compiling once_cell v1.19.0 [INFO] [stderr] Compiling ahash v0.8.10 [INFO] [stderr] Compiling itertools v0.10.5 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling syn v2.0.52 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling hashbrown v0.13.2 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling ark-std v0.4.0 [INFO] [stderr] Compiling ark-serialize-derive v0.4.2 [INFO] [stderr] Compiling ark-ff-asm v0.4.2 [INFO] [stderr] Compiling ark-ff-macros v0.4.2 [INFO] [stderr] Compiling derivative v2.2.0 [INFO] [stderr] Compiling zeroize_derive v1.4.2 [INFO] [stderr] Compiling ark-serialize v0.4.2 [INFO] [stderr] Compiling zeroize v1.7.0 [INFO] [stderr] Compiling ark-ff v0.4.2 [INFO] [stderr] Compiling ark-poly v0.4.2 [INFO] [stderr] Compiling ark-ec v0.4.2 [INFO] [stderr] Compiling ark-bls12-377 v0.4.0 [INFO] [stderr] Compiling ark-bw6-761 v0.4.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 12.95s [INFO] running `Command { std: "docker" "inspect" "4e35252a9f523dc8f5149454e81d20a84ac471e068ba5627ea6daaeaff47303f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4e35252a9f523dc8f5149454e81d20a84ac471e068ba5627ea6daaeaff47303f", kill_on_drop: false }` [INFO] [stdout] 4e35252a9f523dc8f5149454e81d20a84ac471e068ba5627ea6daaeaff47303f [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+d7bd9cd469ff6871420007f091ef52fc32d2ca99" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 4de0e2eae7e8855340f3fdceed8e4183b488dd4455da22ec0284c0da32410d49 [INFO] running `Command { std: "docker" "start" "-a" "4de0e2eae7e8855340f3fdceed8e4183b488dd4455da22ec0284c0da32410d49", kill_on_drop: false }` [INFO] [stderr] Compiling num-traits v0.2.18 [INFO] [stderr] Compiling either v1.10.0 [INFO] [stderr] Compiling libc v0.2.153 [INFO] [stderr] Compiling half v2.4.0 [INFO] [stderr] Compiling plotters-backend v0.3.5 [INFO] [stderr] Compiling os_str_bytes v6.6.1 [INFO] [stderr] Compiling ciborium-io v0.2.2 [INFO] [stderr] Compiling serde_derive v1.0.197 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling regex-automata v0.4.5 [INFO] [stderr] Compiling textwrap v0.16.1 [INFO] [stderr] Compiling cast v0.3.0 [INFO] [stderr] Compiling walkdir v2.5.0 [INFO] [stderr] Compiling anes v0.1.6 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling sha2 v0.10.8 [INFO] [stderr] Compiling ciborium-ll v0.2.2 [INFO] [stderr] Compiling itertools v0.10.5 [INFO] [stderr] Compiling plotters-svg v0.3.5 [INFO] [stderr] Compiling rayon v1.9.0 [INFO] [stderr] Compiling clap_lex v0.2.4 [INFO] [stderr] Compiling clap v3.2.25 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling num-integer v0.1.46 [INFO] [stderr] Compiling num-bigint v0.4.4 [INFO] [stderr] Compiling ark-std v0.4.0 [INFO] [stderr] Compiling plotters v0.3.5 [INFO] [stderr] Compiling regex v1.10.3 [INFO] [stderr] Compiling criterion-plot v0.5.0 [INFO] [stderr] Compiling ark-ff-macros v0.4.2 [INFO] [stderr] Compiling serde v1.0.197 [INFO] [stderr] Compiling ark-serialize v0.4.2 [INFO] [stderr] Compiling ark-ff v0.4.2 [INFO] [stderr] Compiling serde_json v1.0.114 [INFO] [stderr] Compiling ciborium v0.2.2 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling criterion v0.4.0 [INFO] [stderr] Compiling ark-poly v0.4.2 [INFO] [stderr] Compiling ark-ec v0.4.2 [INFO] [stderr] Compiling ark-bls12-377 v0.4.0 [INFO] [stderr] Compiling ark-algebra-test-templates v0.4.2 [INFO] [stderr] Compiling ark-algebra-bench-templates v0.4.2 [INFO] [stderr] Compiling ark-bw6-761 v0.4.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 18.04s [INFO] running `Command { std: "docker" "inspect" "4de0e2eae7e8855340f3fdceed8e4183b488dd4455da22ec0284c0da32410d49", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4de0e2eae7e8855340f3fdceed8e4183b488dd4455da22ec0284c0da32410d49", kill_on_drop: false }` [INFO] [stdout] 4de0e2eae7e8855340f3fdceed8e4183b488dd4455da22ec0284c0da32410d49 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+d7bd9cd469ff6871420007f091ef52fc32d2ca99" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] eb4d4c2eb3abc600a8d4e0627ffae70ad98132692310c0dba8ff1256f6c11fbc [INFO] running `Command { std: "docker" "start" "-a" "eb4d4c2eb3abc600a8d4e0627ffae70ad98132692310c0dba8ff1256f6c11fbc", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.09s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ark_bw6_761-fc4566364be347ae) [INFO] [stdout] [INFO] [stdout] running 67 tests [INFO] [stdout] test curves::tests::g1::test_sw_properties ... ok [INFO] [stdout] test curves::tests::g1::test_add_properties has been running for over 60 seconds [INFO] [stdout] test curves::tests::g1::test_affine_conversion has been running for over 60 seconds [INFO] [stdout] test curves::tests::g1::test_chunked_pippenger has been running for over 60 seconds [INFO] [stdout] test curves::tests::g1::test_cofactor_ops has been running for over 60 seconds [INFO] [stdout] test curves::tests::g1::test_hashmap_pippenger has been running for over 60 seconds [INFO] [stdout] test curves::tests::g1::test_mixed_addition has been running for over 60 seconds [INFO] [stdout] test curves::tests::g1::test_mul_properties has been running for over 60 seconds [INFO] [stdout] test curves::tests::g1::test_serialization has been running for over 60 seconds [INFO] [stdout] test curves::tests::g1::test_sub_properties has been running for over 60 seconds [INFO] [stdout] test curves::tests::g1::test_var_base_msm has been running for over 60 seconds [INFO] [stdout] test curves::tests::g2::test_add_properties has been running for over 60 seconds [INFO] [stdout] test curves::tests::g2::test_affine_conversion has been running for over 60 seconds [INFO] [stdout] test curves::tests::g2::test_chunked_pippenger has been running for over 60 seconds [INFO] [stdout] test curves::tests::g2::test_cofactor_ops has been running for over 60 seconds [INFO] [stdout] test curves::tests::g2::test_hashmap_pippenger has been running for over 60 seconds [INFO] [stdout] test curves::tests::g2::test_mixed_addition has been running for over 60 seconds [INFO] [stdout] test curves::tests::g1::test_sub_properties ... ok [INFO] [stdout] test curves::tests::g2::test_mixed_addition ... ok [INFO] [stdout] test curves::tests::g1::test_mixed_addition ... ok [INFO] [stdout] test curves::tests::g2::test_hashmap_pippenger ... ok [INFO] [stdout] test curves::tests::g2::test_chunked_pippenger ... ok [INFO] [stdout] test curves::tests::g2::test_sw_properties ... ok [INFO] [stdout] test curves::tests::g1::test_hashmap_pippenger ... ok [INFO] [stdout] test curves::tests::g1::test_chunked_pippenger ... ok [INFO] [stdout] test curves::tests::g1::test_add_properties ... ok [INFO] [stdout] test curves::tests::g2::test_add_properties ... ok [INFO] [stdout] test curves::tests::g2::test_mul_properties has been running for over 60 seconds [INFO] [stdout] test curves::tests::g2::test_serialization has been running for over 60 seconds [INFO] [stdout] test curves::tests::g1::test_var_base_msm ... ok [INFO] [stdout] test curves::tests::g2::test_sub_properties has been running for over 60 seconds [INFO] [stdout] test curves::tests::g2::test_var_base_msm has been running for over 60 seconds [INFO] [stdout] test curves::tests::pairing::test_bilinearity has been running for over 60 seconds [INFO] [stdout] test curves::tests::pairing::test_multi_pairing has been running for over 60 seconds [INFO] [stdout] test curves::tests::pairing_output::test_chunked_pippenger has been running for over 60 seconds [INFO] [stdout] test curves::tests::g2::test_sub_properties ... ok [INFO] [stdout] test curves::tests::pairing_output::test_hashmap_pippenger has been running for over 60 seconds [INFO] [stdout] test curves::tests::pairing_output::test_var_base_msm has been running for over 60 seconds [INFO] [stdout] test fields::tests::fq3::test_add_properties has been running for over 60 seconds [INFO] [stdout] test fields::tests::fq3::test_frobenius has been running for over 60 seconds [INFO] [stdout] test curves::tests::pairing::test_multi_pairing ... ok [INFO] [stdout] test curves::tests::pairing::test_bilinearity ... ok [INFO] [stdout] test fields::tests::fq3::test_mul_properties ... ok [INFO] [stdout] test fields::tests::fq3::test_serialization ... ok [INFO] [stdout] test curves::tests::g1::test_serialization ... ok [INFO] [stdout] test curves::tests::g2::test_var_base_msm ... ok [INFO] [stdout] test curves::tests::g2::test_serialization ... ok [INFO] [stdout] test fields::tests::fq3::test_pow has been running for over 60 seconds [INFO] [stdout] test fields::tests::fq3::test_sqrt has been running for over 60 seconds [INFO] [stdout] test fields::tests::fq3::test_sub_properties has been running for over 60 seconds [INFO] [stdout] test fields::tests::fq3::test_sum_of_products_tests ... ok [INFO] [stdout] test fields::tests::fq3::test_pow ... ok [INFO] [stdout] test fields::tests::fq6::test_mul_properties ... ok [INFO] [stdout] test curves::tests::g2::test_cofactor_ops ... ok [INFO] [stdout] test fields::tests::fq6::test_serialization ... ok [INFO] [stdout] test fields::tests::fq6::test_sqrt ... ok [INFO] [stdout] test curves::tests::g1::test_cofactor_ops ... ok [INFO] [stdout] test fields::tests::fq6::test_add_properties has been running for over 60 seconds [INFO] [stdout] test fields::tests::fq6::test_frobenius has been running for over 60 seconds [INFO] [stdout] test curves::tests::g2::test_affine_conversion ... ok [INFO] [stdout] test fields::tests::fq6::test_pow has been running for over 60 seconds [INFO] [stdout] test fields::tests::fq6::test_sub_properties has been running for over 60 seconds [INFO] [stdout] test fields::tests::fq6::test_sum_of_products_tests has been running for over 60 seconds [INFO] [stdout] test fields::tests::fq3::test_frobenius ... ok [INFO] [stdout] test fields::tests::fq::test_constants ... ok [INFO] [stdout] test fields::tests::fq::test_fft ... ok [INFO] [stdout] test curves::tests::g1::test_affine_conversion ... ok [INFO] [stdout] test fields::tests::fq::test_montgomery_config ... ok [INFO] [stdout] test fields::tests::fq::test_mul_properties ... ok [INFO] [stdout] test fields::tests::fq::test_frobenius ... ok [INFO] [stdout] test fields::tests::fq::test_serialization ... ok [INFO] [stdout] test fields::tests::fq::test_pow ... ok [INFO] [stdout] test fields::tests::fq::test_add_properties has been running for over 60 seconds [INFO] [stdout] test fields::tests::fq6::test_sum_of_products_tests ... ok [INFO] [stdout] test fields::tests::fq::test_sum_of_products_edge_case ... ok [INFO] [stdout] test fields::tests::fq::test_sqrt ... ok [INFO] [stdout] test fields::tests::fq::test_sum_of_products_tests ... ok [INFO] [stdout] test fields::tests::fr::test_constants ... ok [INFO] [stdout] test fields::tests::fr::test_fft ... ok [INFO] [stdout] test fields::tests::fr::test_frobenius ... ok [INFO] [stdout] test fields::tests::fr::test_montgomery_config ... ok [INFO] [stdout] test fields::tests::fr::test_mul_properties ... ok [INFO] [stdout] test fields::tests::fr::test_pow ... ok [INFO] [stdout] test fields::tests::fr::test_serialization ... ok [INFO] [stdout] test fields::tests::fr::test_sqrt ... ok [INFO] [stdout] test fields::tests::fq::test_sub_properties has been running for over 60 seconds [INFO] [stdout] test fields::tests::fq3::test_sub_properties ... ok [INFO] [stdout] test fields::tests::fr::test_sum_of_products_edge_case ... ok [INFO] [stdout] test fields::tests::fr::test_sum_of_products_tests ... ok [INFO] [stdout] test fields::tests::fr::test_add_properties has been running for over 60 seconds [INFO] [stdout] test fields::tests::fr::test_sub_properties ... ok [INFO] [stdout] test fields::tests::fr::test_add_properties ... ok [INFO] [stdout] test fields::tests::fq::test_sub_properties ... ok [INFO] [stdout] test curves::tests::pairing_output::test_hashmap_pippenger ... ok [INFO] [stdout] test fields::tests::fq::test_add_properties ... ok [INFO] [stdout] test curves::tests::pairing_output::test_chunked_pippenger ... ok [INFO] [stdout] test fields::tests::fq3::test_add_properties ... ok [INFO] [stdout] test curves::tests::pairing_output::test_var_base_msm ... ok [INFO] [stdout] test fields::tests::fq6::test_pow ... ok [INFO] [stdout] test fields::tests::fq3::test_sqrt ... ok [INFO] [stdout] test curves::tests::g1::test_mul_properties ... ok [INFO] [stdout] test curves::tests::g2::test_mul_properties ... ok [INFO] [stdout] test fields::tests::fq6::test_sub_properties ... ok [INFO] [stdout] test fields::tests::fq6::test_add_properties ... ok [ERROR] error running command: command timed out after 900 seconds [INFO] running `Command { std: "docker" "inspect" "eb4d4c2eb3abc600a8d4e0627ffae70ad98132692310c0dba8ff1256f6c11fbc", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "eb4d4c2eb3abc600a8d4e0627ffae70ad98132692310c0dba8ff1256f6c11fbc", kill_on_drop: false }` [INFO] [stdout] eb4d4c2eb3abc600a8d4e0627ffae70ad98132692310c0dba8ff1256f6c11fbc