[INFO] cloning repository https://github.com/ingmarrr/1DV609_a1p2
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/ingmarrr/1DV609_a1p2" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fingmarrr%2F1DV609_a1p2", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fingmarrr%2F1DV609_a1p2'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 0cd7a86cc17a5741dcb9f41ec7cfebe1fd648363
[INFO] testing ingmarrr/1DV609_a1p2 against try#2440211fe03bc45c89b6dc1a3df18382ce91e32b for pr-146098-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fingmarrr%2F1DV609_a1p2" "/workspace/builds/worker-7-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/ingmarrr/1DV609_a1p2
[INFO] finished tweaking git repo https://github.com/ingmarrr/1DV609_a1p2
[INFO] tweaked toml for git repo https://github.com/ingmarrr/1DV609_a1p2 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/ingmarrr/1DV609_a1p2 on toolchain 2440211fe03bc45c89b6dc1a3df18382ce91e32b
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/ingmarrr/1DV609_a1p2 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" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 4a97ab22b9bf97d9b1a344c6ab7a8123fb7b681b9278c64fee405388442b14e9
[INFO] running `Command { std: "docker" "start" "-a" "4a97ab22b9bf97d9b1a344c6ab7a8123fb7b681b9278c64fee405388442b14e9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "4a97ab22b9bf97d9b1a344c6ab7a8123fb7b681b9278c64fee405388442b14e9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4a97ab22b9bf97d9b1a344c6ab7a8123fb7b681b9278c64fee405388442b14e9", kill_on_drop: false }`
[INFO] [stdout] 4a97ab22b9bf97d9b1a344c6ab7a8123fb7b681b9278c64fee405388442b14e9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 78940f3c264384c80ae9341f672d82e1668ffe39358f8ddb405ff49a7eb424f6
[INFO] running `Command { std: "docker" "start" "-a" "78940f3c264384c80ae9341f672d82e1668ffe39358f8ddb405ff49a7eb424f6", kill_on_drop: false }`
[INFO] [stderr]    Compiling thiserror v1.0.50
[INFO] [stderr]    Compiling thiserror-impl v1.0.50
[INFO] [stderr]    Compiling a1p2 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.19s
[INFO] running `Command { std: "docker" "inspect" "78940f3c264384c80ae9341f672d82e1668ffe39358f8ddb405ff49a7eb424f6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "78940f3c264384c80ae9341f672d82e1668ffe39358f8ddb405ff49a7eb424f6", kill_on_drop: false }`
[INFO] [stdout] 78940f3c264384c80ae9341f672d82e1668ffe39358f8ddb405ff49a7eb424f6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 52a00a549d9c09402727255352258f8c00c608bf07b4e1245c624567edc8841d
[INFO] running `Command { std: "docker" "start" "-a" "52a00a549d9c09402727255352258f8c00c608bf07b4e1245c624567edc8841d", kill_on_drop: false }`
[INFO] [stderr]    Compiling a1p2 v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.03s
[INFO] running `Command { std: "docker" "inspect" "52a00a549d9c09402727255352258f8c00c608bf07b4e1245c624567edc8841d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "52a00a549d9c09402727255352258f8c00c608bf07b4e1245c624567edc8841d", kill_on_drop: false }`
[INFO] [stdout] 52a00a549d9c09402727255352258f8c00c608bf07b4e1245c624567edc8841d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+2440211fe03bc45c89b6dc1a3df18382ce91e32b" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 7904f8c2c1a9a7a83f67581e7a26bee297d027fcae749b2da4353a5766efdd0b
[INFO] running `Command { std: "docker" "start" "-a" "7904f8c2c1a9a7a83f67581e7a26bee297d027fcae749b2da4353a5766efdd0b", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/a1p2-3ad152d9f04bb944)
[INFO] [stdout] 
[INFO] [stdout] running 106 tests
[INFO] [stdout] test cmd::tests::exec_should_write_to_out_writer ... ok
[INFO] [stdout] test cmd::tests::exec_should_err_on_invalid_args ... ok
[INFO] [stdout] test cmd::tests::exec_fn_should_ok_on_valid_arg ... ok
[INFO] [stdout] test cmd::tests::exec_should_err_on_empty ... ok
[INFO] [stdout] test cmd::tests::exec_should_err_too_many_args_for_any_cmd ... ok
[INFO] [stdout] test cmd::tests::sim_should_err_on_missing_file ... ok
[INFO] [stdout] test eval::tests::eval_binary_add_expr_with_int_and_float_should_return_float ... ok
[INFO] [stdout] test eval::tests::eval_binary_add_expr_with_ints_should_return_int ... ok
[INFO] [stdout] test eval::tests::eval_binary_div_expr_with_float_and_int_should_return_float ... ok
[INFO] [stdout] test eval::tests::eval_binary_add_expr_with_floats_should_return_float ... ok
[INFO] [stdout] test eval::tests::eval_binary_div_expr_with_floats_should_return_float ... ok
[INFO] [stdout] test cmd::tests::help_should_print_usage_for_command ... ok
[INFO] [stdout] test eval::tests::eval_binary_div_expr_with_ints_should_return_int ... ok
[INFO] [stdout] test eval::tests::eval_binary_expr_should_calculate_numbers_with_correct_precedence ... ok
[INFO] [stdout] test eval::tests::eval_binary_div_expr_with_int_and_float_should_return_float ... ok
[INFO] [stdout] test eval::tests::eval_binary_expr_with_parentheses ... ok
[INFO] [stdout] test eval::tests::eval_binary_expr_with_parentheses_and_precedence ... ok
[INFO] [stdout] test eval::tests::eval_binary_expr_with_parentheses_and_precedence_and_floats ... ok
[INFO] [stdout] test eval::tests::eval_binary_expr_with_parentheses_and_precedence_and_floats_and_ints ... ok
[INFO] [stdout] test eval::tests::eval_binary_expr_with_parentheses_and_precedence_and_floats_and_ints_and_division ... ok
[INFO] [stdout] test eval::tests::eval_binary_expr_with_strings ... ok
[INFO] [stdout] test eval::tests::eval_binary_mul_expr_with_float_and_int_should_return_float ... ok
[INFO] [stdout] test eval::tests::eval_binary_add_expr_with_float_and_int_should_return_float ... ok
[INFO] [stdout] test eval::tests::eval_binary_mul_expr_with_floats_should_return_float ... ok
[INFO] [stdout] test eval::tests::eval_binary_mul_expr_with_int_and_float_should_return_float ... ok
[INFO] [stdout] test eval::tests::eval_binary_mul_expr_with_int_and_string_should_return_string ... ok
[INFO] [stdout] test eval::tests::eval_binary_mul_expr_with_ints_should_return_int ... ok
[INFO] [stdout] test eval::tests::eval_binary_mul_expr_with_string_and_int_should_return_string ... ok
[INFO] [stdout] test eval::tests::eval_binary_sub_expr_with_float_and_int_should_return_float ... ok
[INFO] [stdout] test eval::tests::eval_binary_sub_expr_with_ints_should_return_int ... ok
[INFO] [stdout] test eval::tests::eval_binary_sub_expr_with_int_and_float_should_return_float ... ok
[INFO] [stdout] test eval::tests::eval_binary_sub_expr_with_floats_should_return_float ... ok
[INFO] [stdout] test eval::tests::eval_expr_with_string_should_return_string ... ok
[INFO] [stdout] test parser::tests::mul_expr_has_higher_precedence_than_add_expr ... ok
[INFO] [stdout] test parser::tests::paren_add_expr_has_higher_precedence_than_mul_expr ... ok
[INFO] [stdout] test parser::tests::parse_assert_should_return_error_on_unexpected_token ... ok
[INFO] [stdout] test parser::tests::parse_assert_union_should_return_error_msg ... ok
[INFO] [stdout] test parser::tests::parse_consume_if_should_return_none_on_wrong_token ... ok
[INFO] [stdout] test parser::tests::parse_consume_if_should_return_token_on_correct_token ... ok
[INFO] [stdout] test parser::tests::parse_assert_should_return_correct_token ... ok
[INFO] [stdout] test parser::tests::parse_expr_should_return_err_on_missing_closing_rparen ... ok
[INFO] [stdout] test parser::tests::parse_expr_should_return_int_node ... ok
[INFO] [stdout] test parser::tests::parse_expr_should_return_nested_binop_node ... ok
[INFO] [stdout] test parser::tests::parse_expr_should_return_string_node ... ok
[INFO] [stdout] test parser::tests::parse_expr_should_return_unexpected_token_on_invalid_token_for_expression ... ok
[INFO] [stdout] test parser::tests::parse_expr_should_sink_mul_expr_to_end ... ok
[INFO] [stdout] test parser::tests::parse_expr_should_return_binop_node ... ok
[INFO] [stdout] test parser::tests::parse_expr_should_swap_add_and_mul_expression ... ok
[INFO] [stdout] test parser::tests::parse_expr_with_error_should_report_error ... ok
[INFO] [stdout] test parser::tests::parse_let_statement_missing_eq_sign ... ok
[INFO] [stdout] test parser::tests::parse_let_statement_should_error_on_missing_name ... ok
[INFO] [stdout] test eval::tests::eval_expr_with_float_should_return_float ... ok
[INFO] [stdout] test eval::tests::eval_expr_with_int_should_return_int ... ok
[INFO] [stdout] test parser::tests::parse_let_statement_with_add_expression_should_return_let_with_type ... ok
[INFO] [stdout] test parser::tests::parse_let_statement_with_invalid_type ... ok
[INFO] [stdout] test parser::tests::parse_let_statement_without_expression_should_return_error ... ok
[INFO] [stdout] test parser::tests::parse_statement_should_return_let_with_inferred_type_int ... ok
[INFO] [stdout] test parser::tests::parse_statement_should_return_let_with_inferred_type_str ... ok
[INFO] [stdout] test parser::tests::parse_statement_should_return_let_with_string_expr ... ok
[INFO] [stdout] test parser::tests::parse_statement_should_return_let_with_type_int ... ok
[INFO] [stdout] test parser::tests::parse_statement_should_return_let_with_unknown_type ... ok
[INFO] [stdout] test parser::tests::parser_should_ok_on_empty ... ok
[INFO] [stdout] test parser::tests::parse_let_statement_with_add_expression_should_return_let ... ok
[INFO] [stdout] test parser::tests::parser_should_return_int_node ... ok
[INFO] [stdout] test semantic::tests::add_float_float ... ok
[INFO] [stdout] test semantic::tests::add_float_int ... ok
[INFO] [stdout] test semantic::tests::add_int_float ... ok
[INFO] [stdout] test parser::tests::two_parenthesized_expressions_have_same_precedence ... ok
[INFO] [stdout] test semantic::tests::add_int_int ... ok
[INFO] [stdout] test semantic::tests::div_float_float ... ok
[INFO] [stdout] test semantic::tests::div_float_int ... ok
[INFO] [stdout] test semantic::tests::div_int_float ... ok
[INFO] [stdout] test semantic::tests::div_int_int ... ok
[INFO] [stdout] test semantic::tests::mul_float_float ... ok
[INFO] [stdout] test semantic::tests::mul_float_int ... ok
[INFO] [stdout] test semantic::tests::mul_int_float ... ok
[INFO] [stdout] test semantic::tests::mul_int_int ... ok
[INFO] [stdout] test semantic::tests::mul_int_string ... ok
[INFO] [stdout] test semantic::tests::mul_string_int ... ok
[INFO] [stdout] test semantic::tests::semantics_check_should_fail_for_unsupported_operators_add ... ok
[INFO] [stdout] test semantic::tests::semantics_check_should_fail_for_unsupported_operators_mul ... ok
[INFO] [stdout] test semantic::tests::sub_float_float ... ok
[INFO] [stdout] test semantic::tests::sub_float_int ... ok
[INFO] [stdout] test semantic::tests::sub_int_float ... ok
[INFO] [stdout] test semantic::tests::sub_int_int ... ok
[INFO] [stdout] test semantic::tests::var_int ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_empty_should_return_eof_on_next ... ok
[INFO] [stdout] test tokenizer::tests::token_kinds_correspond_to_string ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_recognize_all_symbols ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_error_unterminated_string ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_error_on_multiple_dots ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_float_correctly_on_invalid_ident_char ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_float_on_underscores ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_float_with_underscores ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_ident_contains_digits ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_ident_correctly_on_invalid_ident_char ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_ident_front_underscore ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_ident_on_underscore_and_uppercase ... ok
[INFO] [stdout] test eval::tests::eval_with_empty_input_should_return_empty_output ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_ident_regular ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_int_correctly_on_invalid_ident_char ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_int_on_underscores ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_int_without_underscores ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_keywords ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_string ... ok
[INFO] [stdout] test tokenizer::tests::tokenizer_should_return_token_buffer ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 106 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "7904f8c2c1a9a7a83f67581e7a26bee297d027fcae749b2da4353a5766efdd0b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7904f8c2c1a9a7a83f67581e7a26bee297d027fcae749b2da4353a5766efdd0b", kill_on_drop: false }`
[INFO] [stdout] 7904f8c2c1a9a7a83f67581e7a26bee297d027fcae749b2da4353a5766efdd0b