[INFO] updating cached repository https://github.com/zaphar/ucg
[INFO] running `"git" "-c" "credential.helper=" "-c" "credential.helper=/big/crater/work/cargo-home/bin/git-credential-null" "-c" "remote.origin.fetch=refs/heads/*:refs/heads/*" "fetch" "origin" "--force" "--prune"`
[INFO] [stderr] From https://github.com/zaphar/ucg
[INFO] [stderr]    49a6425..acffc6d  master     -> master
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] acffc6d5da2e23c580cb11ccd28ac933caf57c53
[INFO] testing zaphar/ucg against beta-2019-09-28 for beta-1.39-1
[INFO] running `"git" "clone" "work/cache/git-repos/https%3A%2F%2Fgithub.com%2Fzaphar%2Fucg" "work/builds/worker-3/source"`
[INFO] [stderr] Cloning into 'work/builds/worker-3/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/zaphar/ucg on toolchain beta-2019-09-28
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+beta-2019-09-28" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started tweaking git repo https://github.com/zaphar/ucg
[INFO] finished tweaking git repo https://github.com/zaphar/ucg
[INFO] tweaked toml for git repo https://github.com/zaphar/ucg written to work/builds/worker-3/source/Cargo.toml
[INFO] crate git repo https://github.com/zaphar/ucg already has a lockfile, it will not be regenerated
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+beta-2019-09-28" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "build" "--frozen"`
[INFO] [stdout] 6abfc15bffc9ba3f9a385de3d6f238854404619e9235e97d0fa30c168cb50399
[INFO] running `"docker" "start" "-a" "6abfc15bffc9ba3f9a385de3d6f238854404619e9235e97d0fa30c168cb50399"`
[INFO] [stderr]    Compiling nix v0.13.1
[INFO] [stderr]    Compiling same-file v1.0.4
[INFO] [stderr]    Compiling void v1.0.2
[INFO] [stderr]    Compiling unicode-segmentation v1.3.0
[INFO] [stderr]    Compiling utf8parse v0.1.1
[INFO] [stderr]    Compiling xml-rs v0.8.0
[INFO] [stderr]    Compiling abortable_parser v0.2.3
[INFO] [stderr]    Compiling simple-error v0.1.12
[INFO] [stderr]    Compiling dirs v1.0.5
[INFO] [stderr]    Compiling term_size v0.3.1
[INFO] [stderr]    Compiling serde_yaml v0.8.9
[INFO] [stderr]    Compiling toml v0.4.10
[INFO] [stderr]    Compiling serde_json v1.0.40
[INFO] [stderr]    Compiling walkdir v2.2.8
[INFO] [stderr]    Compiling textwrap v0.8.0
[INFO] [stderr]    Compiling clap v2.26.2
[INFO] [stderr]    Compiling ucg v0.6.4 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling rustyline v4.1.0
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 47.18s
[INFO] running `"docker" "inspect" "6abfc15bffc9ba3f9a385de3d6f238854404619e9235e97d0fa30c168cb50399"`
[INFO] running `"docker" "rm" "-f" "6abfc15bffc9ba3f9a385de3d6f238854404619e9235e97d0fa30c168cb50399"`
[INFO] [stdout] 6abfc15bffc9ba3f9a385de3d6f238854404619e9235e97d0fa30c168cb50399
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "test" "--frozen" "--no-run"`
[INFO] [stdout] 41f8efffe84babd5218bd43b05e54ece77ac89868856df3ec566d74f7f8206d5
[INFO] running `"docker" "start" "-a" "41f8efffe84babd5218bd43b05e54ece77ac89868856df3ec566d74f7f8206d5"`
[INFO] [stderr]    Compiling bencher v0.1.5
[INFO] [stderr]    Compiling ucg v0.6.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 18.89s
[INFO] running `"docker" "inspect" "41f8efffe84babd5218bd43b05e54ece77ac89868856df3ec566d74f7f8206d5"`
[INFO] running `"docker" "rm" "-f" "41f8efffe84babd5218bd43b05e54ece77ac89868856df3ec566d74f7f8206d5"`
[INFO] [stdout] 41f8efffe84babd5218bd43b05e54ece77ac89868856df3ec566d74f7f8206d5
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "test" "--frozen"`
[INFO] [stdout] 8891a7b2de6a3b336fbd5568b53869b1a912dddecb692960973a9bf68bd2bf86
[INFO] running `"docker" "start" "-a" "8891a7b2de6a3b336fbd5568b53869b1a912dddecb692960973a9bf68bd2bf86"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.32s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/ucglib-e245f19c7aba08d0
[INFO] [stdout] 
[INFO] [stdout] running 145 tests
[INFO] [stdout] test ast::printer::test::test_binary_expression_with_embedded_comment ... ok
[INFO] [stdout] test ast::printer::test::test_call_expr_one_arg_printing ... ok
[INFO] [stdout] test ast::printer::test::test_call_expr_printing ... ok
[INFO] [stdout] test ast::printer::test::test_copy_expr_one_arg_printing ... ok
[INFO] [stdout] test ast::printer::test::test_copy_expr_printing ... ok
[INFO] [stdout] test ast::printer::test::test_empty_list_printing ... ok
[INFO] [stdout] test ast::printer::test::test_fail_expr_printing ... ok
[INFO] [stdout] test ast::printer::test::test_call_expression_with_embedded_comment_in_args ... ok
[INFO] [stdout] test ast::printer::test::test_fail_expression_with_embedded_comment ... ok
[INFO] [stdout] test ast::printer::test::test_empty_call_expression_with_comment ... ok
[INFO] [stdout] test ast::printer::test::test_format_expr_list_arg_printing ... ok
[INFO] [stdout] test ast::printer::test::test_format_expression_with_embedded_comment ... ok
[INFO] [stdout] test ast::printer::test::test_copy_expression_with_embedded_comment_in_args ... ok
[INFO] [stdout] test ast::printer::test::test_list_nested_empty_tuple_printing ... ok
[INFO] [stdout] test ast::printer::test::test_let_statement_printing ... ok
[INFO] [stdout] test ast::printer::test::test_empty_tuple_printing ... ok
[INFO] [stdout] test ast::printer::test::test_escaped_quoted_printing ... ok
[INFO] [stdout] test ast::printer::test::test_func_expr_single_arg_printing ... ok
[INFO] [stdout] test ast::printer::test::test_grouped_expression_with_embedded_comment ... ok
[INFO] [stdout] test ast::printer::test::test_nested_empty_tuple_printing ... ok
[INFO] [stdout] test ast::printer::test::test_out_expr_printing ... ok
[INFO] [stdout] test ast::printer::test::test_select_expr_with_default_printing ... ok
[INFO] [stdout] test ast::printer::test::test_select_expr_no_default_printing ... ok
[INFO] [stdout] test ast::printer::test::test_simple_selector_printing ... ok
[INFO] [stdout] test ast::printer::test::test_func_expr_printing ... ok
[INFO] [stdout] test ast::printer::test::test_filter_func_operator_expression_with_embedded_comment ... ok
[INFO] [stdout] test ast::printer::test::test_list_expression_with_embedded_comment ... ok
[INFO] [stdout] test ast::printer::test::test_non_empty_tuple_printing ... ok
[INFO] [stdout] test ast::printer::test::test_format_expr_single_arg_printing ... ok
[INFO] [stdout] test ast::printer::test::test_statement_with_comment_printing_multiple_groups ... ok
[INFO] [stdout] test ast::printer::test::test_trace_expression_with_embedded_comment ... ok
[INFO] [stdout] test ast::printer::test::test_statement_with_comment_printing_groups ... ok
[INFO] [stdout] test ast::printer::test::test_simple_quoted_printing ... ok
[INFO] [stdout] test ast::printer::test::test_map_func_operator_expression_with_embedded_comment ... ok
[INFO] [stdout] test ast::printer::test::test_statement_with_comment_printing_comments_at_end ... ok
[INFO] [stdout] test ast::printer::test::test_tuple_expression_with_embedded_comment_same_line ... ok
[INFO] [stdout] test ast::printer::test::test_tuple_expression_with_embedded_comment ... ok
[INFO] [stdout] test build::compile_test::test_assert_just_keyword_compile_failures ... ok
[INFO] [stdout] test ast::printer::test::test_nested_non_empty_list_printing ... ok
[INFO] [stdout] test ast::printer::test::test_tuple_expression_with_embedded_comment_mid_field_expr ... ok
[INFO] [stdout] test ast::printer::test::test_reduce_func_operator_expression_with_embedded_comment ... ok
[INFO] [stdout] test ast::printer::test::test_not_expr_printing ... ok
[INFO] [stdout] test ast::printer::test::test_nested_non_empty_tuple_printing ... ok
[INFO] [stdout] test ast::printer::test::test_special_quoted_field_tuple_printing ... ok
[INFO] [stdout] test ast::printer::test::test_module_with_out_expr_printing ... ok
[INFO] [stdout] test ast::printer::test::test_simple_value_printing ... ok
[INFO] [stdout] test ast::printer::test::test_module_no_out_expr_printing ... ok
[INFO] [stdout] test ast::printer::test::test_trace_expr_printing ... ok
[INFO] [stdout] test ast::printer::test::test_tuple_expression_with_embedded_comment_and_mid_field_expr ... ok
[INFO] [stdout] test ast::printer::test::test_simple_quoted_field_tuple_printing ... ok
[INFO] [stdout] test build::compile_test::test_assert_partial_tuple_missing_ok_compile_failures ... ok
[INFO] [stdout] test ast::printer::test::test_statement_with_comment_printing ... ok
[INFO] [stdout] test build::compile_test::test_bad_import_path_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_assert_partial_tuple_bad_ok_compile_failures ... ok
[INFO] [stdout] test build::compile_test::test_assert_partial_tuple_missing_desc_compile_failures ... ok
[INFO] [stdout] test build::compile_test::test_binary_div_operator_wrong_type_on_rhs_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_assert_partial_tuple_bad_desc_compile_failures ... ok
[INFO] [stdout] test build::compile_test::test_binary_eqeq_operator_wrong_type_on_rhs_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_binary_lteq_operator_wrong_type_on_rhs_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_binary_operator_missing_operand_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_binary_minus_operator_wrong_type_on_rhs_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_binary_lt_operator_wrong_type_on_rhs_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_assert_partial_tuple_compile_failures ... ok
[INFO] [stdout] test build::compile_test::test_binary_gt_operator_wrong_type_on_rhs_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_binary_sum_operator_wrong_type_on_rhs_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_binary_mul_operator_wrong_type_on_rhs_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_concatenation ... ok
[INFO] [stdout] test build::compile_test::test_binary_gteq_operator_wrong_type_on_rhs_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_copy_expression_not_a_tuple_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_empty_value ... ok
[INFO] [stdout] test build::compile_test::test_format_expr_missing_expr_compile_error ... ok
[INFO] [stdout] test build::compile_test::test_import_missing_path_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_func_call_wrong_argument_length_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_let_missing_equal_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_copy_expression_wrong_field_type_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_incomplete_tuple_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_format_expr_unclosed_parens_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_incomplete_tuple_key_value_missing_eq_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_func_call_wrong_argument_type_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_import_path_not_a_string_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_list_unclosed_bracket_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_let_missing_name_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_out_missing_out_expr_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_let_missing_expression_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_out_missing_type_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_out_multiple_times_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_binary_operator_precedence ... ok
[INFO] [stdout] test build::compile_test::test_let_missing_semicolon_compile_failure ... ok
[INFO] [stdout] test build::format::test::test_format_happy_path ... ok
[INFO] [stdout] test build::format::test::test_format_happy_wrong_too_few_args ... ok
[INFO] [stdout] test build::compile_test::test_incomplete_tuple_key_value_missing_value_compile_failure ... ok
[INFO] [stdout] test build::format::test::test_format_happy_wrong_too_many_args ... ok
[INFO] [stdout] test build::compile_test::test_lists ... ok
[INFO] [stdout] test build::compile_test::test_select_missed_case_boolean_no_default_compile_failure ... ok
[INFO] [stdout] test build::test::test_eval_simple_lookup_error ... ok
[INFO] [stdout] test build::compile_test::test_select_missed_case_string_no_default_compile_failure ... ok
[INFO] [stdout] test build::compile_test::test_funcs ... ok
[INFO] [stdout] test build::test::test_eval_mul_expr_fail ... ok
[INFO] [stdout] test build::test::test_eval_div_expr_fail ... ok
[INFO] [stdout] test build::test::test_eval_subtract_expr_fail ... ok
[INFO] [stdout] test build::test::test_expr_copy_no_such_tuple ... ok
[INFO] [stdout] test build::test::test_eval_add_expr_fail ... ok
[INFO] [stdout] test build::compile_test::test_declarative_failures_can_with_format_expr ... ok
[INFO] [stdout] test build::test::test_select_expr_not_a_string ... ok
[INFO] [stdout] test io::test::test_line_accumulator_multi_line_stmt ... ok
[INFO] [stdout] test convert::exec::exec_test::convert_command_with_env_test ... ok
[INFO] [stdout] test tokenizer::test::test_empty_token ... ok
[INFO] [stdout] test tokenizer::test::test_assert_token ... ok
[INFO] [stdout] test tokenizer::test::test_escape_quoted ... ok
[INFO] [stdout] test io::test::test_line_accumulator_single_line_stmt ... ok
[INFO] [stdout] test tokenizer::test::test_gttok ... ok
[INFO] [stdout] test tokenizer::test::test_digittok ... ok
[INFO] [stdout] test tokenizer::test::test_gteqtok ... ok
[INFO] [stdout] test tokenizer::test::test_boolean ... ok
[INFO] [stdout] test build::compile_test::test_selectors ... ok
[INFO] [stdout] test tokenizer::test::test_match_word ... ok
[INFO] [stdout] test tokenizer::test::test_match_word_empty_input ... ok
[INFO] [stdout] test tokenizer::test::test_match_type ... ok
[INFO] [stdout] test tokenizer::test::test_match_punct ... ok
[INFO] [stdout] test tokenizer::test::test_not_out_token ... ok
[INFO] [stdout] test tokenizer::test::test_out_token_with_comment ... ok
[INFO] [stdout] test tokenizer::test::test_out_token ... ok
[INFO] [stdout] test tokenizer::test::test_parse_comment ... ok
[INFO] [stdout] test tokenizer::test::test_string_with_escaping ... ok
[INFO] [stdout] test build::compile_test::test_format ... ok
[INFO] [stdout] test tokenizer::test::test_parse_has_end ... ok
[INFO] [stdout] test tokenizer::test::test_eqeqtok ... ok
[INFO] [stdout] test tokenizer::test::test_notequaltok ... ok
[INFO] [stdout] test tokenizer::test::test_lteqtok ... ok
[INFO] [stdout] test tokenizer::test::test_lttok ... ok
[INFO] [stdout] test convert::exec::exec_test::convert_just_command_test ... ok
[INFO] [stdout] test tokenizer::test::test_whitespace ... ok
[INFO] [stdout] test tokenizer::test::test_tokenize_one_of_each ... ok
[INFO] [stdout] test tokenizer::test::test_tokenize_bareword_with_dash ... ok
[INFO] [stdout] test build::compile_test::test_tuples ... ok
[INFO] [stdout] test tokenizer::test::test_tokenize_builds_comment_map_groups ... ok
[INFO] [stdout] test tokenizer::test::test_tokenize_builds_comment_map ... ok
[INFO] [stdout] test convert::exec::exec_test::convert_command_with_arg_test ... ok
[INFO] [stdout] test tokenizer::test::test_tokenize_one_of_each_comment_map_path ... ok
[INFO] [stdout] test build::compile_test::test_declarative_failures_are_caused_by_msg ... ok
[INFO] [stdout] test build::compile_test::test_select_expressions ... ok
[INFO] [stdout] test build::compile_test::test_comparisons ... ok
[INFO] [stdout] test build::compile_test::test_modules ... ok
[INFO] [stdout] test build::compile_test::test_type_checks ... ok
[INFO] [stdout] test build::compile_test::test_functional_processing ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 145 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/ucg-e47c40a0e516d6b3
[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] [stderr]    Doc-tests ucglib
[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" "8891a7b2de6a3b336fbd5568b53869b1a912dddecb692960973a9bf68bd2bf86"`
[INFO] running `"docker" "rm" "-f" "8891a7b2de6a3b336fbd5568b53869b1a912dddecb692960973a9bf68bd2bf86"`
[INFO] [stdout] 8891a7b2de6a3b336fbd5568b53869b1a912dddecb692960973a9bf68bd2bf86