[INFO] fetching crate opticalc 0.1.4...
[INFO] testing opticalc-0.1.4 against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate opticalc 0.1.4 into /workspace/builds/worker-3-tc2/source
[INFO] started tweaking crates.io crate opticalc 0.1.4
[INFO] finished tweaking crates.io crate opticalc 0.1.4
[INFO] tweaked toml for crates.io crate opticalc 0.1.4 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate opticalc 0.1.4 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate opticalc 0.1.4 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] f7c8dd9fc1eaf2e74a969d1043f8153c8ed0542e0227bf9acbbbde8312baa9c1
[INFO] running `Command { std: "docker" "start" "f7c8dd9fc1eaf2e74a969d1043f8153c8ed0542e0227bf9acbbbde8312baa9c1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f7c8dd9fc1eaf2e74a969d1043f8153c8ed0542e0227bf9acbbbde8312baa9c1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "f7c8dd9fc1eaf2e74a969d1043f8153c8ed0542e0227bf9acbbbde8312baa9c1" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f7c8dd9fc1eaf2e74a969d1043f8153c8ed0542e0227bf9acbbbde8312baa9c1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "f7c8dd9fc1eaf2e74a969d1043f8153c8ed0542e0227bf9acbbbde8312baa9c1" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling opticalc v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.29s
[INFO] running `Command { std: "docker" "inspect" "f7c8dd9fc1eaf2e74a969d1043f8153c8ed0542e0227bf9acbbbde8312baa9c1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "f7c8dd9fc1eaf2e74a969d1043f8153c8ed0542e0227bf9acbbbde8312baa9c1" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling approx v0.5.1
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling opticalc v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 7.19s
[INFO] running `Command { std: "docker" "inspect" "f7c8dd9fc1eaf2e74a969d1043f8153c8ed0542e0227bf9acbbbde8312baa9c1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "f7c8dd9fc1eaf2e74a969d1043f8153c8ed0542e0227bf9acbbbde8312baa9c1" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/build/opticalc/66857d1ad7ddc5eb/out/opticalc-66857d1ad7ddc5eb)
[INFO] [stdout] 
[INFO] [stdout] running 55 tests
[INFO] [stdout] test convert_power::tests::convert_power_measured_from_true_inverse ... ok
[INFO] [stdout] test convert_power::tests::convert_rx_zero_cylinder_passes_through ... ok
[INFO] [stdout] test convert_power::tests::convert_power_panics_on_bad_actual_index - should panic ... ok
[INFO] [stdout] test convert_power::tests::convert_rx_handles_plus_cylinder_notation ... ok
[INFO] [stdout] test crossed_cylinders::tests::aligned_minus_cylinders_add ... ok
[INFO] [stdout] test convert_power::tests::convert_power_panics_on_bad_assumed_index - should panic ... ok
[INFO] [stdout] test convert_power::tests::relative_tolerance_example_factor ... ok
[INFO] [stdout] test convert_power::tests::simulate_lensmeter_reading_inverse_of_convert_rx ... ok
[INFO] [stdout] test crossed_cylinders::tests::matrix_consistency_oblique_case ... ok
[INFO] [stdout] test minimum_blank_size::tests::minimum_blank_size_edge_case_zero_eyesize_and_bridge ... ok
[INFO] [stdout] test convert_power::tests::convert_rx_scales_sphere_and_cylinder_axis_unchanged ... ok
[INFO] [stdout] test crossed_cylinders::tests::pure_spheres_add ... ok
[INFO] [stdout] test convert_power::tests::convert_power_poly_example_true_from_measured ... ok
[INFO] [stdout] test minimum_blank_size::tests::minimum_blank_size_panics_negative_eyesize - should panic ... FAILED
[INFO] [stdout] test minimum_blank_size::tests::minimum_blank_size_edge_case_zero_ipd ... ok
[INFO] [stdout] test minimum_blank_size::tests::minimum_blank_size_large_frame ... ok
[INFO] [stdout] test minimum_blank_size::tests::minimum_blank_size_panics_negative_bridge - should panic ... FAILED
[INFO] [stdout] test minimum_blank_size::tests::minimum_blank_size_negative_decentration ... ok
[INFO] [stdout] test minimum_blank_size::tests::minimum_blank_size_panics_negative_effective_diameter - should panic ... FAILED
[INFO] [stdout] test minimum_blank_size::tests::minimum_blank_size_formula_verification ... ok
[INFO] [stdout] test minimum_blank_size::tests::minimum_blank_size_panics_negative_ipd - should panic ... FAILED
[INFO] [stdout] test minimum_blank_size::tests::minimum_blank_size_precision ... ok
[INFO] [stdout] test minimum_blank_size::tests::minimum_blank_size_small_frame ... ok
[INFO] [stdout] test minimum_blank_size::tests::minimum_blank_size_standard_example ... ok
[INFO] [stdout] test minimum_blank_size::tests::minimum_blank_size_zero_components ... ok
[INFO] [stdout] test minimum_blank_size::tests::recommended_blank_size_adds_working_edge ... ok
[INFO] [stdout] test oblique_meridian::tests::special_cases_90_and_180 ... ok
[INFO] [stdout] test prism::tests::down_only_with_toric_cross_term ... ok
[INFO] [stdout] test prism::tests::equal_in_and_down_at_45_has_equal_components ... ok
[INFO] [stdout] test prism::tests::pure_cylinder_horizontal_decentration_axis_90 ... ok
[INFO] [stdout] test prism::tests::one_centimeter_in_scales_linearly ... ok
[INFO] [stdout] test prism::tests::power_at_matches_definition ... ok
[INFO] [stdout] test prism::tests::mixed_sphero_cyl_os_out_and_up ... ok
[INFO] [stdout] test convert_power::tests::convert_power_zero_is_stable ... ok
[INFO] [stdout] test minimum_blank_size::tests::recommended_blank_size_consistency ... ok
[INFO] [stdout] test oblique_meridian::tests::matches_power_at_definition ... ok
[INFO] [stdout] test prism::tests::axis_135_cancels_components_for_symmetric_decentration ... ok
[INFO] [stdout] test prism::tests::pure_sphere_horizontal_decentration_od_vs_os ... ok
[INFO] [stdout] test prism::tests::pure_cylinder_vertical_decentration_axis_0_or_180_equivalence ... ok
[INFO] [stdout] test prism::tests::test_1 ... ok
[INFO] [stdout] test transpose::tests::transpose_axis_adjustment_less_than_90 ... ok
[INFO] [stdout] test transpose::tests::transpose_axis_exactly_90 ... ok
[INFO] [stdout] test transpose::tests::transpose_complex_prescription ... ok
[INFO] [stdout] test transpose::tests::transpose_double_transposition_returns_original ... ok
[INFO] [stdout] test transpose::tests::transpose_axis_180_becomes_90 ... ok
[INFO] [stdout] test transpose::tests::transpose_function_equivalent_to_method ... ok
[INFO] [stdout] test transpose::tests::transpose_high_power_prescription ... ok
[INFO] [stdout] test transpose::tests::transpose_minus_to_plus_cylinder ... ok
[INFO] [stdout] test transpose::tests::transpose_axis_adjustment_greater_than_or_equal_90 ... ok
[INFO] [stdout] test transpose::tests::transpose_zero_cylinder_unchanged ... ok
[INFO] [stdout] test transpose::tests::transpose_plus_to_minus_cylinder ... ok
[INFO] [stdout] test prism::tests::test_3 ... ok
[INFO] [stdout] test prism::tests::zero_decentration_yields_zero_prism_even_with_power ... ok
[INFO] [stdout] test transpose::tests::transpose_preserves_optical_power ... ok
[INFO] [stdout] test prism::tests::test_4 ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- minimum_blank_size::tests::minimum_blank_size_panics_negative_eyesize stdout ----
[INFO] [stdout] note: test did not panic as expected at src/minimum_blank_size.rs:202:8
[INFO] [stdout] ---- minimum_blank_size::tests::minimum_blank_size_panics_negative_bridge stdout ----
[INFO] [stdout] note: test did not panic as expected at src/minimum_blank_size.rs:208:8
[INFO] [stdout] ---- minimum_blank_size::tests::minimum_blank_size_panics_negative_effective_diameter stdout ----
[INFO] [stdout] note: test did not panic as expected at src/minimum_blank_size.rs:196:8
[INFO] [stdout] ---- minimum_blank_size::tests::minimum_blank_size_panics_negative_ipd stdout ----
[INFO] [stdout] note: test did not panic as expected at src/minimum_blank_size.rs:214:8
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     minimum_blank_size::tests::minimum_blank_size_panics_negative_bridge
[INFO] [stdout]     minimum_blank_size::tests::minimum_blank_size_panics_negative_effective_diameter
[INFO] [stdout]     minimum_blank_size::tests::minimum_blank_size_panics_negative_eyesize
[INFO] [stdout]     minimum_blank_size::tests::minimum_blank_size_panics_negative_ipd
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 51 passed; 4 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "f7c8dd9fc1eaf2e74a969d1043f8153c8ed0542e0227bf9acbbbde8312baa9c1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f7c8dd9fc1eaf2e74a969d1043f8153c8ed0542e0227bf9acbbbde8312baa9c1", kill_on_drop: false }`
[INFO] [stdout] f7c8dd9fc1eaf2e74a969d1043f8153c8ed0542e0227bf9acbbbde8312baa9c1
