Dec 13 06:25:35.426 INFO testing razielgn/ostrov against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 13 06:25:35.426 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 06:25:35.867 INFO [stdout] a680163dde5275569e481fe7ba79d3cfc36dcb9db399fea29264d54e18c9b52e
Dec 13 06:25:35.867 INFO running `"docker" "start" "-a" "a680163dde5275569e481fe7ba79d3cfc36dcb9db399fea29264d54e18c9b52e"`
Dec 13 06:25:37.522 INFO [stderr] usermod: no changes
Dec 13 06:25:37.659 INFO [stderr]    Compiling nom v4.0.0
Dec 13 06:25:41.271 INFO [stderr]    Compiling nom_locate v0.3.0
Dec 13 06:25:42.097 INFO [stderr]    Compiling ostrov v0.0.1 (/source)
Dec 13 06:25:45.959 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.39s
Dec 13 06:25:45.959 INFO [stderr] su: No module specific data is present
Dec 13 06:25:46.706 INFO running `"docker" "inspect" "a680163dde5275569e481fe7ba79d3cfc36dcb9db399fea29264d54e18c9b52e"`
Dec 13 06:25:46.984 INFO running `"docker" "rm" "-f" "a680163dde5275569e481fe7ba79d3cfc36dcb9db399fea29264d54e18c9b52e"`
Dec 13 06:25:47.203 INFO [stdout] a680163dde5275569e481fe7ba79d3cfc36dcb9db399fea29264d54e18c9b52e
Dec 13 06:25:47.205 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 06:25:47.593 INFO [stdout] 4d588410dbf8a18d8ed43c9259fd5357de21b821af2af0b4c2b17d03f872afb9
Dec 13 06:25:47.600 INFO running `"docker" "start" "-a" "4d588410dbf8a18d8ed43c9259fd5357de21b821af2af0b4c2b17d03f872afb9"`
Dec 13 06:25:48.756 INFO [stderr] usermod: no changes
Dec 13 06:25:48.808 INFO [stderr]    Compiling ostrov v0.0.1 (/source)
Dec 13 06:25:49.439 INFO [stderr] warning: function `length_BadArity` should have a snake case name such as `length_bad_arity`
Dec 13 06:25:49.439 INFO [stderr]   --> tests/eval_list_procedures.rs:19:1
Dec 13 06:25:49.439 INFO [stderr]    |
Dec 13 06:25:49.439 INFO [stderr] 19 | / fn length_BadArity() {
Dec 13 06:25:49.439 INFO [stderr] 20 | |     assert_eval_err("(length '() '())", BadArity(Some("length".into())));
Dec 13 06:25:49.439 INFO [stderr] 21 | | }
Dec 13 06:25:49.439 INFO [stderr]    | |_^
Dec 13 06:25:49.439 INFO [stderr]    |
Dec 13 06:25:49.439 INFO [stderr]    = note: #[warn(non_snake_case)] on by default
Dec 13 06:25:49.439 INFO [stderr] 
Dec 13 06:25:54.245 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.45s
Dec 13 06:25:54.247 INFO [stderr] su: No module specific data is present
Dec 13 06:25:55.032 INFO running `"docker" "inspect" "4d588410dbf8a18d8ed43c9259fd5357de21b821af2af0b4c2b17d03f872afb9"`
Dec 13 06:25:55.303 INFO running `"docker" "rm" "-f" "4d588410dbf8a18d8ed43c9259fd5357de21b821af2af0b4c2b17d03f872afb9"`
Dec 13 06:25:55.612 INFO [stdout] 4d588410dbf8a18d8ed43c9259fd5357de21b821af2af0b4c2b17d03f872afb9
Dec 13 06:25:55.690 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 06:25:56.111 INFO [stdout] 0946fb75ec1c26691a91a6fe6c6254fcecfaf16beb7ca3e22b51d397857319b6
Dec 13 06:25:56.117 INFO running `"docker" "start" "-a" "0946fb75ec1c26691a91a6fe6c6254fcecfaf16beb7ca3e22b51d397857319b6"`
Dec 13 06:25:57.217 INFO [stderr] usermod: no changes
Dec 13 06:25:57.307 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 13 06:25:57.307 INFO [stderr]      Running /target/debug/deps/ostrov-231398b686dad783
Dec 13 06:25:57.311 INFO [stdout] 
Dec 13 06:25:57.311 INFO [stdout] running 50 tests
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::constants_values_boolean ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::and ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::define_with_lambda_variable ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::function_application ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::define_with_lambda_fixed ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::constants_values_one_integer ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::define_with_nothing ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::define_with_constant ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::if_one_arg ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::if_two_args ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::lambda_any ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::lambda_fixed ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::lambda_variable ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::let_ ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::quote ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::set_bang ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::or ... ok
Dec 13 06:25:57.311 INFO [stdout] test compiler::test::variable_referencing ... ok
Dec 13 06:25:57.319 INFO [stdout] test env::test::set_and_get_ok ... ok
Dec 13 06:25:57.335 INFO [stdout] test env::test::set_and_get_none ... ok
Dec 13 06:25:57.335 INFO [stdout] test parser::test::booleans ... ok
Dec 13 06:25:57.335 INFO [stdout] test env::test::wraps ... ok
Dec 13 06:25:57.335 INFO [stdout] test parser::test::dotted_list ... ok
Dec 13 06:25:57.335 INFO [stdout] test parser::test::integers ... ok
Dec 13 06:25:57.335 INFO [stdout] test parser::test::atoms ... ok
Dec 13 06:25:57.343 INFO [stdout] test values::test::booleans ... ok
Dec 13 06:25:57.343 INFO [stdout] test values::test::atoms ... ok
Dec 13 06:25:57.343 INFO [stdout] test parser::test::no_expressions ... ok
Dec 13 06:25:57.347 INFO [stdout] test compiler::test::constants_values_two_integers ... ok
Dec 13 06:25:57.347 INFO [stdout] test parser::test::quoted_literals ... ok
Dec 13 06:25:57.347 INFO [stdout] test compiler::test::define_with_lambda_any ... ok
Dec 13 06:25:57.347 INFO [stdout] test parser::test::lists ... ok
Dec 13 06:25:57.347 INFO [stdout] test parser::test::multiple_expressions ... ok
Dec 13 06:25:57.347 INFO [stdout] test values::test::closures ... ok
Dec 13 06:25:57.347 INFO [stdout] test values::test::primitive_fns ... ok
Dec 13 06:25:57.347 INFO [stdout] test values::test::unspecified ... ok
Dec 13 06:25:57.347 INFO [stdout] test vm::test::execute_apply ... ok
Dec 13 06:25:57.347 INFO [stdout] test vm::test::execute_argument ... ok
Dec 13 06:25:57.347 INFO [stdout] test vm::test::execute_assignment ... ok
Dec 13 06:25:57.347 INFO [stdout] test vm::test::execute_jump_on_false ... ok
Dec 13 06:25:57.347 INFO [stdout] test vm::test::execute_jump_on_true ... ok
Dec 13 06:25:57.347 INFO [stdout] test vm::test::execute_jump ... ok
Dec 13 06:25:57.347 INFO [stdout] test vm::test::execute_load_constant ... ok
Dec 13 06:25:57.347 INFO [stdout] test values::test::nil ... ok
Dec 13 06:25:57.347 INFO [stdout] test values::test::pairs ... ok
Dec 13 06:25:57.347 INFO [stdout] test values::test::integers ... ok
Dec 13 06:25:57.347 INFO [stdout] test vm::test::execute_load_reference ... ok
Dec 13 06:25:57.347 INFO [stdout] test vm::test::execute_nested_arguments ... ok
Dec 13 06:25:57.347 INFO [stdout] test vm::test::execute_load_unspecified ... ok
Dec 13 06:25:57.348 INFO [stdout] test vm::test::illegal_frame_apply ... ok
Dec 13 06:25:57.348 INFO [stdout] 
Dec 13 06:25:57.348 INFO [stdout] test result: ok. 50 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 06:25:57.348 INFO [stdout] 
Dec 13 06:25:57.351 INFO [stderr]      Running /target/debug/deps/tests-ce517c49523161af
Dec 13 06:25:57.352 INFO [stdout] 
Dec 13 06:25:57.352 INFO [stdout] running 74 tests
Dec 13 06:25:57.352 INFO [stdout] test eval_application::integers ... ok
Dec 13 06:25:57.352 INFO [stdout] test eval_application::expressions_in_first_position ... ok
Dec 13 06:25:57.352 INFO [stdout] test eval_application::dotted_lists ... ok
Dec 13 06:25:57.352 INFO [stdout] test eval_application::booleans ... ok
Dec 13 06:25:57.354 INFO [stdout] test eval_application::atoms ... ok
Dec 13 06:25:57.363 INFO [stdout] test eval_application::lists ... ok
Dec 13 06:25:57.363 INFO [stdout] test eval_application::lambda_with_variable_arguments_number ... ok
Dec 13 06:25:57.363 INFO [stdout] test eval_application::lambda_with_variable_arguments_number_bad_arity ... ok
Dec 13 06:25:57.363 INFO [stdout] test eval_application::lambda_with_fixed_arguments_number_bad_arity ... ok
Dec 13 06:25:57.363 INFO [stdout] test eval_application::procedure_with_mismatched_arity ... ignored
Dec 13 06:25:57.372 INFO [stdout] test eval_application::procedure_with_two_args ... ok
Dec 13 06:25:57.373 INFO [stdout] test eval_application::lambda_with_fixed_arguments_number ... ok
Dec 13 06:25:57.379 INFO [stdout] test eval_application::lambda_with_any_arguments_number ... ok
Dec 13 06:25:57.379 INFO [stdout] test eval_application::procedure_with_any_args ... ok
Dec 13 06:25:57.379 INFO [stdout] test eval_application::procedure_with_one_arg ... ok
Dec 13 06:25:57.379 INFO [stdout] test eval_application::lambda_multiple_expressions_are_evaluated_sequentially ... ok
Dec 13 06:25:57.379 INFO [stdout] test eval_application::procedure_with_two_args_previous_scoping_is_kept ... ok
Dec 13 06:25:57.379 INFO [stdout] test eval_application::procedure_with_no_args ... ok
Dec 13 06:25:57.379 INFO [stdout] test eval_application::procedure_with_two_args_scoping ... ok
Dec 13 06:25:57.379 INFO [stdout] test eval_application::procedure_with_var_args ... ok
Dec 13 06:25:57.379 INFO [stdout] test eval_assignment::overwrites_variables ... ok
Dec 13 06:25:57.379 INFO [stdout] test eval_assignment::malformed_variable_name ... ok
Dec 13 06:25:57.391 INFO [stdout] test eval_assignment::overwrites_variables_in_captured_scopes ... ok
Dec 13 06:25:57.391 INFO [stdout] test eval_boolean_procedures::and ... ok
Dec 13 06:25:57.391 INFO [stdout] test eval_assignment::unknown_variable ... ok
Dec 13 06:25:57.391 INFO [stdout] test eval_assignment::wrong_arguments_number ... ok
Dec 13 06:25:57.391 INFO [stdout] test eval_boolean_procedures::not_bad_arity ... ok
Dec 13 06:25:57.391 INFO [stdout] test eval_boolean_procedures::not ... ok
Dec 13 06:25:57.391 INFO [stdout] test eval_assignment::returns_expression ... ok
Dec 13 06:25:57.395 INFO [stdout] test eval_assignment::overwrites_variables_on_upper_scopes ... ok
Dec 13 06:25:57.399 INFO [stdout] test eval_definitions::define_procedure_with_any ... ok
Dec 13 06:25:57.399 INFO [stdout] test eval_conditionals::if_bad_arity ... ok
Dec 13 06:25:57.399 INFO [stdout] test eval_conditionals::if_with_two_args ... ok
Dec 13 06:25:57.399 INFO [stdout] test eval_definitions::define_bad_arity ... ok
Dec 13 06:25:57.399 INFO [stdout] test eval_conditionals::if_with_one_arg ... ok
Dec 13 06:25:57.399 INFO [stdout] test eval_boolean_procedures::or ... ok
Dec 13 06:25:57.399 INFO [stdout] test eval_definitions::define_procedure_with_fixed_args ... ok
Dec 13 06:25:57.399 INFO [stdout] test eval_definitions::define_procedure_with_varargs ... ok
Dec 13 06:25:57.402 INFO [stdout] test eval_integer_procedures::division ... ok
Dec 13 06:25:57.402 INFO [stdout] test eval_integer_procedures::division_bad_arity ... ok
Dec 13 06:25:57.402 INFO [stdout] test eval_definitions::define_with_two_args ... ok
Dec 13 06:25:57.402 INFO [stdout] test eval_definitions::define_with_one_arg ... ok
Dec 13 06:25:57.402 INFO [stdout] test eval_definitions::define_with_one_arg_lambda ... ok
Dec 13 06:25:57.419 INFO [stdout] test eval_integer_procedures::equal_sign ... ok
Dec 13 06:25:57.419 INFO [stdout] test eval_integer_procedures::minus ... ok
Dec 13 06:25:57.419 INFO [stdout] test eval_integer_procedures::plus ... ok
Dec 13 06:25:57.431 INFO [stdout] test eval_integer_procedures::product ... ok
Dec 13 06:25:57.431 INFO [stdout] test eval_integer_procedures::minus_bad_arity ... ok
Dec 13 06:25:57.431 INFO [stdout] test eval_integer_procedures::greater_than_sign ... ok
Dec 13 06:25:57.431 INFO [stdout] test eval_integer_procedures::greater_than_or_equal_sign ... ok
Dec 13 06:25:57.431 INFO [stdout] test eval_lets::bad_arity_ ... ok
Dec 13 06:25:57.431 INFO [stdout] test eval_integer_procedures::less_than_or_equal_sign ... ok
Dec 13 06:25:57.431 INFO [stdout] test eval_integer_procedures::less_than_sign ... ok
Dec 13 06:25:57.431 INFO [stdout] test eval_integer_procedures::plus_bad_arity ... ok
Dec 13 06:25:57.431 INFO [stdout] test eval_list_procedures::cdr_wrong_argument_type ... ok
Dec 13 06:25:57.435 INFO [stdout] test eval_lets::malformed ... ok
Dec 13 06:25:57.435 INFO [stdout] test eval_list_procedures::cdr_bad_arity ... ok
Dec 13 06:25:57.435 INFO [stdout] test eval_list_procedures::cons_bad_arity ... ok
Dec 13 06:25:57.435 INFO [stdout] test eval_list_procedures::cdr ... ok
Dec 13 06:25:57.435 INFO [stdout] test eval_list_procedures::length ... ok
Dec 13 06:25:57.435 INFO [stdout] test eval_list_procedures::list_ ... ok
Dec 13 06:25:57.435 INFO [stdout] test eval_list_procedures::list_question_mark ... ok
Dec 13 06:25:57.435 INFO [stdout] test eval_list_procedures::list_question_mark_bad_arity ... ok
Dec 13 06:25:57.439 INFO [stdout] test eval_list_procedures::null ... ok
Dec 13 06:25:57.439 INFO [stdout] test eval_list_procedures::length_BadArity ... ok
Dec 13 06:25:57.447 INFO [stdout] test eval_list_procedures::length_bad_arguments ... ok
Dec 13 06:25:57.447 INFO [stdout] test eval_list_procedures::car ... ok
Dec 13 06:25:57.450 INFO [stdout] test eval_list_procedures::pair_bad_arity ... ok
Dec 13 06:25:57.450 INFO [stdout] test eval_list_procedures::null_bad_arity ... ok
Dec 13 06:25:57.450 INFO [stdout] test eval_list_procedures::car_bad_arity ... ok
Dec 13 06:25:57.450 INFO [stdout] test eval_lets::one_definition ... ok
Dec 13 06:25:57.450 INFO [stdout] test eval_list_procedures::car_wrong_argument_type ... ok
Dec 13 06:25:57.450 INFO [stdout] test eval_list_procedures::pair_ ... ok
Dec 13 06:25:57.452 INFO [stdout] test eval_list_procedures::cons ... ok
Dec 13 06:25:57.452 INFO [stdout] 
Dec 13 06:25:57.452 INFO [stdout] test result: ok. 73 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 13 06:25:57.452 INFO [stdout] 
Dec 13 06:25:57.458 INFO [stderr] su: No module specific data is present
Dec 13 06:25:58.087 INFO running `"docker" "inspect" "0946fb75ec1c26691a91a6fe6c6254fcecfaf16beb7ca3e22b51d397857319b6"`
Dec 13 06:25:58.384 INFO running `"docker" "rm" "-f" "0946fb75ec1c26691a91a6fe6c6254fcecfaf16beb7ca3e22b51d397857319b6"`
Dec 13 06:25:58.546 INFO [stdout] 0946fb75ec1c26691a91a6fe6c6254fcecfaf16beb7ca3e22b51d397857319b6