Dec 06 23:54:11.646 INFO testing sapling-crypto-0.0.1 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 06 23:54:11.646 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 06 23:54:11.896 INFO [stdout] bd2cca539d1a7705e4f0e755344a9dbed5a3c780729574c64c67cc281b69d927
Dec 06 23:54:11.897 INFO running `"docker" "start" "-a" "bd2cca539d1a7705e4f0e755344a9dbed5a3c780729574c64c67cc281b69d927"`
Dec 06 23:54:12.460 INFO [stderr] usermod: no changes
Dec 06 23:54:12.528 INFO [stderr]    Compiling pairing v0.13.2
Dec 06 23:54:12.528 INFO [stderr]    Compiling blake2 v0.7.1
Dec 06 23:54:17.053 INFO [stderr]    Compiling bellman v0.0.6
Dec 06 23:54:18.142 INFO [stderr]    Compiling sapling-crypto v0.0.1 (/source)
Dec 06 23:54:20.692 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.21s
Dec 06 23:54:20.696 INFO [stderr] su: No module specific data is present
Dec 06 23:54:20.989 INFO running `"docker" "inspect" "bd2cca539d1a7705e4f0e755344a9dbed5a3c780729574c64c67cc281b69d927"`
Dec 06 23:54:21.126 INFO running `"docker" "rm" "-f" "bd2cca539d1a7705e4f0e755344a9dbed5a3c780729574c64c67cc281b69d927"`
Dec 06 23:54:21.267 INFO [stdout] bd2cca539d1a7705e4f0e755344a9dbed5a3c780729574c64c67cc281b69d927
Dec 06 23:54:21.272 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 06 23:54:21.550 INFO [stdout] e6f1b31d0e399b80b4c2c0aa3d3a8ca1b8042ee81f269684f203043fabce0655
Dec 06 23:54:21.552 INFO running `"docker" "start" "-a" "e6f1b31d0e399b80b4c2c0aa3d3a8ca1b8042ee81f269684f203043fabce0655"`
Dec 06 23:54:22.024 INFO [stderr] usermod: no changes
Dec 06 23:54:22.092 INFO [stderr]    Compiling sapling-crypto v0.0.1 (/source)
Dec 06 23:54:27.458 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.40s
Dec 06 23:54:27.463 INFO [stderr] su: No module specific data is present
Dec 06 23:54:28.127 INFO running `"docker" "inspect" "e6f1b31d0e399b80b4c2c0aa3d3a8ca1b8042ee81f269684f203043fabce0655"`
Dec 06 23:54:28.398 INFO running `"docker" "rm" "-f" "e6f1b31d0e399b80b4c2c0aa3d3a8ca1b8042ee81f269684f203043fabce0655"`
Dec 06 23:54:28.608 INFO [stdout] e6f1b31d0e399b80b4c2c0aa3d3a8ca1b8042ee81f269684f203043fabce0655
Dec 06 23:54:28.643 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 06 23:54:29.092 INFO [stdout] 2f21a9dbcba0900231e4a6150132f482f4579c154b40794fa15cdd56328a55ae
Dec 06 23:54:29.100 INFO running `"docker" "start" "-a" "2f21a9dbcba0900231e4a6150132f482f4579c154b40794fa15cdd56328a55ae"`
Dec 06 23:54:30.527 INFO [stderr] usermod: no changes
Dec 06 23:54:30.688 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Dec 06 23:54:30.704 INFO [stderr]      Running /target/debug/deps/sapling_crypto-4baa13506b730dc2
Dec 06 23:54:30.704 INFO [stdout] 
Dec 06 23:54:30.704 INFO [stdout] running 55 tests
Dec 06 23:54:30.704 INFO [stdout] test circuit::test::test_cs ... ok
Dec 06 23:54:30.704 INFO [stdout] test circuit::boolean::test::test_allocated_bit ... ok
Dec 06 23:54:30.737 INFO [stdout] test circuit::boolean::test::test_boolean_negation ... ok
Dec 06 23:54:30.737 INFO [stdout] test circuit::boolean::test::test_boolean_xor ... ok
Dec 06 23:54:30.744 INFO [stdout] test circuit::boolean::test::test_and ... ok
Dec 06 23:54:30.756 INFO [stdout] test circuit::uint32::test::test_uint32_rotr ... ok
Dec 06 23:54:30.773 INFO [stdout] test circuit::boolean::test::test_xor ... ok
Dec 06 23:54:30.988 INFO [stdout] test circuit::uint32::test::test_uint32_from_bits ... ok
Dec 06 23:54:33.055 INFO [stdout] test jubjub::edwards::test::test_identities ... ok
Dec 06 23:54:35.460 INFO [stdout] test jubjub::edwards::test::test_back_and_forth ... ok
Dec 06 23:54:37.637 INFO [stdout] test jubjub::edwards::test::test_order ... ok
Dec 06 23:54:37.879 INFO [stdout] test circuit::blake2s::test::test_blake2s_constraints ... ok
Dec 06 23:54:37.900 INFO [stdout] test jubjub::fs::test_fr_repr_add_nocarry ... ok
Dec 06 23:54:38.304 INFO [stdout] test jubjub::edwards::test::test_rand ... ok
Dec 06 23:54:38.316 INFO [stdout] test jubjub::fs::test_fs_add_assign ... ok
Dec 06 23:54:38.330 INFO [stdout] test jubjub::fs::test_fs_display ... ok
Dec 06 23:54:38.332 INFO [stdout] test jubjub::fs::test_fs_double ... ok
Dec 06 23:54:38.385 INFO [stdout] test jubjub::fs::test_fs_from_into_repr ... ok
Dec 06 23:54:39.204 INFO [stdout] test jubjub::fs::test_fs_inverse ... ok
Dec 06 23:54:39.204 INFO [stdout] test jubjub::fs::test_fs_is_valid ... ok
Dec 06 23:54:39.216 INFO [stdout] test jubjub::fs::test_fs_legendre ... ok
Dec 06 23:54:47.300 INFO [stdout] test circuit::uint32::test::test_uint32_xor ... ok
Dec 06 23:54:47.304 INFO [stdout] test jubjub::fs::test_fs_negate ... ok
Dec 06 23:54:47.324 INFO [stdout] test jubjub::fs::test_fs_num_bits ... ok
Dec 06 23:54:50.068 INFO [stdout] test jubjub::fs::test_fr_squaring ... ok
Dec 06 23:54:50.068 INFO [stdout] test jubjub::fs::test_fs_repr_display ... ok
Dec 06 23:54:50.068 INFO [stdout] test jubjub::fs::test_fs_repr_div2 ... ok
Dec 06 23:54:50.068 INFO [stdout] test jubjub::fs::test_fs_repr_divn ... ok
Dec 06 23:54:50.068 INFO [stdout] test jubjub::fs::test_fs_repr_from ... ok
Dec 06 23:54:50.068 INFO [stdout] test jubjub::fs::test_fs_repr_is_odd ... ok
Dec 06 23:54:50.068 INFO [stdout] test jubjub::fs::test_fs_repr_is_zero ... ok
Dec 06 23:54:50.068 INFO [stdout] test jubjub::fs::test_fs_repr_mul2 ... ok
Dec 06 23:54:50.068 INFO [stdout] test jubjub::fs::test_fs_repr_num_bits ... ok
Dec 06 23:54:50.068 INFO [stdout] test jubjub::fs::test_fs_repr_ordering ... ok
Dec 06 23:54:50.092 INFO [stdout] test jubjub::fs::test_fs_repr_sub_noborrow ... ok
Dec 06 23:54:50.094 INFO [stdout] test jubjub::fs::test_fs_root_of_unity ... ok
Dec 06 23:54:52.572 INFO [stdout] test jubjub::fs::test_fs_pow ... ok
Dec 06 23:54:52.584 INFO [stdout] test jubjub::fs::test_fs_sub_assign ... ok
Dec 06 23:54:52.592 INFO [stdout] test jubjub::fs::test_neg_one ... ok
Dec 06 23:54:53.372 INFO [stdout] test circuit::uint32::test::test_uint32_addmany ... ok
Dec 06 23:54:54.225 INFO [stdout] test jubjub::fs::test_fs_sqrt ... ok
Dec 06 23:54:54.308 INFO [stdout] test jubjub::montgomery::test::test_awkward_points ... ok
Dec 06 23:54:59.072 INFO [stdout] test jubjub::montgomery::test::test_back_and_forth ... ok
Dec 06 23:55:00.704 INFO [stdout] test jubjub::montgomery::test::test_identities ... ok
Dec 06 23:55:02.788 INFO [stdout] test jubjub::edwards::test::test_mul_associativity ... ok
Dec 06 23:55:05.912 INFO [stdout] test jubjub::edwards::test::test_associativity ... ok
Dec 06 23:55:07.304 INFO [stdout] test jubjub::montgomery::test::test_rand ... ok
Dec 06 23:55:07.331 INFO [stdout] test jubjub::test::test_params ... ok
Dec 06 23:55:30.712 INFO [stdout] test circuit::blake2s::test::test_blake2s ... test circuit::blake2s::test::test_blake2s has been running for over 60 seconds
Dec 06 23:55:31.000 INFO [stdout] test jubjub::edwards::test::test_montgomery_conversion ... test jubjub::edwards::test::test_montgomery_conversion has been running for over 60 seconds
Dec 06 23:55:39.220 INFO [stdout] test jubjub::fs::test_fs_mul_assign ... test jubjub::fs::test_fs_mul_assign has been running for over 60 seconds
Dec 06 23:55:42.180 INFO [stdout] test jubjub::montgomery::test::test_associativity ... ok
Dec 06 23:55:54.324 INFO [stdout] test jubjub::montgomery::test::test_edwards_conversion ... test jubjub::montgomery::test::test_edwards_conversion has been running for over 60 seconds
Dec 06 23:56:00.696 INFO [stdout] test jubjub::montgomery::test::test_mul_associativity ... test jubjub::montgomery::test::test_mul_associativity has been running for over 60 seconds
Dec 06 23:56:01.526 INFO [stdout] test jubjub::fs::test_fs_mul_assign ... ok
Dec 06 23:56:02.788 INFO [stdout] test jubjub::montgomery::test::test_order ... test jubjub::montgomery::test::test_order has been running for over 60 seconds
Dec 06 23:56:27.096 INFO [stdout] test jubjub::montgomery::test::test_edwards_conversion ... ok
Dec 06 23:56:27.620 INFO [stdout] test jubjub::montgomery::test::test_order ... ok
Dec 06 23:57:06.844 INFO [stdout] test jubjub::edwards::test::test_montgomery_conversion ... ok
Dec 06 23:59:56.196 INFO [stdout] test circuit::blake2s::test::test_blake2s ... ok
Dec 07 00:00:50.548 INFO [stdout] test jubjub::montgomery::test::test_mul_associativity ... ok
Dec 07 00:00:50.548 INFO [stdout] 
Dec 07 00:00:50.552 INFO [stdout] test result: ok. 55 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 00:00:50.552 INFO [stdout] 
Dec 07 00:00:50.556 INFO [stderr]    Doc-tests sapling-crypto
Dec 07 00:00:53.220 INFO [stdout] 
Dec 07 00:00:53.220 INFO [stdout] running 0 tests
Dec 07 00:00:53.220 INFO [stdout] 
Dec 07 00:00:53.220 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 00:00:53.220 INFO [stdout] 
Dec 07 00:00:53.225 INFO [stderr] su: No module specific data is present
Dec 07 00:00:53.975 INFO running `"docker" "inspect" "2f21a9dbcba0900231e4a6150132f482f4579c154b40794fa15cdd56328a55ae"`
Dec 07 00:00:54.318 INFO running `"docker" "rm" "-f" "2f21a9dbcba0900231e4a6150132f482f4579c154b40794fa15cdd56328a55ae"`
Dec 07 00:00:54.712 INFO [stdout] 2f21a9dbcba0900231e4a6150132f482f4579c154b40794fa15cdd56328a55ae