Dec 15 09:36:02.086 INFO testing gridiron-0.3.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 09:36:02.086 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 09:36:03.065 INFO [stdout] 7a5642e65f7576bf7697c5068bcd9b3a181eba4d1a5e2dc0e96098e5dd6d6813
Dec 15 09:36:03.067 INFO running `"docker" "start" "-a" "7a5642e65f7576bf7697c5068bcd9b3a181eba4d1a5e2dc0e96098e5dd6d6813"`
Dec 15 09:36:04.799 INFO [stderr] usermod: no changes
Dec 15 09:36:04.999 INFO [stderr]    Compiling gridiron v0.3.0 (/source)
Dec 15 09:36:07.039 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.22s
Dec 15 09:36:07.068 INFO [stderr] su: No module specific data is present
Dec 15 09:36:08.048 INFO running `"docker" "inspect" "7a5642e65f7576bf7697c5068bcd9b3a181eba4d1a5e2dc0e96098e5dd6d6813"`
Dec 15 09:36:08.331 INFO running `"docker" "rm" "-f" "7a5642e65f7576bf7697c5068bcd9b3a181eba4d1a5e2dc0e96098e5dd6d6813"`
Dec 15 09:36:08.631 INFO [stdout] 7a5642e65f7576bf7697c5068bcd9b3a181eba4d1a5e2dc0e96098e5dd6d6813
Dec 15 09:36:08.639 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 09:36:09.133 INFO [stdout] 84ce64a218a8c38b4541e95076219d25e4c3affac9b89b7754425748e3297039
Dec 15 09:36:09.135 INFO running `"docker" "start" "-a" "84ce64a218a8c38b4541e95076219d25e4c3affac9b89b7754425748e3297039"`
Dec 15 09:36:11.106 INFO [stderr] usermod: no changes
Dec 15 09:36:11.319 INFO [stderr]    Compiling proptest v0.8.7
Dec 15 09:36:28.641 INFO [stderr]    Compiling gridiron v0.3.0 (/source)
Dec 15 09:37:42.561 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 31s
Dec 15 09:37:42.575 INFO [stderr] su: No module specific data is present
Dec 15 09:37:43.236 INFO running `"docker" "inspect" "84ce64a218a8c38b4541e95076219d25e4c3affac9b89b7754425748e3297039"`
Dec 15 09:37:43.449 INFO running `"docker" "rm" "-f" "84ce64a218a8c38b4541e95076219d25e4c3affac9b89b7754425748e3297039"`
Dec 15 09:37:43.709 INFO [stdout] 84ce64a218a8c38b4541e95076219d25e4c3affac9b89b7754425748e3297039
Dec 15 09:37:43.719 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 09:37:44.079 INFO [stdout] 3f86cc0d622f734d0df682bacd56c78783f0b14fc8dab79efc683772d632bb36
Dec 15 09:37:44.085 INFO running `"docker" "start" "-a" "3f86cc0d622f734d0df682bacd56c78783f0b14fc8dab79efc683772d632bb36"`
Dec 15 09:37:45.125 INFO [stderr] usermod: no changes
Dec 15 09:37:45.327 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.17s
Dec 15 09:37:45.346 INFO [stderr]      Running /target/debug/deps/gridiron-60d9b6cea607c6a7
Dec 15 09:37:45.357 INFO [stdout] 
Dec 15 09:37:45.357 INFO [stdout] running 72 tests
Dec 15 09:37:45.357 INFO [stdout] test digits::constant_time_primitives::tests::const_ge ... ok
Dec 15 09:37:45.363 INFO [stdout] test digits::constant_time_primitives::tests::const_le ... ok
Dec 15 09:37:45.363 INFO [stdout] test digits::constant_time_primitives::tests::const_gt ... ok
Dec 15 09:37:45.383 INFO [stdout] test digits::constant_time_primitives::tests::const_lt ... ok
Dec 15 09:37:45.383 INFO [stdout] test digits::constant_time_primitives::tests::const_not ... ok
Dec 15 09:37:45.383 INFO [stdout] test digits::constant_time_primitives::tests::const_eq ... ok
Dec 15 09:37:45.383 INFO [stdout] test fp_256::tests::associative ... ok
Dec 15 09:37:45.383 INFO [stdout] test fp_256::tests::add_equals_mult ... ok
Dec 15 09:37:45.383 INFO [stdout] test fp_256::tests::default_is_zero ... ok
Dec 15 09:37:45.395 INFO [stdout] test fp_256::tests::commutative ... ok
Dec 15 09:37:45.395 INFO [stdout] test fp_256::tests::from_u32 ... ok
Dec 15 09:37:45.427 INFO [stdout] test fp_256::tests::from_bytes_roundtrip ... ok
Dec 15 09:37:45.435 INFO [stdout] test fp_256::tests::div_zero_by_anything_should_be_zero ... ok
Dec 15 09:37:45.443 INFO [stdout] test fp_256::tests::identity ... ok
Dec 15 09:37:45.443 INFO [stdout] test fp_256::tests::monty_add_assign_works ... ok
Dec 15 09:37:45.447 INFO [stdout] test fp_256::tests::monty_add_works ... ok
Dec 15 09:37:45.455 INFO [stdout] test fp_256::tests::distributive ... ok
Dec 15 09:37:45.455 INFO [stdout] test fp_256::tests::monty_neg_works ... ok
Dec 15 09:37:45.457 INFO [stdout] test fp_256::tests::monty_inv_same_as_div ... ok
Dec 15 09:37:45.470 INFO [stdout] test fp_256::tests::monty_times_normal_equals_normal ... ok
Dec 15 09:37:45.487 INFO [stdout] test fp_256::tests::monty_mult_equals_normal ... ok
Dec 15 09:37:45.487 INFO [stdout] test fp_256::tests::monty_sub_works ... ok
Dec 15 09:37:45.487 INFO [stdout] test fp_256::tests::neg ... ok
Dec 15 09:37:45.491 INFO [stdout] test fp_256::tests::to_monty_roundtrip_to_norm ... ok
Dec 15 09:37:45.493 INFO [stdout] test fp_256::tests::mul_equals_div_numerator_can_be_zero ... ok
Dec 15 09:37:45.500 INFO [stdout] test fp_256::tests::mul_equals_div ... ok
Dec 15 09:37:45.500 INFO [stdout] test fp_256::tests::normal_times_monty_equals_normal ... ok
Dec 15 09:37:45.507 INFO [stdout] test fp_256::tests::pow_equals_mult ... ok
Dec 15 09:37:45.507 INFO [stdout] test fp_256::tests::monty_sub_assign_works ... ok
Dec 15 09:37:45.507 INFO [stdout] test fp_256::tests::zero ... ok
Dec 15 09:37:45.507 INFO [stdout] test fp_480::tests::default_is_zero ... ok
Dec 15 09:37:45.507 INFO [stdout] test fp_480::tests::commutative ... ok
Dec 15 09:37:45.507 INFO [stdout] test fp_480::tests::from_u32 ... ok
Dec 15 09:37:45.526 INFO [stdout] test fp_480::tests::add_equals_mult ... ok
Dec 15 09:37:45.538 INFO [stdout] test fp_480::tests::identity ... ok
Dec 15 09:37:45.562 INFO [stdout] test fp_480::tests::from_bytes_roundtrip ... ok
Dec 15 09:37:45.566 INFO [stdout] test fp_480::tests::div_zero_by_anything_should_be_zero ... ok
Dec 15 09:37:45.571 INFO [stdout] test fp_480::tests::associative ... ok
Dec 15 09:37:45.599 INFO [stdout] test fp_480::tests::monty_inv_same_as_div ... ok
Dec 15 09:37:45.599 INFO [stdout] test fp_480::tests::monty_add_works ... ok
Dec 15 09:37:45.611 INFO [stdout] test fp_480::tests::monty_mult_equals_normal ... ok
Dec 15 09:37:45.617 INFO [stdout] test fp_480::tests::monty_add_assign_works ... ok
Dec 15 09:37:45.623 INFO [stdout] test fp_480::tests::monty_neg_works ... ok
Dec 15 09:37:45.623 INFO [stdout] test fp_480::tests::distributive ... ok
Dec 15 09:37:45.639 INFO [stdout] test fp_480::tests::monty_times_normal_equals_normal ... ok
Dec 15 09:37:45.655 INFO [stdout] test fp_480::tests::monty_sub_works ... ok
Dec 15 09:37:45.667 INFO [stdout] test fp_480::tests::neg ... ok
Dec 15 09:37:45.671 INFO [stdout] test fp_480::tests::monty_sub_assign_works ... ok
Dec 15 09:37:45.686 INFO [stdout] test fp_480::tests::pow_equals_mult ... ok
Dec 15 09:37:45.686 INFO [stdout] test fp_480::tests::normal_times_monty_equals_normal ... ok
Dec 15 09:37:45.687 INFO [stdout] test fp_480::tests::zero ... ok
Dec 15 09:37:45.687 INFO [stdout] test lib::debug_hex_output_test256 ... ok
Dec 15 09:37:45.687 INFO [stdout] test lib::barrett_reduction ... ok
Dec 15 09:37:45.687 INFO [stdout] test lib::fp_256_31_normalize_prime_minus_1 ... ok
Dec 15 09:37:45.687 INFO [stdout] test lib::fp256_to_bytes_known_good_value ... ok
Dec 15 09:37:45.687 INFO [stdout] test lib::fp_256_31_normalize_prime_plus_1 ... ok
Dec 15 09:37:45.687 INFO [stdout] test lib::fp256_from_bytes_should_mod ... ok
Dec 15 09:37:45.687 INFO [stdout] test lib::mont_mult1 ... ok
Dec 15 09:37:45.687 INFO [stdout] test lib::mont_mult2 ... ok
Dec 15 09:37:45.687 INFO [stdout] test lib::mul_precalc ... ok
Dec 15 09:37:45.689 INFO [stdout] test lib::neg_test256 ... ok
Dec 15 09:37:45.689 INFO [stdout] test lib::static_add_31_bit ... ok
Dec 15 09:37:45.689 INFO [stdout] test lib::static_co_reduce_256_bit ... ok
Dec 15 09:37:45.689 INFO [stdout] test lib::test_from_sha_static ... ok
Dec 15 09:37:45.693 INFO [stdout] test lib::hex_dec_print ... ok
Dec 15 09:37:45.693 INFO [stdout] test lib::static_div_31_bit ... ok
Dec 15 09:37:45.693 INFO [stdout] test lib::zero1 ... ok
Dec 15 09:37:45.693 INFO [stdout] test fp_480::tests::to_monty_roundtrip_to_norm ... ok
Dec 15 09:37:45.711 INFO [stdout] test fp_480::tests::mul_equals_div_numerator_can_be_zero ... ok
Dec 15 09:37:45.715 INFO [stdout] test fp_480::tests::mul_equals_div ... ok
Dec 15 09:37:45.776 INFO [stdout] test fp_480::tests::div_by_zero_should_panic ... ok
Dec 15 09:37:45.783 INFO [stdout] test fp_256::tests::div_by_zero_should_panic ... ok
Dec 15 09:37:45.783 INFO [stdout] 
Dec 15 09:37:45.783 INFO [stdout] test result: ok. 72 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:37:45.783 INFO [stdout] 
Dec 15 09:37:45.791 INFO [stderr]    Doc-tests gridiron
Dec 15 09:37:46.939 INFO [stdout] 
Dec 15 09:37:46.939 INFO [stdout] running 0 tests
Dec 15 09:37:46.939 INFO [stdout] 
Dec 15 09:37:46.939 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:37:46.939 INFO [stdout] 
Dec 15 09:37:46.949 INFO [stderr] su: No module specific data is present
Dec 15 09:37:47.871 INFO running `"docker" "inspect" "3f86cc0d622f734d0df682bacd56c78783f0b14fc8dab79efc683772d632bb36"`
Dec 15 09:37:48.142 INFO running `"docker" "rm" "-f" "3f86cc0d622f734d0df682bacd56c78783f0b14fc8dab79efc683772d632bb36"`
Dec 15 09:37:48.445 INFO [stdout] 3f86cc0d622f734d0df682bacd56c78783f0b14fc8dab79efc683772d632bb36