Dec 15 09:36:18.932 INFO testing gridiron-0.3.0 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 09:36:18.932 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:19.339 INFO [stdout] fc0babd755ab2771f48ad3acc49746948d27ba7a315fdb0b4c0f5cf7a65385ff
Dec 15 09:36:19.343 INFO running `"docker" "start" "-a" "fc0babd755ab2771f48ad3acc49746948d27ba7a315fdb0b4c0f5cf7a65385ff"`
Dec 15 09:36:20.779 INFO [stderr] usermod: no changes
Dec 15 09:36:20.999 INFO [stderr]    Compiling gridiron v0.3.0 (/source)
Dec 15 09:36:23.360 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.53s
Dec 15 09:36:23.369 INFO [stderr] su: No module specific data is present
Dec 15 09:36:24.302 INFO running `"docker" "inspect" "fc0babd755ab2771f48ad3acc49746948d27ba7a315fdb0b4c0f5cf7a65385ff"`
Dec 15 09:36:24.717 INFO running `"docker" "rm" "-f" "fc0babd755ab2771f48ad3acc49746948d27ba7a315fdb0b4c0f5cf7a65385ff"`
Dec 15 09:36:25.063 INFO [stdout] fc0babd755ab2771f48ad3acc49746948d27ba7a315fdb0b4c0f5cf7a65385ff
Dec 15 09:36:25.075 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:25.607 INFO [stdout] e1bf6488a879d5a88d99a4ddfa8c2031d6b57bcaf0e5608adb320a1493ca010d
Dec 15 09:36:25.607 INFO running `"docker" "start" "-a" "e1bf6488a879d5a88d99a4ddfa8c2031d6b57bcaf0e5608adb320a1493ca010d"`
Dec 15 09:36:26.714 INFO [stderr] usermod: no changes
Dec 15 09:36:27.143 INFO [stderr]    Compiling proptest v0.8.7
Dec 15 09:36:44.416 INFO [stderr]    Compiling gridiron v0.3.0 (/source)
Dec 15 09:37:52.205 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 25s
Dec 15 09:37:52.217 INFO [stderr] su: No module specific data is present
Dec 15 09:37:52.585 INFO running `"docker" "inspect" "e1bf6488a879d5a88d99a4ddfa8c2031d6b57bcaf0e5608adb320a1493ca010d"`
Dec 15 09:37:52.689 INFO running `"docker" "rm" "-f" "e1bf6488a879d5a88d99a4ddfa8c2031d6b57bcaf0e5608adb320a1493ca010d"`
Dec 15 09:37:52.794 INFO [stdout] e1bf6488a879d5a88d99a4ddfa8c2031d6b57bcaf0e5608adb320a1493ca010d
Dec 15 09:37:52.796 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:53.071 INFO [stdout] d1418a10d376c7765f199ceee6ca1519cda16e50d17e858541fce3bb39712836
Dec 15 09:37:53.075 INFO running `"docker" "start" "-a" "d1418a10d376c7765f199ceee6ca1519cda16e50d17e858541fce3bb39712836"`
Dec 15 09:37:53.671 INFO [stderr] usermod: no changes
Dec 15 09:37:53.827 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.13s
Dec 15 09:37:53.847 INFO [stdout] 
Dec 15 09:37:53.847 INFO [stdout] running 72 tests
Dec 15 09:37:53.847 INFO [stderr]      Running /target/debug/deps/gridiron-d640c8217566f852
Dec 15 09:37:53.855 INFO [stdout] test fp_256::tests::add_equals_mult ... ok
Dec 15 09:37:53.855 INFO [stdout] test digits::constant_time_primitives::tests::const_not ... ok
Dec 15 09:37:53.859 INFO [stdout] test fp_256::tests::default_is_zero ... ok
Dec 15 09:37:53.859 INFO [stdout] test digits::constant_time_primitives::tests::const_lt ... ok
Dec 15 09:37:53.859 INFO [stdout] test digits::constant_time_primitives::tests::const_le ... ok
Dec 15 09:37:53.859 INFO [stdout] test digits::constant_time_primitives::tests::const_gt ... ok
Dec 15 09:37:53.870 INFO [stdout] test fp_256::tests::from_bytes_roundtrip ... ok
Dec 15 09:37:53.870 INFO [stdout] test digits::constant_time_primitives::tests::const_eq ... ok
Dec 15 09:37:53.871 INFO [stdout] test fp_256::tests::associative ... ok
Dec 15 09:37:53.871 INFO [stdout] test fp_256::tests::div_zero_by_anything_should_be_zero ... ok
Dec 15 09:37:53.879 INFO [stdout] test fp_256::tests::distributive ... ok
Dec 15 09:37:53.879 INFO [stdout] test digits::constant_time_primitives::tests::const_ge ... ok
Dec 15 09:37:53.887 INFO [stdout] test fp_256::tests::from_u32 ... ok
Dec 15 09:37:53.891 INFO [stdout] test fp_256::tests::identity ... ok
Dec 15 09:37:53.899 INFO [stdout] test fp_256::tests::monty_mult_equals_normal ... ok
Dec 15 09:37:53.903 INFO [stdout] test fp_256::tests::monty_neg_works ... ok
Dec 15 09:37:53.907 INFO [stdout] test fp_256::tests::monty_add_assign_works ... ok
Dec 15 09:37:53.916 INFO [stdout] test fp_256::tests::commutative ... ok
Dec 15 09:37:53.923 INFO [stdout] test fp_256::tests::monty_add_works ... ok
Dec 15 09:37:53.959 INFO [stdout] test fp_256::tests::monty_times_normal_equals_normal ... ok
Dec 15 09:37:53.959 INFO [stdout] test fp_256::tests::neg ... ok
Dec 15 09:37:53.967 INFO [stdout] test fp_256::tests::mul_equals_div ... ok
Dec 15 09:37:53.967 INFO [stdout] test fp_256::tests::mul_equals_div_numerator_can_be_zero ... ok
Dec 15 09:37:53.973 INFO [stdout] test fp_256::tests::pow_equals_mult ... ok
Dec 15 09:37:53.995 INFO [stdout] test fp_256::tests::monty_sub_works ... ok
Dec 15 09:37:53.999 INFO [stdout] test fp_256::tests::zero ... ok
Dec 15 09:37:53.999 INFO [stdout] test fp_256::tests::monty_sub_assign_works ... ok
Dec 15 09:37:53.999 INFO [stdout] test fp_256::tests::normal_times_monty_equals_normal ... ok
Dec 15 09:37:53.999 INFO [stdout] test fp_480::tests::add_equals_mult ... ok
Dec 15 09:37:54.003 INFO [stdout] test fp_256::tests::to_monty_roundtrip_to_norm ... ok
Dec 15 09:37:54.003 INFO [stdout] test fp_480::tests::default_is_zero ... ok
Dec 15 09:37:54.003 INFO [stdout] test fp_256::tests::monty_inv_same_as_div ... ok
Dec 15 09:37:54.031 INFO [stdout] test fp_480::tests::from_bytes_roundtrip ... ok
Dec 15 09:37:54.031 INFO [stdout] test fp_480::tests::from_u32 ... ok
Dec 15 09:37:54.055 INFO [stdout] test fp_480::tests::div_zero_by_anything_should_be_zero ... ok
Dec 15 09:37:54.055 INFO [stdout] test fp_480::tests::commutative ... ok
Dec 15 09:37:54.061 INFO [stdout] test fp_480::tests::identity ... ok
Dec 15 09:37:54.090 INFO [stdout] test fp_480::tests::distributive ... ok
Dec 15 09:37:54.119 INFO [stdout] test fp_480::tests::associative ... ok
Dec 15 09:37:54.121 INFO [stdout] test fp_480::tests::monty_add_works ... ok
Dec 15 09:37:54.127 INFO [stdout] test fp_480::tests::monty_mult_equals_normal ... ok
Dec 15 09:37:54.143 INFO [stdout] test fp_480::tests::monty_inv_same_as_div ... ok
Dec 15 09:37:54.143 INFO [stdout] test fp_480::tests::monty_add_assign_works ... ok
Dec 15 09:37:54.147 INFO [stdout] test fp_480::tests::monty_neg_works ... ok
Dec 15 09:37:54.176 INFO [stdout] test fp_480::tests::monty_sub_works ... ok
Dec 15 09:37:54.186 INFO [stdout] test fp_480::tests::monty_sub_assign_works ... ok
Dec 15 09:37:54.222 INFO [stdout] test fp_480::tests::pow_equals_mult ... ok
Dec 15 09:37:54.222 INFO [stdout] test fp_480::tests::neg ... ok
Dec 15 09:37:54.223 INFO [stdout] test fp_480::tests::monty_times_normal_equals_normal ... ok
Dec 15 09:37:54.223 INFO [stdout] test lib::barrett_reduction ... ok
Dec 15 09:37:54.229 INFO [stdout] test fp_480::tests::mul_equals_div_numerator_can_be_zero ... ok
Dec 15 09:37:54.229 INFO [stdout] test lib::fp256_from_bytes_should_mod ... ok
Dec 15 09:37:54.229 INFO [stdout] test lib::fp256_to_bytes_known_good_value ... ok
Dec 15 09:37:54.229 INFO [stdout] test lib::fp_256_31_normalize_prime_minus_1 ... ok
Dec 15 09:37:54.229 INFO [stdout] test lib::fp_256_31_normalize_prime_plus_1 ... ok
Dec 15 09:37:54.231 INFO [stdout] test fp_480::tests::to_monty_roundtrip_to_norm ... ok
Dec 15 09:37:54.232 INFO [stdout] test fp_480::tests::zero ... ok
Dec 15 09:37:54.232 INFO [stdout] test lib::hex_dec_print ... ok
Dec 15 09:37:54.239 INFO [stdout] test lib::mont_mult1 ... ok
Dec 15 09:37:54.239 INFO [stdout] test lib::mont_mult2 ... ok
Dec 15 09:37:54.243 INFO [stdout] test lib::neg_test256 ... ok
Dec 15 09:37:54.243 INFO [stdout] test lib::static_add_31_bit ... ok
Dec 15 09:37:54.243 INFO [stdout] test lib::static_div_31_bit ... ok
Dec 15 09:37:54.243 INFO [stdout] test lib::static_co_reduce_256_bit ... ok
Dec 15 09:37:54.243 INFO [stdout] test lib::test_from_sha_static ... ok
Dec 15 09:37:54.243 INFO [stdout] test lib::zero1 ... ok
Dec 15 09:37:54.259 INFO [stdout] test lib::debug_hex_output_test256 ... ok
Dec 15 09:37:54.259 INFO [stdout] test lib::mul_precalc ... ok
Dec 15 09:37:54.275 INFO [stdout] test fp_480::tests::normal_times_monty_equals_normal ... ok
Dec 15 09:37:54.275 INFO [stdout] test fp_480::tests::mul_equals_div ... ok
Dec 15 09:37:54.307 INFO [stdout] test fp_480::tests::div_by_zero_should_panic ... ok
Dec 15 09:37:54.310 INFO [stdout] test fp_256::tests::div_by_zero_should_panic ... ok
Dec 15 09:37:54.310 INFO [stdout] 
Dec 15 09:37:54.310 INFO [stdout] test result: ok. 72 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:37:54.310 INFO [stdout] 
Dec 15 09:37:54.316 INFO [stderr]    Doc-tests gridiron
Dec 15 09:37:55.308 INFO [stdout] 
Dec 15 09:37:55.308 INFO [stdout] running 0 tests
Dec 15 09:37:55.309 INFO [stdout] 
Dec 15 09:37:55.309 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:37:55.309 INFO [stdout] 
Dec 15 09:37:55.320 INFO [stderr] su: No module specific data is present
Dec 15 09:37:56.063 INFO running `"docker" "inspect" "d1418a10d376c7765f199ceee6ca1519cda16e50d17e858541fce3bb39712836"`
Dec 15 09:37:56.305 INFO running `"docker" "rm" "-f" "d1418a10d376c7765f199ceee6ca1519cda16e50d17e858541fce3bb39712836"`
Dec 15 09:37:56.403 INFO [stdout] d1418a10d376c7765f199ceee6ca1519cda16e50d17e858541fce3bb39712836