[INFO] fetching crate spvirit-calc 0.3.4...
[INFO] testing spvirit-calc-0.3.4 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate spvirit-calc 0.3.4 into /workspace/builds/worker-1-tc2/source
[INFO] started tweaking crates.io crate spvirit-calc 0.3.4
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate spvirit-calc 0.3.4
[INFO] tweaked toml for crates.io crate spvirit-calc 0.3.4 written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate spvirit-calc 0.3.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 spvirit-calc 0.3.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-1-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 73416122ccc7fff98d170043be35395a41e5e4d0f30762d42abd05bd8e03a6a4
[INFO] running `Command { std: "docker" "start" "73416122ccc7fff98d170043be35395a41e5e4d0f30762d42abd05bd8e03a6a4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "73416122ccc7fff98d170043be35395a41e5e4d0f30762d42abd05bd8e03a6a4", 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" "73416122ccc7fff98d170043be35395a41e5e4d0f30762d42abd05bd8e03a6a4" "/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" "73416122ccc7fff98d170043be35395a41e5e4d0f30762d42abd05bd8e03a6a4", 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" "73416122ccc7fff98d170043be35395a41e5e4d0f30762d42abd05bd8e03a6a4" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling spvirit-calc v0.3.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.49s
[INFO] running `Command { std: "docker" "inspect" "73416122ccc7fff98d170043be35395a41e5e4d0f30762d42abd05bd8e03a6a4", 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" "73416122ccc7fff98d170043be35395a41e5e4d0f30762d42abd05bd8e03a6a4" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling spvirit-calc v0.3.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.51s
[INFO] running `Command { std: "docker" "inspect" "73416122ccc7fff98d170043be35395a41e5e4d0f30762d42abd05bd8e03a6a4", 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" "73416122ccc7fff98d170043be35395a41e5e4d0f30762d42abd05bd8e03a6a4" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/spvirit-calc/908156370037e850/out/spvirit_calc-908156370037e850)
[INFO] [stdout] 
[INFO] [stdout] running 142 tests
[INFO] [stdout] test eval::tests::bitwise_result_with_bit_31_set_is_negative ... ok
[INFO] [stdout] test eval::tests::a_store_in_a_ternary_hoists_out_and_runs_on_both_paths ... ok
[INFO] [stdout] test eval::tests::atan2_arguments_are_backwards_matching_base ... ok
[INFO] [stdout] test eval::tests::abs_exp_hyperbolic_and_inverse_trig ... ok
[INFO] [stdout] test eval::tests::bitwise_truncates_toward_zero ... ok
[INFO] [stdout] test eval::tests::chained_ternary_in_else_branch_evaluates_correctly ... ok
[INFO] [stdout] test eval::tests::conditional_binds_loosest ... ok
[INFO] [stdout] test eval::tests::bitwise_and_or_not ... ok
[INFO] [stdout] test eval::tests::bitwise_on_non_finite_yields_zero_operand ... ok
[INFO] [stdout] test eval::tests::bitwise_ops_never_panic_on_nan_or_infinity ... ok
[INFO] [stdout] test eval::tests::caret_is_power_and_xor_is_the_word ... ok
[INFO] [stdout] test eval::tests::chained_stores_feed_later_expressions ... ok
[INFO] [stdout] test eval::tests::conditional_selects_then_branch_on_nonzero_condition ... ok
[INFO] [stdout] test eval::tests::conditional_never_executes_the_untaken_branch ... ok
[INFO] [stdout] test eval::tests::conditional_selects_branch ... ok
[INFO] [stdout] test eval::tests::corpus_uint32_store_shapes ... ok
[INFO] [stdout] test eval::tests::conditional_selects_else_branch_on_zero_condition ... ok
[INFO] [stdout] test eval::tests::direct_d2i_d2ui_unit_checks ... ok
[INFO] [stdout] test eval::tests::division_by_zero_yields_infinity_not_error ... ok
[INFO] [stdout] test eval::tests::empty_expression_is_nan ... ok
[INFO] [stdout] test eval::tests::fetch_then_store_returns_the_earlier_fetch_not_the_stored_value ... ok
[INFO] [stdout] test eval::tests::finite_is_variadic_and_folds_with_and ... ok
[INFO] [stdout] test eval::tests::hash_is_not_equal ... ok
[INFO] [stdout] test eval::tests::infinity_spelling_is_accepted_like_base ... ok
[INFO] [stdout] test eval::tests::isinf_is_strictly_unary_not_variadic ... ok
[INFO] [stdout] test eval::tests::isnan_is_variadic_and_folds_with_or ... ok
[INFO] [stdout] test eval::tests::log_is_base_ten_and_loge_is_natural ... ok
[INFO] [stdout] test eval::tests::log_of_negative_is_nan_not_error ... ok
[INFO] [stdout] test eval::tests::logical_operators_treat_nan_as_true ... ok
[INFO] [stdout] test eval::tests::evaluates_arithmetic ... ok
[INFO] [stdout] test eval::tests::eval_does_not_write_args_without_a_store ... ok
[INFO] [stdout] test eval::tests::accepted_store_and_terminator_shapes_never_panic ... ok
[INFO] [stdout] test eval::tests::expression_keeps_its_auto_traits_after_adding_rndm ... ok
[INFO] [stdout] test eval::tests::eval_with_rng_uses_the_caller_supplied_generator_not_the_thread_local ... ok
[INFO] [stdout] test eval::tests::many_chained_nullary_constants_compile_and_evaluate ... ok
[INFO] [stdout] test eval::tests::min_and_max_are_variadic ... ok
[INFO] [stdout] test eval::tests::min_and_max_propagate_nan_from_any_position ... ok
[INFO] [stdout] test eval::tests::logical_operators_treat_nonzero_as_true ... ok
[INFO] [stdout] test eval::tests::logical_shift_right_does_not_sign_extend_unlike_arithmetic_shift_right ... ok
[INFO] [stdout] test eval::tests::modulo_by_zero_yields_nan_not_infinity ... ok
[INFO] [stdout] test eval::tests::named_constants ... ok
[INFO] [stdout] test eval::tests::modulo_with_negative_divisor ... ok
[INFO] [stdout] test eval::tests::nan_and_inf_predicates ... ok
[INFO] [stdout] test eval::tests::modulo_is_integer_not_float_remainder ... ok
[INFO] [stdout] test eval::tests::nan_comparisons_are_always_false_except_not_equal ... ok
[INFO] [stdout] test eval::tests::respects_precedence_end_to_end ... ok
[INFO] [stdout] test eval::tests::rndm_is_in_unit_interval_and_varies_across_draws ... ok
[INFO] [stdout] test eval::tests::rndm_is_reproducible_from_a_fixed_seed ... ok
[INFO] [stdout] test eval::tests::rndm_participates_in_a_larger_expression ... ok
[INFO] [stdout] test eval::tests::rounding_functions ... ok
[INFO] [stdout] test eval::tests::shift_count_is_masked_to_five_bits_and_never_panics ... ok
[INFO] [stdout] test eval::tests::shifts_operate_on_integers ... ok
[INFO] [stdout] test eval::tests::single_equals_is_equality_not_assignment ... ok
[INFO] [stdout] test eval::tests::sqr_is_square_root_not_squaring ... ok
[INFO] [stdout] test eval::tests::store_ordering_within_one_expression ... ok
[INFO] [stdout] test eval::tests::store_then_fetch_sees_the_stored_value ... ok
[INFO] [stdout] test eval::tests::logical_shift_right_matches_corpus_examples ... ok
[INFO] [stdout] test eval::tests::stores_reach_every_slot_including_u ... ok
[INFO] [stdout] test eval::tests::nested_ternary_in_then_branch_evaluates_correctly ... ok
[INFO] [stdout] test eval::tests::logical_shift_right_result_is_unsigned_unlike_every_other_bitwise_op ... ok
[INFO] [stdout] test eval::tests::strict_relational_operators_differ_from_non_strict_at_equal_operands ... ok
[INFO] [stdout] test eval::tests::nint_rounds_half_away_from_zero_at_boundaries ... ok
[INFO] [stdout] test eval::tests::untaken_ternary_branch_never_draws_from_the_rng ... ok
[INFO] [stdout] test lex::tests::expression_terminator_lexes_as_an_operator ... ok
[INFO] [stdout] test lex::tests::identifiers_are_case_insensitive ... ok
[INFO] [stdout] test lex::tests::lexes_hex_literals ... ok
[INFO] [stdout] test lex::tests::lexes_operands_numbers_and_operators ... ok
[INFO] [stdout] test lex::tests::rejects_unknown_character ... ok
[INFO] [stdout] test lex::tests::store_operator_beats_the_ternary_colon ... ok
[INFO] [stdout] test lex::tests::two_char_operators_beat_one_char ... ok
[INFO] [stdout] test eval::tests::nint_saturates_on_i32_overflow_matching_rust_cast_semantics ... ok
[INFO] [stdout] test lex::tests::triple_char_logical_shift_beats_double_and_single ... ok
[INFO] [stdout] test parse::tests::arg_usage_counts_each_operand_once ... ok
[INFO] [stdout] test parse::tests::arg_usage_reports_referenced_operands ... ok
[INFO] [stdout] test parse::tests::a_bare_store_leaves_no_result_and_is_rejected ... ok
[INFO] [stdout] test parse::tests::bitwise_and_shares_precedence_with_logical_and ... ok
[INFO] [stdout] test parse::tests::bitwise_and_and_left_shift_are_equal_precedence ... ok
[INFO] [stdout] test parse::tests::and_binds_looser_than_relational ... ok
[INFO] [stdout] test eval::tests::d2i_bit31_asymmetry_positive_and_negative_agree_where_naive_cast_would_not ... ok
[INFO] [stdout] test eval::tests::relational_operators_yield_one_or_zero ... ok
[INFO] [stdout] test eval::tests::unary_minus_applies_to_operand ... ok
[INFO] [stdout] test parse::tests::bitwise_not_binds_tighter_than_power ... ok
[INFO] [stdout] test parse::tests::bitwise_not_binds_tighter_than_relational ... ok
[INFO] [stdout] test eval::tests::trig_functions ... ok
[INFO] [stdout] test parse::tests::bare_function_name_without_a_call_is_incomplete ... ok
[INFO] [stdout] test parse::tests::bitwise_or_and_xor_are_equal_precedence_left_associative ... ok
[INFO] [stdout] test parse::tests::dangling_conditional_outranks_a_missing_operand ... ok
[INFO] [stdout] test parse::tests::conditional_interacts_with_lower_precedence_operators ... ok
[INFO] [stdout] test parse::tests::conditional_punctuation_in_operand_position_is_a_syntax_error ... ok
[INFO] [stdout] test parse::tests::empty_expression_compiles_to_nothing ... ok
[INFO] [stdout] test parse::tests::depth_may_return_to_zero_between_terminators ... ok
[INFO] [stdout] test parse::tests::double_star_is_an_alias_for_caret ... ok
[INFO] [stdout] test parse::tests::fetch_then_store_of_same_slot_is_reported_as_input ... ok
[INFO] [stdout] test parse::tests::every_operand_letter_has_its_own_store_slot ... ok
[INFO] [stdout] test parse::tests::multiplication_binds_tighter_than_addition ... ok
[INFO] [stdout] test parse::tests::lowercase_operands_store_to_the_same_slot ... ok
[INFO] [stdout] test parse::tests::bitwise_or_shares_precedence_with_logical_or ... ok
[INFO] [stdout] test parse::tests::logical_right_shift_shares_precedence_with_bitwise_and ... ok
[INFO] [stdout] test parse::tests::left_shift_and_bitwise_and_are_equal_precedence ... ok
[INFO] [stdout] test parse::tests::chained_ternary_in_else_branch ... ok
[INFO] [stdout] test parse::tests::fetch_claim_is_not_retracted_by_a_later_store_to_the_same_slot ... ok
[INFO] [stdout] test parse::tests::conditional_compiles_to_branch ... ok
[INFO] [stdout] test parse::tests::nested_ternary_in_then_branch ... ok
[INFO] [stdout] test parse::tests::not_binds_tighter_than_relational ... ok
[INFO] [stdout] test parse::tests::or_binds_looser_than_and ... ok
[INFO] [stdout] test parse::tests::rejects_adjacent_number_literals ... ok
[INFO] [stdout] test parse::tests::power_binds_tighter_than_multiplication ... ok
[INFO] [stdout] test parse::tests::parentheses_override_precedence ... ok
[INFO] [stdout] test parse::tests::power_is_left_associative ... ok
[INFO] [stdout] test parse::tests::rejects_colon_without_question_mark ... ok
[INFO] [stdout] test parse::tests::rejects_dangling_question_mark ... ok
[INFO] [stdout] test parse::tests::rejects_dangling_colon ... ok
[INFO] [stdout] test parse::tests::rejects_empty_argument_list ... ok
[INFO] [stdout] test parse::tests::rejects_operand_adjacent_to_function_call ... ok
[INFO] [stdout] test parse::tests::rejects_paren_closing_over_dangling_conditional ... ok
[INFO] [stdout] test parse::tests::relational_binds_tighter_than_left_shift ... ok
[INFO] [stdout] test parse::tests::rejects_expression_exceeding_max_ops ... ok
[INFO] [stdout] test parse::tests::rejects_extra_operand ... ok
[INFO] [stdout] test parse::tests::rejects_missing_operand ... ok
[INFO] [stdout] test parse::tests::store_in_an_else_branch_is_rejected ... ok
[INFO] [stdout] test parse::tests::rejects_operand_adjacent_to_empty_call ... ok
[INFO] [stdout] test parse::tests::store_requires_a_bare_operand_as_its_target ... ok
[INFO] [stdout] test parse::tests::store_swallows_the_colon_of_a_ternary_leaving_it_unbalanced ... ok
[INFO] [stdout] test parse::tests::store_then_fetch_of_same_slot_is_not_reported_as_input ... ok
[INFO] [stdout] test parse::tests::rejects_unbalanced_parens ... ok
[INFO] [stdout] test parse::tests::relational_binds_looser_than_addition ... ok
[INFO] [stdout] test parse::tests::store_of_a_parenthesised_conditional_keeps_the_store_outside_the_arms ... ok
[INFO] [stdout] test parse::tests::reordered_unwind_preserves_the_other_end_of_parse_errors ... ok
[INFO] [stdout] test parse::tests::store_in_a_then_branch_hoists_out_of_the_conditional ... ok
[INFO] [stdout] test parse::tests::stores_only_expression_reports_zero_inputs ... ok
[INFO] [stdout] test parse::tests::subtraction_is_left_associative ... ok
[INFO] [stdout] test parse::tests::store_to_one_slot_does_not_suppress_fetch_of_a_different_slot ... ok
[INFO] [stdout] test parse::tests::terminator_emits_nothing_and_leaves_the_earlier_value_on_the_stack ... ok
[INFO] [stdout] test parse::tests::store_to_u_sets_bit_20 ... ok
[INFO] [stdout] test parse::tests::store_unemits_the_fetch_and_emits_a_store_after_its_value ... ok
[INFO] [stdout] test parse::tests::terminator_finalizes_a_completed_ternary ... ok
[INFO] [stdout] test parse::tests::terminator_in_operand_position_is_rejected ... ok
[INFO] [stdout] test parse::tests::unary_minus_binds_tighter_than_power ... ok
[INFO] [stdout] test parse::tests::word_spelled_bitwise_operators_compile_like_their_symbols ... ok
[INFO] [stderr]      Running tests/base_corpus.rs (/opt/rustwide/target/debug/build/spvirit-calc/4bfb8d413a4e1290/out/base_corpus-4bfb8d413a4e1290)
[INFO] [stdout] test parse::tests::terminator_rejects_an_open_paren_or_dangling_conditional ... ok
[INFO] [stdout] test parse::tests::ternary_reports_both_untaken_and_taken_arm ... ok
[INFO] [stdout] test parse::tests::unary_minus_distinguished_from_binary ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 142 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test rndm_stays_in_unit_interval ... ok
[INFO] [stdout] test base_corpus ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests spvirit_calc
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "73416122ccc7fff98d170043be35395a41e5e4d0f30762d42abd05bd8e03a6a4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "73416122ccc7fff98d170043be35395a41e5e4d0f30762d42abd05bd8e03a6a4", kill_on_drop: false }`
[INFO] [stdout] 73416122ccc7fff98d170043be35395a41e5e4d0f30762d42abd05bd8e03a6a4
