Dec 07 18:53:37.373 INFO testing dgen-0.1.1 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 18:53:37.373 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 18:53:37.558 INFO [stdout] 6be4bd9f4c4cfcfb02ef5faf668e02370cede2896f85f07903af55ad2e9f28c0
Dec 07 18:53:37.562 INFO running `"docker" "start" "-a" "6be4bd9f4c4cfcfb02ef5faf668e02370cede2896f85f07903af55ad2e9f28c0"`
Dec 07 18:53:38.288 INFO [stderr] usermod: no changes
Dec 07 18:53:38.596 INFO [stderr]    Compiling lalrpop-util v0.16.2
Dec 07 18:53:38.619 INFO [stderr]    Compiling ena v0.10.1
Dec 07 18:53:38.619 INFO [stderr]    Compiling docopt v1.0.2
Dec 07 18:53:43.781 INFO [stderr]    Compiling lalrpop v0.16.2
Dec 07 18:54:23.377 INFO [stderr]    Compiling dgen v0.1.1 (/source)
Dec 07 18:54:52.400 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Dec 07 18:54:52.400 INFO [stderr]   --> src/main.rs:34:46
Dec 07 18:54:52.400 INFO [stderr]    |
Dec 07 18:54:52.400 INFO [stderr] 34 |                     eprintln!("cause: {}", e.cause());
Dec 07 18:54:52.400 INFO [stderr]    |                                              ^^^^^
Dec 07 18:54:52.400 INFO [stderr]    |
Dec 07 18:54:52.400 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 07 18:54:52.400 INFO [stderr] 
Dec 07 18:54:55.661 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 17s
Dec 07 18:54:55.696 INFO [stderr] su: No module specific data is present
Dec 07 18:54:56.395 INFO running `"docker" "inspect" "6be4bd9f4c4cfcfb02ef5faf668e02370cede2896f85f07903af55ad2e9f28c0"`
Dec 07 18:54:56.662 INFO running `"docker" "rm" "-f" "6be4bd9f4c4cfcfb02ef5faf668e02370cede2896f85f07903af55ad2e9f28c0"`
Dec 07 18:54:56.979 INFO [stdout] 6be4bd9f4c4cfcfb02ef5faf668e02370cede2896f85f07903af55ad2e9f28c0
Dec 07 18:54:57.044 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 18:54:57.562 INFO [stdout] ea78bf7f182b07801600a88229793be1a8fb959451e271796fec2ff035b16557
Dec 07 18:54:57.566 INFO running `"docker" "start" "-a" "ea78bf7f182b07801600a88229793be1a8fb959451e271796fec2ff035b16557"`
Dec 07 18:54:58.626 INFO [stderr] usermod: no changes
Dec 07 18:54:58.830 INFO [stderr]    Compiling dgen v0.1.1 (/source)
Dec 07 18:55:03.472 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Dec 07 18:55:03.472 INFO [stderr]   --> src/main.rs:34:46
Dec 07 18:55:03.472 INFO [stderr]    |
Dec 07 18:55:03.472 INFO [stderr] 34 |                     eprintln!("cause: {}", e.cause());
Dec 07 18:55:03.472 INFO [stderr]    |                                              ^^^^^
Dec 07 18:55:03.472 INFO [stderr]    |
Dec 07 18:55:03.472 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 07 18:55:03.472 INFO [stderr] 
Dec 07 18:55:09.922 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.27s
Dec 07 18:55:09.934 INFO [stderr] su: No module specific data is present
Dec 07 18:55:10.551 INFO running `"docker" "inspect" "ea78bf7f182b07801600a88229793be1a8fb959451e271796fec2ff035b16557"`
Dec 07 18:55:10.838 INFO running `"docker" "rm" "-f" "ea78bf7f182b07801600a88229793be1a8fb959451e271796fec2ff035b16557"`
Dec 07 18:55:11.137 INFO [stdout] ea78bf7f182b07801600a88229793be1a8fb959451e271796fec2ff035b16557
Dec 07 18:55:11.142 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 18:55:11.577 INFO [stdout] ca691a8e0d895de32f8eac7c9da9c51255eb6cd63106ed6dc537ea67e18d570d
Dec 07 18:55:11.579 INFO running `"docker" "start" "-a" "ca691a8e0d895de32f8eac7c9da9c51255eb6cd63106ed6dc537ea67e18d570d"`
Dec 07 18:55:12.993 INFO [stderr] usermod: no changes
Dec 07 18:55:13.307 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.29s
Dec 07 18:55:13.314 INFO [stderr]      Running /target/debug/deps/dgen-1d6c011ae63d4776
Dec 07 18:55:13.326 INFO [stdout] 
Dec 07 18:55:13.326 INFO [stdout] running 58 tests
Dec 07 18:55:17.252 INFO [stdout] test builtins::bin_length::test::bin_length_returns_length_of_binary ... ok
Dec 07 18:55:17.738 INFO [stdout] test builtins::byte_order::test::decimal_is_converted_to_big_endian_binary ... ok
Dec 07 18:55:18.322 INFO [stdout] test builtins::concat::test::binary_is_concatenated ... ok
Dec 07 18:55:18.357 INFO [stdout] test builtins::from_file::test::produces_words_from_file_with_crlf_line_endings ... ok
Dec 07 18:55:18.360 INFO [stdout] test builtins::from_file::test::produces_words_from_file_with_lf_line_endings ... ok
Dec 07 18:55:19.176 INFO [stdout] test builtins::byte_order::test::uint_is_converted_to_little_endian_binary ... ok
Dec 07 18:55:19.968 INFO [stdout] test builtins::byte_order::test::uint_is_converted_to_big_endian_binary ... ok
Dec 07 18:55:20.352 INFO [stdout] test builtins::byte_order::test::int_is_converted_to_little_endian_binary ... ok
Dec 07 18:55:20.901 INFO [stdout] test builtins::env::test::returns_the_value_of_an_environment_variable ... ok
Dec 07 18:55:20.944 INFO [stdout] test builtins::byte_order::test::decimal_is_converted_to_little_endian_binary ... ok
Dec 07 18:55:22.166 INFO [stdout] test builtins::concat::test::strings_are_concatenated ... ok
Dec 07 18:55:22.719 INFO [stdout] test builtins::byte_order::test::int_is_converted_to_big_endian_binary ... ok
Dec 07 18:55:24.248 INFO [stdout] test builtins::repeat_delim::test::repeat_delimited_creates_string_output ... ok
Dec 07 18:55:24.423 INFO [stdout] test builtins::sequence::test::char_sequence ... ok
Dec 07 18:55:24.496 INFO [stdout] test builtins::sequence::test::bin_wrapping_sequence ... ok
Dec 07 18:55:24.770 INFO [stdout] test builtins::sequence::test::bin_sequence ... ok
Dec 07 18:55:25.727 INFO [stdout] test builtins::repeat_delim::test::repeat_delimited_creates_binary_output ... ok
Dec 07 18:55:27.304 INFO [stdout] test builtins::sequence::test::char_wrapping_sequence ... ok
Dec 07 18:55:27.924 INFO [stdout] test builtins::strings::test::generate_ascii_strings ... ok
Dec 07 18:55:29.301 INFO [stdout] test builtins::strings::test::std_unicode_string_fun ... ok
Dec 07 18:55:29.488 INFO [stdout] test builtins::strings::test::use_custom_string_function ... ok
Dec 07 18:55:29.568 INFO [stdout] test builtins::strings::test::string_length_returns_length_of_string ... ok
Dec 07 18:55:29.971 INFO [stdout] test builtins::strings::test::utf8_bytes_returns_encoded_string ... ok
Dec 07 18:55:30.756 INFO [stdout] test fun_test::declare_and_use_function_with_mapper ... ok
Dec 07 18:55:30.904 INFO [stdout] test builtins::strings::test::string_bytes_supports_a_lot_of_encodings ... ok
Dec 07 18:55:30.904 INFO [stdout] test interpreter::errors::parse_err_is_displayed_correctly ... ok
Dec 07 18:55:31.592 INFO [stdout] test fun_test::declare_and_use_functions ... ok
Dec 07 18:55:31.881 INFO [stdout] test interpreter::parse_test::parses_basic_char_literal ... ok
Dec 07 18:55:32.484 INFO [stdout] test interpreter::parse_test::parses_basic_string_literal_token ... ok
Dec 07 18:55:32.508 INFO [stdout] test interpreter::parse_test::parses_bin_literal ... ok
Dec 07 18:55:33.028 INFO [stdout] test fun_test::signed_integer_functions ... ok
Dec 07 18:55:33.160 INFO [stdout] test interpreter::parse_test::parses_boolean_literal_true_token ... ok
Dec 07 18:55:33.203 INFO [stdout] test fun_test::mapping_a_mapped_function ... ok
Dec 07 18:55:33.351 INFO [stdout] test interpreter::parse_test::parses_boolean_literal_false_token ... ok
Dec 07 18:55:33.523 INFO [stdout] test interpreter::parse_test::parses_decimal_literal_token ... ok
Dec 07 18:55:33.760 INFO [stdout] test fun_test::use_std_boolean_function ... ok
Dec 07 18:55:33.780 INFO [stdout] test interpreter::parse_test::parses_decimal_literal_token_with_negative_sign ... ok
Dec 07 18:55:33.945 INFO [stdout] test fun_test::pass_mapped_function_as_function_argument ... ok
Dec 07 18:55:34.111 INFO [stdout] test interpreter::parse_test::parses_empty_bin_literal ... ok
Dec 07 18:55:34.262 INFO [stdout] test interpreter::parse_test::parses_function_call_with_literal_arguments ... ok
Dec 07 18:55:34.292 INFO [stdout] test interpreter::parse_test::parses_function_call_with_zero_arguments ... ok
Dec 07 18:55:34.560 INFO [stdout] test interpreter::parse_test::parses_decimal_literal_token_with_positive_sign ... ok
Dec 07 18:55:34.750 INFO [stdout] test interpreter::parse_test::parses_mapped_function_call_withou_args ... ok
Dec 07 18:55:34.956 INFO [stdout] test interpreter::parse_test::parses_nested_function_calls ... ok
Dec 07 18:55:34.996 INFO [stdout] test fun_test::stable_select_a_generator ... ok
Dec 07 18:55:35.254 INFO [stdout] test interpreter::parse_test::parses_mapped_function_call ... ok
Dec 07 18:55:35.448 INFO [stdout] test interpreter::parse_test::parses_newline_escaped_char_literal ... ok
Dec 07 18:55:35.449 INFO [stdout] test interpreter::parse_test::parses_signed_int_literal_negative_token ... ok
Dec 07 18:55:35.548 INFO [stdout] test interpreter::parse_test::parses_signed_int_literal_positive_token ... ok
Dec 07 18:55:35.773 INFO [stdout] test interpreter::parse_test::parses_unicode_char_literal ... ok
Dec 07 18:55:35.803 INFO [stdout] test interpreter::parse_test::parses_program_with_macro_definitions ... ok
Dec 07 18:55:35.832 INFO [stdout] test interpreter::parse_test::parses_string_literal_with_whitespace_chars_and_escape_sequences ... ok
Dec 07 18:55:35.847 INFO [stdout] test interpreter::parse_test::parses_string_literal_that_is_all_whitespace ... ok
Dec 07 18:55:35.948 INFO [stdout] test interpreter::parse_test::parses_string_literal_with_escaped_quotes ... ok
Dec 07 18:55:35.964 INFO [stdout] test interpreter::parse_test::parses_unsigned_int_literal_token ... ok
Dec 07 18:55:35.974 INFO [stdout] test interpreter::parse_test::parses_unsigned_int_hex_literal_token ... ok
Dec 07 18:55:36.156 INFO [stdout] test interpreter::parse_test::parses_string_literal_with_unicode_escape_sequences ... ok
Dec 07 18:55:36.306 INFO [stdout] test fun_test::use_binary_functions ... ok
Dec 07 18:55:36.306 INFO [stdout] 
Dec 07 18:55:36.306 INFO [stdout] test result: ok. 58 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:36.306 INFO [stdout] 
Dec 07 18:55:36.307 INFO [stderr]      Running /target/debug/deps/dgen-67abb8d97e1a0e9a
Dec 07 18:55:36.319 INFO [stdout] 
Dec 07 18:55:36.319 INFO [stdout] running 0 tests
Dec 07 18:55:36.320 INFO [stdout] 
Dec 07 18:55:36.320 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:36.320 INFO [stdout] 
Dec 07 18:55:36.320 INFO [stderr]    Doc-tests dgen
Dec 07 18:55:42.599 INFO [stdout] 
Dec 07 18:55:42.599 INFO [stdout] running 0 tests
Dec 07 18:55:42.599 INFO [stdout] 
Dec 07 18:55:42.599 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:42.599 INFO [stdout] 
Dec 07 18:55:42.635 INFO [stderr] su: No module specific data is present
Dec 07 18:55:43.965 INFO running `"docker" "inspect" "ca691a8e0d895de32f8eac7c9da9c51255eb6cd63106ed6dc537ea67e18d570d"`
Dec 07 18:55:44.217 INFO running `"docker" "rm" "-f" "ca691a8e0d895de32f8eac7c9da9c51255eb6cd63106ed6dc537ea67e18d570d"`
Dec 07 18:55:44.464 INFO [stdout] ca691a8e0d895de32f8eac7c9da9c51255eb6cd63106ed6dc537ea67e18d570d