[INFO] cloning repository tylerlaberge/rascal
[INFO] running `"git" "clone" "--bare" "git://github.com/tylerlaberge/rascal.git" "work/cache/sources/gh/tylerlaberge/rascal"`
[INFO] [stderr] Cloning into bare repository 'work/cache/sources/gh/tylerlaberge/rascal'...
[INFO] running `"git" "clone" "work/cache/sources/gh/tylerlaberge/rascal" "work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/gh/tylerlaberge/rascal"`
[INFO] [stderr] Cloning into 'work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/gh/tylerlaberge/rascal'...
[INFO] [stderr] done.
[INFO] running `"git" "clone" "work/cache/sources/gh/tylerlaberge/rascal" "work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/gh/tylerlaberge/rascal"`
[INFO] [stderr] Cloning into 'work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/gh/tylerlaberge/rascal'...
[INFO] [stderr] done.
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] 52475957c947dff2e610a9cd3874766b7e3688cc
[INFO] sha for GitHub repo tylerlaberge/rascal: 52475957c947dff2e610a9cd3874766b7e3688cc
[INFO] validating manifest of tylerlaberge/rascal on toolchain master#c8865d8e195813ade6b84434ac9f8850e7112d1a
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of tylerlaberge/rascal on toolchain try#e212b7d492c96d3837691ba29d32d5f468933fb8
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing tylerlaberge/rascal
[INFO] finished frobbing tylerlaberge/rascal
[INFO] frobbed toml for tylerlaberge/rascal written to work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/gh/tylerlaberge/rascal/Cargo.toml
[INFO] started frobbing tylerlaberge/rascal
[INFO] finished frobbing tylerlaberge/rascal
[INFO] frobbed toml for tylerlaberge/rascal written to work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/gh/tylerlaberge/rascal/Cargo.toml
[INFO] crate tylerlaberge/rascal already has a lockfile, it will not be regenerated
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing tylerlaberge/rascal against master#c8865d8e195813ade6b84434ac9f8850e7112d1a for pr-61629
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-4/master#c8865d8e195813ade6b84434ac9f8850e7112d1a:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/gh/tylerlaberge/rascal:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "build" "--frozen"`
[INFO] [stdout] 5197936a899b551946742cbec2eb574ec097894799ac4ec5e2dbbd9e4ac56f50
[INFO] running `"docker" "start" "-a" "5197936a899b551946742cbec2eb574ec097894799ac4ec5e2dbbd9e4ac56f50"`
[INFO] [stderr]    Compiling either v1.2.0
[INFO] [stderr]    Compiling itertools v0.7.1
[INFO] [stderr]    Compiling rascal v1.2.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.39s
[INFO] running `"docker" "inspect" "5197936a899b551946742cbec2eb574ec097894799ac4ec5e2dbbd9e4ac56f50"`
[INFO] running `"docker" "rm" "-f" "5197936a899b551946742cbec2eb574ec097894799ac4ec5e2dbbd9e4ac56f50"`
[INFO] [stdout] 5197936a899b551946742cbec2eb574ec097894799ac4ec5e2dbbd9e4ac56f50
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-4/master#c8865d8e195813ade6b84434ac9f8850e7112d1a:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/gh/tylerlaberge/rascal:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "test" "--frozen" "--no-run"`
[INFO] [stdout] 061ca9ab6aa1d90dda02a91cba9db368841124921327a02595dbf6d23c945e1d
[INFO] running `"docker" "start" "-a" "061ca9ab6aa1d90dda02a91cba9db368841124921327a02595dbf6d23c945e1d"`
[INFO] [stderr]    Compiling rascal v1.2.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.33s
[INFO] running `"docker" "inspect" "061ca9ab6aa1d90dda02a91cba9db368841124921327a02595dbf6d23c945e1d"`
[INFO] running `"docker" "rm" "-f" "061ca9ab6aa1d90dda02a91cba9db368841124921327a02595dbf6d23c945e1d"`
[INFO] [stdout] 061ca9ab6aa1d90dda02a91cba9db368841124921327a02595dbf6d23c945e1d
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-4/master#c8865d8e195813ade6b84434ac9f8850e7112d1a:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/gh/tylerlaberge/rascal:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "test" "--frozen"`
[INFO] [stdout] 658dd618cf1ca2719611c4c9a158dd874bb06c89c39dfc3d5f2160380e87bde3
[INFO] running `"docker" "start" "-a" "658dd618cf1ca2719611c4c9a158dd874bb06c89c39dfc3d5f2160380e87bde3"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/rascal-08bdc5b1454c072a
[INFO] [stdout] 
[INFO] [stdout] running 154 tests
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_declarations ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_formal_parameter_list ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_formal_parameters ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_compound ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_call_parameters ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_block ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_binop_expr ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_function_call ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_function_declaration ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_group_expr ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_if_statement ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_literal ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_assignment ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_procedure_declaration ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_program ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_unaryop_expr ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_variable ... ok
[INFO] [stdout] test analyzer::semantic_analyzer::tests::visit_variable_declaration ... ok
[INFO] [stdout] test analyzer::symbol_table::tests::enclosing_lookup ... ok
[INFO] [stdout] test analyzer::symbol_table::tests::local_lookup ... ok
[INFO] [stdout] test analyzer::symbol_table::tests::lookup ... ok
[INFO] [stdout] test interpreter::built_ins::tests::int_to_string ... ok
[INFO] [stdout] test interpreter::built_ins::tests::real_to_string ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_declarations ... ok
[INFO] [stdout] test interpreter::built_ins::tests::string_to_int ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_assignment ... ok
[INFO] [stdout] test interpreter::built_ins::tests::string_to_real ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_formal_parameter_list ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_binop ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_compound ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_block ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_function_call ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_if_statement ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_function_declaration ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_group ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_procedure_declaration ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_program ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_formal_parameters ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_unaryop ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_variable ... ok
[INFO] [stdout] test interpreter::object::tests::add_float ... ok
[INFO] [stdout] test interpreter::object::tests::add_integer ... ok
[INFO] [stdout] test interpreter::object::tests::add_string ... ok
[INFO] [stdout] test interpreter::object::tests::and_false ... ok
[INFO] [stdout] test interpreter::object::tests::and_mismatch ... ok
[INFO] [stdout] test interpreter::object::tests::and_true ... ok
[INFO] [stdout] test interpreter::object::tests::divide_float ... ok
[INFO] [stdout] test interpreter::object::tests::divide_integer ... ok
[INFO] [stdout] test interpreter::object::tests::equal_float ... ok
[INFO] [stdout] test interpreter::object::tests::equal_integer ... ok
[INFO] [stdout] test interpreter::object::tests::greater_than_float ... ok
[INFO] [stdout] test interpreter::object::tests::greater_than_integer ... ok
[INFO] [stdout] test interpreter::object::tests::greater_than_or_equal_float ... ok
[INFO] [stdout] test interpreter::object::tests::greater_than_or_equal_integer ... ok
[INFO] [stdout] test interpreter::object::tests::less_than_float ... ok
[INFO] [stdout] test interpreter::object::tests::less_than_integer ... ok
[INFO] [stdout] test interpreter::object::tests::less_than_or_equal_float ... ok
[INFO] [stdout] test interpreter::object::tests::less_than_or_equal_integer ... ok
[INFO] [stdout] test interpreter::object::tests::multiply_float ... ok
[INFO] [stdout] test interpreter::object::tests::multiply_integer ... ok
[INFO] [stdout] test interpreter::object::tests::negate_false ... ok
[INFO] [stdout] test interpreter::object::tests::negate_true ... ok
[INFO] [stdout] test interpreter::object::tests::not_equal_float ... ok
[INFO] [stdout] test interpreter::object::tests::not_equal_integer ... ok
[INFO] [stdout] test interpreter::object::tests::or_false ... ok
[INFO] [stdout] test interpreter::object::tests::or_mismatch ... ok
[INFO] [stdout] test interpreter::object::tests::or_true ... ok
[INFO] [stdout] test interpreter::object::tests::subtract_float ... ok
[INFO] [stdout] test interpreter::object::tests::subtract_integer ... ok
[INFO] [stdout] test interpreter::object::tests::unary_minus_float ... ok
[INFO] [stdout] test interpreter::object::tests::unary_minus_integer ... ok
[INFO] [stdout] test interpreter::object::tests::unary_plus_float ... ok
[INFO] [stdout] test interpreter::object::tests::unary_plus_integer ... ok
[INFO] [stdout] test interpreter::scope::tests::get ... ok
[INFO] [stdout] test interpreter::scope::tests::get_enclosing_scope ... ok
[INFO] [stdout] test interpreter::scope::tests::get_local_scope ... ok
[INFO] [stdout] test lexer::lexer::tests::and_token ... ok
[INFO] [stdout] test lexer::lexer::tests::assign_token ... ok
[INFO] [stdout] test lexer::lexer::tests::begin_token ... ok
[INFO] [stdout] test lexer::lexer::tests::boolean_const_token ... ok
[INFO] [stdout] test lexer::lexer::tests::boolean_token ... ok
[INFO] [stdout] test lexer::lexer::tests::colon_token ... ok
[INFO] [stdout] test lexer::lexer::tests::comma_token ... ok
[INFO] [stdout] test lexer::lexer::tests::dot_token ... ok
[INFO] [stdout] test lexer::lexer::tests::else_token ... ok
[INFO] [stdout] test lexer::lexer::tests::end_token ... ok
[INFO] [stdout] test lexer::lexer::tests::eof_token ... ok
[INFO] [stdout] test lexer::lexer::tests::function_token ... ok
[INFO] [stdout] test lexer::lexer::tests::float_div_token ... ok
[INFO] [stdout] test lexer::lexer::tests::equal_token ... ok
[INFO] [stdout] test lexer::lexer::tests::greater_than_or_equal_token ... ok
[INFO] [stdout] test lexer::lexer::tests::greater_than_token ... ok
[INFO] [stdout] test lexer::lexer::tests::id_token ... ok
[INFO] [stdout] test lexer::lexer::tests::if_token ... ok
[INFO] [stdout] test interpreter::interpreter::tests::visit_literal ... ok
[INFO] [stdout] test lexer::lexer::tests::minus_token ... ok
[INFO] [stdout] test lexer::lexer::tests::multiply_token ... ok
[INFO] [stdout] test lexer::lexer::tests::not_equal_token ... ok
[INFO] [stdout] test lexer::lexer::tests::not_token ... ok
[INFO] [stdout] test lexer::lexer::tests::plus_token ... ok
[INFO] [stdout] test lexer::lexer::tests::or_token ... ok
[INFO] [stdout] test lexer::lexer::tests::program_token ... ok
[INFO] [stdout] test lexer::lexer::tests::procedure_token ... ok
[INFO] [stdout] test lexer::lexer::tests::real_const_token ... ok
[INFO] [stdout] test lexer::lexer::tests::real_token ... ok
[INFO] [stdout] test lexer::lexer::tests::integer_token ... ok
[INFO] [stdout] test lexer::lexer::tests::integer_div_token ... ok
[INFO] [stdout] test lexer::lexer::tests::integer_const_token ... ok
[INFO] [stdout] test lexer::lexer::tests::right_paren_token ... ok
[INFO] [stdout] test lexer::lexer::tests::semi_token ... ok
[INFO] [stdout] test lexer::lexer::tests::string_literal_token ... ok
[INFO] [stdout] test lexer::lexer::tests::string_token ... ok
[INFO] [stdout] test lexer::lexer::tests::then_token ... ok
[INFO] [stdout] test lexer::lexer::tests::var_token ... ok
[INFO] [stdout] test lexer::source::tests::current_char ... ok
[INFO] [stdout] test lexer::source::tests::next ... ok
[INFO] [stdout] test lexer::source::tests::peek ... ok
[INFO] [stdout] test lexer::source::tests::peeking_next ... ok
[INFO] [stdout] test parser::parser::tests::assignment_statement ... ok
[INFO] [stdout] test lexer::token::tests::peek ... ok
[INFO] [stdout] test lexer::token::tests::next ... ok
[INFO] [stdout] test lexer::token::tests::peek_ahead ... ok
[INFO] [stdout] test parser::parser::tests::call_parameters ... ok
[INFO] [stdout] test parser::parser::tests::compound_statement ... ok
[INFO] [stdout] test parser::parser::tests::declarations ... ok
[INFO] [stdout] test parser::parser::tests::expr_binary_add ... ok
[INFO] [stdout] test parser::parser::tests::expr_binary_multiply ... ok
[INFO] [stdout] test parser::parser::tests::expr_binary_subtract ... ok
[INFO] [stdout] test parser::parser::tests::expr_binary_int_divide ... ok
[INFO] [stdout] test parser::parser::tests::expr_binary_float_divide ... ok
[INFO] [stdout] test parser::parser::tests::expr_literal ... ok
[INFO] [stdout] test parser::parser::tests::expr_function_call ... ok
[INFO] [stdout] test parser::parser::tests::expr_grouped ... ok
[INFO] [stdout] test parser::parser::tests::expr_unary_minus ... ok
[INFO] [stdout] test parser::parser::tests::block ... ok
[INFO] [stdout] test lexer::lexer::tests::left_paren_token ... ok
[INFO] [stdout] test lexer::lexer::tests::less_than_token ... ok
[INFO] [stdout] test lexer::lexer::tests::less_than_or_equal_token ... ok
[INFO] [stdout] test parser::parser::tests::formal_parameters_list ... ok
[INFO] [stdout] test parser::parser::tests::formal_parameters ... ok
[INFO] [stdout] test parser::parser::tests::expr_variable ... ok
[INFO] [stdout] test parser::parser::tests::expr_unary_plus ... ok
[INFO] [stdout] test parser::parser::tests::function_declaration ... ok
[INFO] [stderr]      Running /opt/crater/target/debug/deps/rascal-4d411a66767f120c
[INFO] [stdout] test parser::parser::tests::function_call ... ok
[INFO] [stderr]    Doc-tests rascal
[INFO] [stdout] test parser::parser::tests::if_else_if_statement ... ok
[INFO] [stdout] test parser::parser::tests::if_statement ... ok
[INFO] [stdout] test parser::parser::tests::parse ... ok
[INFO] [stdout] test parser::parser::tests::procedure_declaration ... ok
[INFO] [stdout] test parser::parser::tests::if_else_if_else_statement ... ok
[INFO] [stdout] test parser::parser::tests::if_else_statement ... ok
[INFO] [stdout] test parser::parser::tests::program ... ok
[INFO] [stdout] test parser::parser::tests::type_spec ... ok
[INFO] [stdout] test parser::parser::tests::variable ... ok
[INFO] [stdout] test parser::parser::tests::variable_declaration ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 154 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[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
[INFO] [stdout] 
[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
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "658dd618cf1ca2719611c4c9a158dd874bb06c89c39dfc3d5f2160380e87bde3"`
[INFO] running `"docker" "rm" "-f" "658dd618cf1ca2719611c4c9a158dd874bb06c89c39dfc3d5f2160380e87bde3"`
[INFO] [stdout] 658dd618cf1ca2719611c4c9a158dd874bb06c89c39dfc3d5f2160380e87bde3