Nov 17 21:00:40.228 INFO testing tera-0.11.17 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 17 21:00:40.230 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 21:00:40.685 INFO [stdout] c09dc4854bbd565741180a95079f0213868f643162ac1887a78b3072bb800653
Nov 17 21:00:40.687 INFO running `"docker" "start" "-a" "c09dc4854bbd565741180a95079f0213868f643162ac1887a78b3072bb800653"`
Nov 17 21:00:42.639 INFO [stderr] usermod: no changes
Nov 17 21:00:42.815 INFO [stderr]    Compiling tera v0.11.17 (/source)
Nov 17 21:00:58.631 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 15.97s
Nov 17 21:00:58.639 INFO [stderr] su: No module specific data is present
Nov 17 21:00:59.351 INFO running `"docker" "inspect" "c09dc4854bbd565741180a95079f0213868f643162ac1887a78b3072bb800653"`
Nov 17 21:00:59.589 INFO running `"docker" "rm" "-f" "c09dc4854bbd565741180a95079f0213868f643162ac1887a78b3072bb800653"`
Nov 17 21:01:00.051 INFO [stdout] c09dc4854bbd565741180a95079f0213868f643162ac1887a78b3072bb800653
Nov 17 21:01:00.058 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 21:01:00.532 INFO [stdout] 56f70d6f170fc8e90a3f562ce338fd79136aec7db5a7b71f746a56174d020558
Nov 17 21:01:00.541 INFO running `"docker" "start" "-a" "56f70d6f170fc8e90a3f562ce338fd79136aec7db5a7b71f746a56174d020558"`
Nov 17 21:01:01.579 INFO [stderr] usermod: no changes
Nov 17 21:01:01.770 INFO [stderr]    Compiling pretty_assertions v0.5.1
Nov 17 21:01:02.597 INFO [stderr]    Compiling tera v0.11.17 (/source)
Nov 17 21:01:25.214 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 23.61s
Nov 17 21:01:25.227 INFO [stderr] su: No module specific data is present
Nov 17 21:01:25.611 INFO running `"docker" "inspect" "56f70d6f170fc8e90a3f562ce338fd79136aec7db5a7b71f746a56174d020558"`
Nov 17 21:01:25.790 INFO running `"docker" "rm" "-f" "56f70d6f170fc8e90a3f562ce338fd79136aec7db5a7b71f746a56174d020558"`
Nov 17 21:01:25.901 INFO [stdout] 56f70d6f170fc8e90a3f562ce338fd79136aec7db5a7b71f746a56174d020558
Nov 17 21:01:25.905 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 21:01:26.201 INFO [stdout] 82ed00bf3facccd82ae59715f204d08168c71442a2046c9accaef5713d461871
Nov 17 21:01:26.203 INFO running `"docker" "start" "-a" "82ed00bf3facccd82ae59715f204d08168c71442a2046c9accaef5713d461871"`
Nov 17 21:01:26.645 INFO [stderr] usermod: no changes
Nov 17 21:01:26.734 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Nov 17 21:01:26.748 INFO [stderr]      Running /target/debug/deps/tera-be33e50130ff7793
Nov 17 21:01:26.751 INFO [stdout] 
Nov 17 21:01:26.751 INFO [stdout] running 314 tests
Nov 17 21:01:26.756 INFO [stdout] test builtins::filters::array::tests::test_first_empty ... ok
Nov 17 21:01:26.756 INFO [stdout] test builtins::filters::array::tests::test_first ... ok
Nov 17 21:01:26.756 INFO [stdout] test builtins::filters::array::tests::test_join_sep ... ok
Nov 17 21:01:26.756 INFO [stdout] test builtins::filters::array::tests::test_filter ... ok
Nov 17 21:01:26.756 INFO [stdout] test builtins::filters::array::tests::test_group_by_nested_key ... ok
Nov 17 21:01:26.757 INFO [stdout] test builtins::filters::array::tests::test_join_empty ... ok
Nov 17 21:01:26.757 INFO [stdout] test builtins::filters::array::tests::test_join_sep_omitted ... ok
Nov 17 21:01:26.757 INFO [stdout] test builtins::filters::array::tests::test_group_by ... ok
Nov 17 21:01:26.757 INFO [stdout] test builtins::filters::array::tests::test_sort_empty ... ok
Nov 17 21:01:26.757 INFO [stdout] test builtins::filters::array::tests::test_sort_attribute ... ok
Nov 17 21:01:26.757 INFO [stdout] test builtins::filters::array::tests::test_sort_invalid_attribute ... ok
Nov 17 21:01:26.757 INFO [stdout] test builtins::filters::array::tests::test_sort_tuple ... ok
Nov 17 21:01:26.757 INFO [stdout] test builtins::filters::common::tests::as_str_object ... ok
Nov 17 21:01:26.758 INFO [stdout] test builtins::filters::common::tests::date_custom_format ... ok
Nov 17 21:01:26.758 INFO [stdout] test builtins::filters::common::tests::date_default ... ok
Nov 17 21:01:26.758 INFO [stdout] test builtins::filters::common::tests::date_from_naive_datetime ... ok
Nov 17 21:01:26.758 INFO [stdout] test builtins::filters::common::tests::date_rfc3339 ... ok
Nov 17 21:01:26.758 INFO [stdout] test builtins::filters::common::tests::date_rfc3339_preserves_timezone ... ok
Nov 17 21:01:26.758 INFO [stdout] test builtins::filters::common::tests::date_yyyy_mm_dd ... ok
Nov 17 21:01:26.758 INFO [stdout] test builtins::filters::common::tests::length_num ... ok
Nov 17 21:01:26.759 INFO [stdout] test builtins::filters::common::tests::length_str ... ok
Nov 17 21:01:26.759 INFO [stdout] test builtins::filters::array::tests::test_last ... ok
Nov 17 21:01:26.759 INFO [stdout] test builtins::filters::array::tests::test_last_empty ... ok
Nov 17 21:01:26.759 INFO [stdout] test builtins::filters::common::tests::reverse_num ... ok
Nov 17 21:01:26.762 INFO [stdout] test builtins::filters::common::tests::length_vec ... ok
Nov 17 21:01:26.762 INFO [stdout] test builtins::filters::array::tests::test_slice ... ok
Nov 17 21:01:26.762 INFO [stdout] test builtins::filters::array::tests::test_sort ... ok
Nov 17 21:01:26.762 INFO [stdout] test builtins::filters::common::tests::reverse_vec ... ok
Nov 17 21:01:26.762 INFO [stdout] test builtins::filters::common::tests::test_json_encode ... ok
Nov 17 21:01:26.762 INFO [stdout] test builtins::filters::common::tests::test_json_encode_pretty ... ok
Nov 17 21:01:26.763 INFO [stdout] test builtins::filters::number::tests::test_pluralize_multiple ... ok
Nov 17 21:01:26.763 INFO [stdout] test builtins::filters::number::tests::test_pluralize_multiple_custom_suffix ... ok
Nov 17 21:01:26.763 INFO [stdout] test builtins::filters::number::tests::test_pluralize_single ... ok
Nov 17 21:01:26.763 INFO [stdout] test builtins::filters::number::tests::test_filesizeformat ... ok
Nov 17 21:01:26.763 INFO [stdout] test builtins::filters::number::tests::test_pluralize_zero ... ok
Nov 17 21:01:26.763 INFO [stdout] test builtins::filters::number::tests::test_round_ceil ... ok
Nov 17 21:01:26.763 INFO [stdout] test builtins::filters::number::tests::test_round_default ... ok
Nov 17 21:01:26.763 INFO [stdout] test builtins::filters::number::tests::test_round_ceil_precision ... ok
Nov 17 21:01:26.765 INFO [stdout] test builtins::filters::number::tests::test_round_default_precision ... ok
Nov 17 21:01:26.765 INFO [stdout] test builtins::filters::number::tests::test_round_floor ... ok
Nov 17 21:01:26.765 INFO [stdout] test builtins::filters::object::tests::test_get_filter_exists ... ok
Nov 17 21:01:26.765 INFO [stdout] test builtins::filters::object::tests::test_get_filter_doesnt_exist ... ok
Nov 17 21:01:26.765 INFO [stdout] test builtins::filters::string::tests::test_capitalize ... ok
Nov 17 21:01:26.765 INFO [stdout] test builtins::filters::string::tests::test_lower ... ok
Nov 17 21:01:26.766 INFO [stdout] test builtins::filters::string::tests::test_addslashes ... ok
Nov 17 21:01:26.766 INFO [stdout] test builtins::filters::string::tests::test_replace ... ok
Nov 17 21:01:26.766 INFO [stdout] test builtins::filters::number::tests::test_round_floor_precision ... ok
Nov 17 21:01:26.766 INFO [stdout] test builtins::filters::string::tests::test_split ... ok
Nov 17 21:01:26.767 INFO [stdout] test builtins::filters::string::tests::test_replace_missing_arg ... ok
Nov 17 21:01:26.767 INFO [stdout] test builtins::filters::common::tests::length_str_nonascii ... ok
Nov 17 21:01:26.767 INFO [stdout] test builtins::filters::common::tests::reverse_str ... ok
Nov 17 21:01:26.767 INFO [stdout] test builtins::filters::common::tests::as_str_vec ... ok
Nov 17 21:01:26.767 INFO [stdout] test builtins::filters::string::tests::test_trim ... ok
Nov 17 21:01:26.777 INFO [stdout] test builtins::filters::string::tests::test_truncate_custom_end ... ok
Nov 17 21:01:26.777 INFO [stdout] test builtins::filters::string::tests::test_truncate_multichar_grapheme ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::filters::string::tests::test_slugify ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::filters::array::tests::test_sort_multiple_types ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::filters::array::tests::test_sort_non_finite_numbers ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::filters::string::tests::test_urlencode ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::filters::string::tests::test_wordcount ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::functions::tests::now_default ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::functions::tests::now_timestamp ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::functions::tests::range_default ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::functions::tests::range_start ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::filters::string::tests::test_upper_error ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::functions::tests::range_start_greater_than_end ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::filters::string::tests::test_truncate_when_required ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::functions::tests::now_datetime_utc ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::functions::tests::throw_errors_with_message ... ok
Nov 17 21:01:26.778 INFO [stdout] test builtins::filters::string::tests::test_striptags ... ok
Nov 17 21:01:26.779 INFO [stdout] test builtins::functions::tests::range_step_by ... ok
Nov 17 21:01:26.780 INFO [stdout] test builtins::testers::tests::test_iterable ... ok
Nov 17 21:01:26.780 INFO [stdout] test builtins::testers::tests::test_number_args_ok ... ok
Nov 17 21:01:26.781 INFO [stdout] test builtins::testers::tests::test_ending_with ... ok
Nov 17 21:01:26.781 INFO [stdout] test builtins::filters::string::tests::test_upper ... ok
Nov 17 21:01:26.783 INFO [stdout] test builtins::testers::tests::test_too_many_args ... ok
Nov 17 21:01:26.783 INFO [stdout] test builtins::testers::tests::test_containing ... ok
Nov 17 21:01:26.783 INFO [stdout] test builtins::filters::string::tests::test_truncate_smaller_than_length ... ok
Nov 17 21:01:26.783 INFO [stdout] test builtins::testers::tests::test_value_defined ... ok
Nov 17 21:01:26.783 INFO [stdout] test builtins::testers::tests::test_divisible_by ... ok
Nov 17 21:01:26.783 INFO [stdout] test builtins::testers::tests::test_starting_with ... ok
Nov 17 21:01:26.784 INFO [stdout] test parser::tests::errors::invalid_elif ... ok
Nov 17 21:01:26.785 INFO [stdout] test context::tests::test_extend ... ok
Nov 17 21:01:26.785 INFO [stdout] test parser::tests::errors::invalid_extends_no_string ... ok
Nov 17 21:01:26.791 INFO [stdout] test parser::tests::errors::invalid_else ... ok
Nov 17 21:01:26.792 INFO [stdout] test parser::tests::errors::invalid_block_missing_name ... ok
Nov 17 21:01:26.792 INFO [stdout] test parser::tests::errors::invalid_filter_section_missing_name ... ok
Nov 17 21:01:26.792 INFO [stdout] test parser::tests::errors::invalid_continue_outside_loop ... ok
Nov 17 21:01:26.792 INFO [stdout] test parser::tests::errors::invalid_break_outside_loop ... ok
Nov 17 21:01:26.792 INFO [stdout] test parser::tests::errors::invalid_import_macros_missing_namespace ... ok
Nov 17 21:01:26.792 INFO [stdout] test parser::tests::errors::invalid_extends_position ... ok
Nov 17 21:01:26.792 INFO [stdout] test parser::tests::errors::invalid_macro_call ... ok
Nov 17 21:01:26.792 INFO [stdout] test parser::tests::errors::invalid_macro_default_arg_value ... ok
Nov 17 21:01:26.792 INFO [stdout] test parser::tests::errors::invalid_include_no_string ... ok
Nov 17 21:01:26.795 INFO [stdout] test parser::tests::errors::invalid_macro_content ... ok
Nov 17 21:01:26.796 INFO [stdout] test parser::tests::errors::invalid_op ... ok
Nov 17 21:01:26.797 INFO [stdout] test parser::tests::errors::invalid_number ... ok
Nov 17 21:01:26.797 INFO [stdout] test parser::tests::errors::invalid_operator ... ok
Nov 17 21:01:26.797 INFO [stdout] test parser::tests::errors::missing_container_name_in_forloop ... ok
Nov 17 21:01:26.798 INFO [stdout] test parser::tests::errors::missing_expression_with_not ... ok
Nov 17 21:01:26.798 INFO [stdout] test parser::tests::errors::invalid_test_argument ... ok
Nov 17 21:01:26.799 INFO [stdout] test parser::tests::errors::missing_expression_in_if ... ok
Nov 17 21:01:26.800 INFO [stdout] test parser::tests::errors::invalid_import_macros_missing_filename ... ok
Nov 17 21:01:26.800 INFO [stdout] test parser::tests::errors::unterminated_filter_section ... ok
Nov 17 21:01:26.800 INFO [stdout] test parser::tests::errors::unterminated_fn_call ... ok
Nov 17 21:01:26.805 INFO [stdout] test parser::tests::errors::missing_variable_name_in_set ... ok
Nov 17 21:01:26.805 INFO [stdout] test parser::tests::errors::missing_value_in_set ... ok
Nov 17 21:01:26.805 INFO [stdout] test parser::tests::errors::invalid_fn_call_missing_value ... ok
Nov 17 21:01:26.805 INFO [stdout] test parser::tests::errors::unterminated_extends ... ok
Nov 17 21:01:26.808 INFO [stdout] test parser::tests::errors::unterminated_include ... ok
Nov 17 21:01:26.808 INFO [stdout] test parser::tests::errors::unterminated_raw_tag ... ok
Nov 17 21:01:26.808 INFO [stdout] test parser::tests::errors::unterminated_test ... ok
Nov 17 21:01:26.814 INFO [stdout] test parser::tests::errors::unterminated_if_tag ... ok
Nov 17 21:01:26.814 INFO [stdout] test parser::tests::errors::unterminated_variable_block ... ok
Nov 17 21:01:26.814 INFO [stdout] test parser::tests::errors::wrong_end_block ... ok
Nov 17 21:01:26.816 INFO [stdout] test parser::tests::errors::unterminated_string ... ok
Nov 17 21:01:26.816 INFO [stdout] test parser::tests::errors::wrong_start_block ... ok
Nov 17 21:01:26.819 INFO [stdout] test parser::tests::lexer::lex_array ... ok
Nov 17 21:01:26.821 INFO [stdout] test parser::tests::errors::unterminated_macro_call ... ok
Nov 17 21:01:26.821 INFO [stdout] test parser::tests::lexer::lex_basic_expr ... ok
Nov 17 21:01:26.821 INFO [stdout] test parser::tests::lexer::lex_block_tag ... ok
Nov 17 21:01:26.821 INFO [stdout] test parser::tests::lexer::lex_comment_tag ... ok
Nov 17 21:01:26.826 INFO [stdout] test parser::tests::lexer::lex_basic_expr_with_filter ... ok
Nov 17 21:01:26.828 INFO [stdout] test parser::tests::lexer::lex_continue_tag ... ok
Nov 17 21:01:26.835 INFO [stdout] test parser::tests::lexer::lex_break_tag ... ok
Nov 17 21:01:26.836 INFO [stdout] test builtins::testers::tests::test_matching ... ok
Nov 17 21:01:26.836 INFO [stdout] test parser::tests::lexer::lex_dotted_square_bracket_ident ... ok
Nov 17 21:01:26.836 INFO [stdout] test parser::tests::lexer::lex_comparison_expr ... ok
Nov 17 21:01:26.837 INFO [stdout] test parser::tests::lexer::lex_elif_tag ... ok
Nov 17 21:01:26.837 INFO [stdout] test parser::tests::lexer::lex_boolean ... ok
Nov 17 21:01:26.837 INFO [stdout] test parser::tests::lexer::lex_extends_tag ... ok
Nov 17 21:01:26.838 INFO [stdout] test parser::tests::lexer::lex_float ... ok
Nov 17 21:01:26.838 INFO [stdout] test parser::tests::lexer::lex_else_tag ... ok
Nov 17 21:01:26.838 INFO [stdout] test parser::tests::lexer::lex_ident ... ok
Nov 17 21:01:26.843 INFO [stdout] test parser::tests::lexer::lex_filter ... ok
Nov 17 21:01:26.843 INFO [stdout] test parser::tests::lexer::lex_fn_call ... ok
Nov 17 21:01:26.844 INFO [stdout] test parser::tests::lexer::lex_dotted_ident ... ok
Nov 17 21:01:26.844 INFO [stdout] test parser::tests::lexer::lex_content ... ok
Nov 17 21:01:26.844 INFO [stdout] test parser::tests::lexer::lex_for_tag ... ok
Nov 17 21:01:26.844 INFO [stdout] test parser::tests::lexer::lex_int ... ok
Nov 17 21:01:26.845 INFO [stdout] test parser::tests::lexer::lex_if_tag ... ok
Nov 17 21:01:26.846 INFO [stdout] test builtins::filters::string::tests::test_title ... ok
Nov 17 21:01:26.847 INFO [stdout] test parser::tests::lexer::lex_include_tag ... ok
Nov 17 21:01:26.847 INFO [stdout] test parser::tests::lexer::lex_import_macro_tag ... ok
Nov 17 21:01:26.849 INFO [stdout] test parser::tests::lexer::lex_kwarg ... ok
Nov 17 21:01:26.851 INFO [stdout] test parser::tests::lexer::lex_set_global_tag ... ok
Nov 17 21:01:26.851 INFO [stdout] test parser::tests::lexer::lex_string ... ok
Nov 17 21:01:26.854 INFO [stdout] test parser::tests::lexer::lex_comparison_val ... ok
Nov 17 21:01:26.855 INFO [stdout] test parser::tests::lexer::lex_macro_tag ... ok
Nov 17 21:01:26.859 INFO [stdout] test parser::tests::lexer::lex_logic_expr ... ok
Nov 17 21:01:26.863 INFO [stdout] test parser::tests::lexer::lex_kwargs ... ok
Nov 17 21:01:26.863 INFO [stdout] test parser::tests::lexer::lex_template ... ok
Nov 17 21:01:26.867 INFO [stdout] test parser::tests::lexer::lex_test ... ok
Nov 17 21:01:26.867 INFO [stdout] test parser::tests::parser::parse_block ... ok
Nov 17 21:01:26.867 INFO [stdout] test parser::tests::parser::parse_break ... ok
Nov 17 21:01:26.867 INFO [stdout] test parser::tests::parser::parse_continue ... ok
Nov 17 21:01:26.869 INFO [stdout] test parser::tests::parser::parse_comments_before_extends ... ok
Nov 17 21:01:26.869 INFO [stdout] test parser::tests::parser::parse_comment_tag ... ok
Nov 17 21:01:26.869 INFO [stdout] test parser::tests::parser::parse_empty_template ... ok
Nov 17 21:01:26.869 INFO [stdout] test parser::tests::parser::parse_extends ... ok
Nov 17 21:01:26.869 INFO [stdout] test parser::tests::parser::parse_filter_section_without_args ... ok
Nov 17 21:01:26.869 INFO [stdout] test parser::tests::parser::parse_filter_section_with_args ... ok
Nov 17 21:01:26.869 INFO [stdout] test parser::tests::parser::parse_import_macro ... ok
Nov 17 21:01:26.869 INFO [stdout] test parser::tests::parser::parse_include_tag ... ok
Nov 17 21:01:26.869 INFO [stdout] test parser::tests::parser::parse_raw_tag ... ok
Nov 17 21:01:26.869 INFO [stdout] test parser::tests::parser::parse_set_array ... ok
Nov 17 21:01:26.869 INFO [stdout] test parser::tests::parser::parse_set_global_tag ... ok
Nov 17 21:01:26.869 INFO [stdout] test parser::tests::parser::parse_set_tag_fn_call ... ok
Nov 17 21:01:26.869 INFO [stdout] test parser::tests::lexer::lex_variable_tag ... ok
Nov 17 21:01:26.870 INFO [stdout] test parser::tests::parser::parse_key_value_forloop ... ok
Nov 17 21:01:26.870 INFO [stdout] test parser::tests::parser::parse_if ... ok
Nov 17 21:01:26.873 INFO [stdout] test parser::tests::lexer::lex_set_tag ... ok
Nov 17 21:01:26.873 INFO [stdout] test parser::tests::lexer::lex_macro_definition ... ok
Nov 17 21:01:26.873 INFO [stdout] test parser::tests::lexer::lex_string_concat ... ok
Nov 17 21:01:26.874 INFO [stdout] test parser::tests::parser::parse_set_tag_lit ... ok
Nov 17 21:01:26.874 INFO [stdout] test parser::tests::parser::parse_set_tag_macro_call ... ok
Nov 17 21:01:26.875 INFO [stdout] test parser::tests::parser::parse_simple_macro_definition ... ok
Nov 17 21:01:26.875 INFO [stdout] test parser::tests::lexer::lex_logic_val ... ok
Nov 17 21:01:26.875 INFO [stdout] test parser::tests::parser::parse_variable_math_on_filter ... ok
Nov 17 21:01:26.875 INFO [stdout] test parser::tests::parser::parse_value_forloop_array ... ok
Nov 17 21:01:26.876 INFO [stdout] test parser::tests::parser::parse_string_concat ... ok
Nov 17 21:01:26.876 INFO [stdout] test parser::tests::parser::parse_variable_tag_global_function ... ok
Nov 17 21:01:26.876 INFO [stdout] test parser::tests::parser::parse_variable_tag_global_function_with_filter ... ok
Nov 17 21:01:26.879 INFO [stdout] test parser::tests::parser::parse_variable_tag_ident ... ok
Nov 17 21:01:26.879 INFO [stdout] test parser::tests::parser::parse_variable_tag_ident_with_simple_filters ... ok
Nov 17 21:01:26.880 INFO [stdout] test parser::tests::parser::parse_variable_tag_lit ... ok
Nov 17 21:01:26.884 INFO [stdout] test parser::tests::parser::parse_text ... ok
Nov 17 21:01:26.884 INFO [stdout] test parser::tests::parser::parse_variable_tag_lit_math_expression_with_parentheses_and_filter ... ok
Nov 17 21:01:26.884 INFO [stdout] test parser::tests::parser::parse_variable_tag_lit_math_expression_with_parentheses ... ok
Nov 17 21:01:26.884 INFO [stdout] test parser::tests::parser::parse_value_forloop ... ok
Nov 17 21:01:26.884 INFO [stdout] test parser::tests::parser::parse_variable_tag_lit_math_expression ... ok
Nov 17 21:01:26.884 INFO [stdout] test parser::tests::parser::parse_text_with_whitespace ... ok
Nov 17 21:01:26.884 INFO [stdout] test parser::tests::parser::parse_string_concat_can_merge ... ok
Nov 17 21:01:26.884 INFO [stdout] test parser::tests::parser::parse_string_concat_multiple ... ok
Nov 17 21:01:26.887 INFO [stdout] test parser::tests::parser::parse_variable_tag_simple_negated_expr ... ok
Nov 17 21:01:26.887 INFO [stdout] test parser::tests::parser::parse_variable_tag_math_and_logic_expression ... ok
Nov 17 21:01:26.887 INFO [stdout] test parser::tests::parser::parse_variable_tag_macro_call ... ok
Nov 17 21:01:26.888 INFO [stdout] test parser::tests::whitespace::do_nothing_if_unneeded ... ok
Nov 17 21:01:26.889 INFO [stdout] test parser::tests::parser::parse_variable_tag_test_as_expression ... ok
Nov 17 21:01:26.889 INFO [stdout] test parser::tests::parser::parse_variable_tag_simple_logic_expression ... ok
Nov 17 21:01:26.889 INFO [stdout] test parser::tests::parser::parse_variable_tag_macro_call_with_filter ... ok
Nov 17 21:01:26.890 INFO [stdout] test parser::tests::parser::parse_variable_tag_simple_test ... ok
Nov 17 21:01:26.890 INFO [stdout] test parser::tests::parser::parse_variable_tag_macro_call_with_array ... ok
Nov 17 21:01:26.890 INFO [stdout] test parser::tests::parser::parse_variable_tag_negated_expr ... ok
Nov 17 21:01:26.890 INFO [stdout] test parser::tests::whitespace::handle_ws_both_sides_for_raw_tag ... ok
Nov 17 21:01:26.890 INFO [stdout] test parser::tests::parser::parse_variable_tag_math_with_filters_and_logic_expression ... ok
Nov 17 21:01:26.890 INFO [stdout] test parser::tests::whitespace::remove_previous_ws_if_single_opening_tag_requires_it ... ok
Nov 17 21:01:26.891 INFO [stdout] test renderer::square_brackets::tests::can_pull_out_square_bracket ... ok
Nov 17 21:01:26.891 INFO [stdout] test parser::tests::whitespace::handle_ws_for_if_nodes ... ok
Nov 17 21:01:26.892 INFO [stdout] test parser::tests::whitespace::handle_ws_for_if_nodes_with_else ... ok
Nov 17 21:01:26.893 INFO [stdout] test parser::tests::whitespace::remove_next_ws_if_single_opening_tag_requires_it ... ok
Nov 17 21:01:26.896 INFO [stdout] test renderer::tests::basic::comments_are_ignored ... ok
Nov 17 21:01:26.896 INFO [stdout] test renderer::tests::basic::can_concat_strings ... ok
Nov 17 21:01:26.896 INFO [stdout] test renderer::tests::basic::can_fail_rendering_from_template ... ok
Nov 17 21:01:26.897 INFO [stdout] test renderer::tests::basic::can_set_variables_in_included_templates ... ok
Nov 17 21:01:26.897 INFO [stdout] test parser::tests::whitespace::handle_ws_both_sides_for_macro_definitions ... ok
Nov 17 21:01:26.899 INFO [stdout] test parser::tests::whitespace::handle_ws_both_sides_for_forloop_tag_and_remove_empty_node ... ok
Nov 17 21:01:26.899 INFO [stdout] test renderer::tests::basic::can_set_variable_in_global_context_in_forloop ... ok
Nov 17 21:01:26.902 INFO [stdout] test renderer::tests::basic::add_set_values_in_context ... ok
Nov 17 21:01:26.903 INFO [stdout] test renderer::tests::basic::filter_filter_works ... ok
Nov 17 21:01:26.905 INFO [stdout] test renderer::tests::basic::does_render_owned_for_loop_with_objects ... ok
Nov 17 21:01:26.907 INFO [stdout] test renderer::tests::basic::render_include_tag ... ok
Nov 17 21:01:26.909 INFO [stdout] test renderer::tests::basic::redefining_loop_value_doesnt_break_loop ... ok
Nov 17 21:01:26.909 INFO [stdout] test renderer::tests::basic::filter_args_are_not_escaped ... ok
Nov 17 21:01:26.911 INFO [stdout] test renderer::tests::basic::render_magic_variable_macro_doesnt_leak ... ok
Nov 17 21:01:26.911 INFO [stdout] test renderer::tests::basic::default_filter_works ... ok
Nov 17 21:01:26.922 INFO [stdout] test renderer::tests::basic::render_magic_variable_isnt_escaped ... ok
Nov 17 21:01:26.934 INFO [stdout] test renderer::tests::basic::render_for ... ok
Nov 17 21:01:26.938 INFO [stdout] test renderer::tests::basic::render_filter_section ... ok
Nov 17 21:01:26.950 INFO [stdout] test renderer::tests::basic::render_magic_variable_gets_all_contexts ... ok
Nov 17 21:01:26.950 INFO [stdout] test renderer::tests::basic::render_raw_tag ... ok
Nov 17 21:01:26.963 INFO [stdout] test renderer::tests::basic::ok_many_variable_blocks ... ok
Nov 17 21:01:26.963 INFO [stdout] test renderer::tests::basic::render_variable_block_ident ... ok
Nov 17 21:01:26.963 INFO [stdout] test renderer::tests::basic::render_simple_string ... ok
Nov 17 21:01:26.963 INFO [stdout] test renderer::tests::basic::render_variable_block_autoescaping_disabled ... ok
Nov 17 21:01:26.964 INFO [stdout] test renderer::tests::basic::render_if_elif_else ... ok
Nov 17 21:01:26.966 INFO [stdout] test renderer::tests::errors::error_location_basic ... ok
Nov 17 21:01:26.966 INFO [stdout] test renderer::tests::errors::error_location_inside_macro ... ok
Nov 17 21:01:26.969 INFO [stdout] test renderer::tests::errors::error_location_base_template ... ok
Nov 17 21:01:26.969 INFO [stdout] test renderer::tests::basic::render_variable_block_lit_expr ... ok
Nov 17 21:01:26.969 INFO [stdout] test renderer::tests::errors::error_out_of_range_index ... ok
Nov 17 21:01:26.970 INFO [stdout] test renderer::tests::errors::error_unknown_index_variable ... ok
Nov 17 21:01:26.971 INFO [stdout] test renderer::tests::errors::error_when_using_variable_set_in_included_templates_outside ... ok
Nov 17 21:01:26.971 INFO [stdout] test renderer::tests::errors::error_when_missing_macro_templates ... ok
Nov 17 21:01:26.978 INFO [stdout] test renderer::tests::inheritance::render_multiple_inheritance_with_super ... ok
Nov 17 21:01:26.979 INFO [stdout] test renderer::tests::inheritance::render_nested_block_multiple_inheritance_no_super ... ok
Nov 17 21:01:26.979 INFO [stdout] test renderer::tests::inheritance::render_simple_inheritance ... ok
Nov 17 21:01:26.979 INFO [stdout] test renderer::tests::inheritance::render_simple_inheritance_super ... ok
Nov 17 21:01:26.979 INFO [stdout] test renderer::tests::inheritance::render_super_in_grandchild_without_redefining_in_parent_works ... ok
Nov 17 21:01:26.983 INFO [stdout] test renderer::tests::inheritance::render_super_in_grandchild_without_redefining_works ... ok
Nov 17 21:01:26.991 INFO [stdout] test renderer::tests::inheritance::render_multiple_inheritance ... ok
Nov 17 21:01:26.997 INFO [stdout] test renderer::tests::inheritance::render_super_multiple_inheritance_nested_block ... ok
Nov 17 21:01:27.006 INFO [stdout] test renderer::tests::macros::can_inherit_macro_import_from_grandparent ... ok
Nov 17 21:01:27.011 INFO [stdout] test renderer::tests::macros::can_inherit_macro_import_from_parent ... ok
Nov 17 21:01:27.017 INFO [stdout] test renderer::tests::macros::can_load_macro_in_child ... ok
Nov 17 21:01:27.017 INFO [stdout] test renderer::tests::macros::can_load_macro_in_parent_with_grandparent ... ok
Nov 17 21:01:27.020 INFO [stdout] test renderer::tests::macros::can_load_parent_macro_in_child ... ok
Nov 17 21:01:27.020 INFO [stdout] test renderer::tests::macros::import_macros_into_other_macro_files ... ok
Nov 17 21:01:27.029 INFO [stdout] test renderer::tests::macros::macro_can_access_global_context ... ok
Nov 17 21:01:27.033 INFO [stdout] test renderer::tests::macros::macro_can_load_macro_from_macro_files ... ok
Nov 17 21:01:27.035 INFO [stdout] test renderer::tests::macros::macro_param_arent_escaped ... ok
Nov 17 21:01:27.078 INFO [stdout] test renderer::tests::errors::right_variable_name_is_needed_in_for_loop ... ok
Nov 17 21:01:27.078 INFO [stdout] test renderer::tests::inheritance::render_super_in_top_block_errors ... ok
Nov 17 21:01:27.078 INFO [stdout] test renderer::tests::macros::parent_macro_cant_access_child_macro_context ... ok
Nov 17 21:01:27.078 INFO [stdout] test renderer::tests::errors::error_location_in_parent_block ... ok
Nov 17 21:01:27.078 INFO [stdout] test renderer::tests::errors::error_invalid_type_index_variable ... ok
Nov 17 21:01:27.078 INFO [stdout] test renderer::tests::basic::render_variable_block_logic_expr ... ok
Nov 17 21:01:27.078 INFO [stdout] test renderer::tests::macros::render_macros_in_child_templates_same_namespace ... ok
Nov 17 21:01:27.078 INFO [stdout] test renderer::tests::macros::recursive_macro_with_loops ... ok
Nov 17 21:01:27.082 INFO [stdout] test renderer::tests::macros::render_macros ... ok
Nov 17 21:01:27.082 INFO [stdout] test renderer::tests::macros::render_macros_expression_arg ... ok
Nov 17 21:01:27.085 INFO [stdout] test renderer::tests::macros::render_macros_in_child_templates_different_namespace ... ok
Nov 17 21:01:27.085 INFO [stdout] test renderer::tests::macros::render_macros_in_included ... ok
Nov 17 21:01:27.085 INFO [stdout] test renderer::tests::macros::render_macros_with_default_args ... ok
Nov 17 21:01:27.085 INFO [stdout] test renderer::tests::macros::render_macros_in_parent_template_with_inheritance ... ok
Nov 17 21:01:27.087 INFO [stdout] test renderer::tests::macros::render_macros_override_default_args ... ok
Nov 17 21:01:27.088 INFO [stdout] test renderer::tests::macros::render_set_tag_macro ... ok
Nov 17 21:01:27.089 INFO [stdout] test renderer::tests::square_brackets::var_access_by_loop_index ... ok
Nov 17 21:01:27.090 INFO [stdout] test renderer::tests::macros::render_recursive_macro ... ok
Nov 17 21:01:27.090 INFO [stdout] test renderer::tests::macros::template_cant_access_macros_context ... ok
Nov 17 21:01:27.094 INFO [stdout] test renderer::tests::square_brackets::var_access_by_loop_index_with_set ... ok
Nov 17 21:01:27.094 INFO [stdout] test renderer::tests::square_brackets::var_access_by_square_brackets ... ok
Nov 17 21:01:27.094 INFO [stdout] test renderer::tests::square_brackets::var_access_by_square_brackets_errors ... ok
Nov 17 21:01:27.094 INFO [stdout] test template::tests::test_can_find_blocks ... ok
Nov 17 21:01:27.094 INFO [stdout] test template::tests::test_can_find_imported_macros ... ok
Nov 17 21:01:27.094 INFO [stdout] test renderer::tests::whitespace::can_remove_whitespace_inheritance ... ok
Nov 17 21:01:27.096 INFO [stdout] test template::tests::test_can_find_macros ... ok
Nov 17 21:01:27.102 INFO [stdout] test template::tests::test_can_parse_ok_template ... ok
Nov 17 21:01:27.102 INFO [stdout] test renderer::tests::whitespace::can_remove_whitespace_basic ... ok
Nov 17 21:01:27.102 INFO [stdout] test renderer::tests::whitespace::can_remove_whitespace_macros ... ok
Nov 17 21:01:27.102 INFO [stdout] test template::tests::test_can_find_parent_template ... ok
Nov 17 21:01:27.104 INFO [stdout] test renderer::tests::whitespace::can_remove_whitespace_include ... ok
Nov 17 21:01:27.106 INFO [stdout] test tera::tests::test_can_autoescape_one_off_template ... ok
Nov 17 21:01:27.108 INFO [stdout] test tera::tests::can_load_from_glob ... ok
Nov 17 21:01:27.117 INFO [stdout] test tera::tests::test_can_disable_autoescape_one_off_template ... ok
Nov 17 21:01:27.121 INFO [stdout] test template::tests::test_can_find_nested_blocks ... ok
Nov 17 21:01:27.122 INFO [stdout] test tera::tests::test_circular_extends ... ok
Nov 17 21:01:27.122 INFO [stdout] test tera::tests::full_reload_with_glob ... ok
Nov 17 21:01:27.123 INFO [stdout] test tera::tests::test_extend_new_filter ... ok
Nov 17 21:01:27.128 INFO [stdout] test tera::tests::test_extend_new_tester ... ok
Nov 17 21:01:27.128 INFO [stdout] test tera::tests::test_get_inheritance_chain ... ok
Nov 17 21:01:27.130 INFO [stdout] test tera::tests::test_extend_with_overlap ... ok
Nov 17 21:01:27.130 INFO [stdout] test tera::tests::test_extend_no_overlap ... ok
Nov 17 21:01:27.130 INFO [stdout] test tera::tests::test_get_parent_blocks_definition_nested_block ... ok
Nov 17 21:01:27.132 INFO [stdout] test tera::tests::test_get_parent_blocks_definition ... ok
Nov 17 21:01:27.132 INFO [stdout] test tera::tests::test_reset_escape_function ... ok
Nov 17 21:01:27.132 INFO [stdout] test utils::tests::test_escape_html ... ok
Nov 17 21:01:27.139 INFO [stdout] test tera::tests::test_set_escape_function ... ok
Nov 17 21:01:27.139 INFO [stdout] test tera::tests::test_value_one_off_template ... ok
Nov 17 21:01:27.140 INFO [stdout] test tera::tests::test_missing_parent_template ... ok
Nov 17 21:01:27.142 INFO [stdout] test tera::tests::full_reload_with_glob_after_extending ... ok
Nov 17 21:01:27.212 INFO [stdout] test renderer::tests::errors::error_location_in_parent_in_macro ... ok
Nov 17 21:01:27.222 INFO [stdout] test renderer::tests::errors::error_loading_macro_from_unloaded_namespace ... ok
Nov 17 21:01:27.304 INFO [stdout] test tera::tests::test_can_only_parse_templates ... ok
Nov 17 21:01:27.304 INFO [stdout] 
Nov 17 21:01:27.304 INFO [stdout] test result: ok. 314 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 21:01:27.304 INFO [stdout] 
Nov 17 21:01:27.313 INFO [stderr]      Running /target/debug/deps/render_fails-68d187070e4862c5
Nov 17 21:01:27.315 INFO [stdout] 
Nov 17 21:01:27.315 INFO [stdout] running 12 tests
Nov 17 21:01:27.346 INFO [stdout] test test_error_macros_self_inexisting ... ok
Nov 17 21:01:27.355 INFO [stdout] test test_error_in_parent_template_location ... ok
Nov 17 21:01:27.363 INFO [stdout] test test_error_render_field_unknown_in_forloop ... ok
Nov 17 21:01:27.366 INFO [stdout] test test_error_in_child_template_location ... ok
Nov 17 21:01:27.368 INFO [stdout] test test_error_render_field_unknown ... ok
Nov 17 21:01:27.375 INFO [stdout] test test_error_render_non_math ... ok
Nov 17 21:01:27.379 INFO [stdout] test test_error_render_serialize_non_object ... ok
Nov 17 21:01:27.383 INFO [stdout] test test_error_in_macro_location ... ok
Nov 17 21:01:27.383 INFO [stdout] test test_error_render_filter_section_invalid ... ok
Nov 17 21:01:27.387 INFO [stdout] test test_error_render_iterate_non_array ... ok
Nov 17 21:01:27.387 INFO [stdout] test test_error_in_grandchild_template_location ... ok
Nov 17 21:01:27.391 INFO [stdout] test test_error_wrong_args_macros ... ok
Nov 17 21:01:27.391 INFO [stderr]    Doc-tests tera
Nov 17 21:01:27.391 INFO [stdout] 
Nov 17 21:01:27.391 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 21:01:27.391 INFO [stdout] 
Nov 17 21:01:30.719 INFO [stdout] 
Nov 17 21:01:30.719 INFO [stdout] running 19 tests
Nov 17 21:01:30.719 INFO [stdout] test src/context.rs - context::Context::extend (line 52) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/context.rs - context::Context::insert (line 35) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/macros.rs - compile_templates (line 42) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/macros.rs - try_get_value (line 11) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::add_raw_template (line 364) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::add_raw_templates (line 381) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::add_template_file (line 405) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::add_template_files (line 424) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::autoescape_on (line 587) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::extend (line 647) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::new (line 74) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::one_off (line 332) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::parse (line 93) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::register_filter (line 455) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::register_function (line 516) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::register_global_function (line 504) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::register_tester (line 475) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::render (line 299) ... ignored
Nov 17 21:01:30.719 INFO [stdout] test src/tera.rs - tera::Tera::set_escape_fn (line 605) ... ignored
Nov 17 21:01:30.719 INFO [stdout] 
Nov 17 21:01:30.719 INFO [stdout] test result: ok. 0 passed; 0 failed; 19 ignored; 0 measured; 0 filtered out
Nov 17 21:01:30.719 INFO [stdout] 
Nov 17 21:01:30.725 INFO [stderr] su: No module specific data is present
Nov 17 21:01:31.081 INFO running `"docker" "inspect" "82ed00bf3facccd82ae59715f204d08168c71442a2046c9accaef5713d461871"`
Nov 17 21:01:31.191 INFO running `"docker" "rm" "-f" "82ed00bf3facccd82ae59715f204d08168c71442a2046c9accaef5713d461871"`
Nov 17 21:01:31.308 INFO [stdout] 82ed00bf3facccd82ae59715f204d08168c71442a2046c9accaef5713d461871