Nov 18 04:06:08.644 INFO testing peresil-0.4.0-alpha.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 04:06:08.644 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 18 04:06:08.838 INFO [stdout] fc624988f411a895180b4aca05203b73c32ff3a62ddb8c3234831cb58f6ac51a
Nov 18 04:06:08.841 INFO running `"docker" "start" "-a" "fc624988f411a895180b4aca05203b73c32ff3a62ddb8c3234831cb58f6ac51a"`
Nov 18 04:06:09.241 INFO [stderr] usermod: no changes
Nov 18 04:06:09.265 INFO [stderr]    Compiling peresil v0.4.0-alpha.0 (/source)
Nov 18 04:06:09.850 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.59s
Nov 18 04:06:09.852 INFO [stderr] su: No module specific data is present
Nov 18 04:06:10.137 INFO running `"docker" "inspect" "fc624988f411a895180b4aca05203b73c32ff3a62ddb8c3234831cb58f6ac51a"`
Nov 18 04:06:10.196 INFO running `"docker" "rm" "-f" "fc624988f411a895180b4aca05203b73c32ff3a62ddb8c3234831cb58f6ac51a"`
Nov 18 04:06:10.276 INFO [stdout] fc624988f411a895180b4aca05203b73c32ff3a62ddb8c3234831cb58f6ac51a
Nov 18 04:06:10.280 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 18 04:06:10.426 INFO [stdout] c2bf6968ccfefc5a53e0f5b61be07a908392e9680f7a9964a6b3fcf972bebb7f
Nov 18 04:06:10.427 INFO running `"docker" "start" "-a" "c2bf6968ccfefc5a53e0f5b61be07a908392e9680f7a9964a6b3fcf972bebb7f"`
Nov 18 04:06:10.853 INFO [stderr] usermod: no changes
Nov 18 04:06:10.901 INFO [stderr]    Compiling peresil v0.4.0-alpha.0 (/source)
Nov 18 04:06:13.644 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.77s
Nov 18 04:06:13.651 INFO [stderr] su: No module specific data is present
Nov 18 04:06:14.276 INFO running `"docker" "inspect" "c2bf6968ccfefc5a53e0f5b61be07a908392e9680f7a9964a6b3fcf972bebb7f"`
Nov 18 04:06:14.517 INFO running `"docker" "rm" "-f" "c2bf6968ccfefc5a53e0f5b61be07a908392e9680f7a9964a6b3fcf972bebb7f"`
Nov 18 04:06:14.822 INFO [stdout] c2bf6968ccfefc5a53e0f5b61be07a908392e9680f7a9964a6b3fcf972bebb7f
Nov 18 04:06:14.825 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 18 04:06:15.290 INFO [stdout] 5f65a38c579737758e85e57b87631a47a3752afb94e485d0ee404c673b53907e
Nov 18 04:06:15.293 INFO running `"docker" "start" "-a" "5f65a38c579737758e85e57b87631a47a3752afb94e485d0ee404c673b53907e"`
Nov 18 04:06:16.327 INFO [stderr] usermod: no changes
Nov 18 04:06:16.411 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Nov 18 04:06:16.431 INFO [stderr]      Running /target/debug/deps/peresil-d14ada9a0bd95e5f
Nov 18 04:06:16.432 INFO [stdout] 
Nov 18 04:06:16.432 INFO [stdout] running 26 tests
Nov 18 04:06:16.432 INFO [stdout] test test::alternate_stops_parsing_after_unrecoverable_failure ... ok
Nov 18 04:06:16.433 INFO [stdout] test test::alternate_with_children_parses ... ok
Nov 18 04:06:16.433 INFO [stdout] test test::child_parse_fails_child_step ... ok
Nov 18 04:06:16.433 INFO [stdout] test test::one_success ... ok
Nov 18 04:06:16.434 INFO [stdout] test test::child_parse_fails_parent_step ... ok
Nov 18 04:06:16.434 INFO [stdout] test test::one_error ... ok
Nov 18 04:06:16.434 INFO [stdout] test test::child_parse_succeeds ... ok
Nov 18 04:06:16.435 INFO [stdout] test test::first_error_is_better ... ok
Nov 18 04:06:16.435 INFO [stdout] test test::sequential_success ... ok
Nov 18 04:06:16.435 INFO [stdout] test test::string_alternate ... ok
Nov 18 04:06:16.435 INFO [stdout] test test::string_consume_identifier ... ok
Nov 18 04:06:16.436 INFO [stdout] test test::string_consume_literal ... ok
Nov 18 04:06:16.436 INFO [stdout] test test::string_sequential ... ok
Nov 18 04:06:16.436 INFO [stdout] test test::string_to ... ok
Nov 18 04:06:16.436 INFO [stdout] test test::string_zero_or_more ... ok
Nov 18 04:06:16.437 INFO [stdout] test test::success_after_failure ... ok
Nov 18 04:06:16.437 INFO [stdout] test test::success_before_failure ... ok
Nov 18 04:06:16.437 INFO [stdout] test test::two_error_at_same_point ... ok
Nov 18 04:06:16.437 INFO [stdout] test test::zero_or_more ... ok
Nov 18 04:06:16.438 INFO [stdout] test test::zero_or_more_fails_on_unrecoverable_failure ... ok
Nov 18 04:06:16.438 INFO [stdout] test test::zero_or_more_failure_returns_to_beginning_of_line ... ok
Nov 18 04:06:16.439 INFO [stdout] test test::second_error_is_better ... ok
Nov 18 04:06:16.447 INFO [stdout] test test::optional_missing ... ok
Nov 18 04:06:16.447 INFO [stderr]      Running /target/debug/deps/calculator-05ea4c2fc47c279b
Nov 18 04:06:16.447 INFO [stdout] test test::optional_with_recoverable ... ok
Nov 18 04:06:16.447 INFO [stderr]      Running /target/debug/deps/ingredient_list-7fc1f1a3c39f0a41
Nov 18 04:06:16.447 INFO [stdout] test test::optional_with_unrecoverable ... ok
Nov 18 04:06:16.447 INFO [stdout] test test::optional_present ... ok
Nov 18 04:06:16.447 INFO [stdout] 
Nov 18 04:06:16.447 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:06:16.447 INFO [stdout] 
Nov 18 04:06:16.447 INFO [stdout] 
Nov 18 04:06:16.447 INFO [stdout] running 15 tests
Nov 18 04:06:16.447 INFO [stdout] test division_divides ... ok
Nov 18 04:06:16.447 INFO [stdout] test failure_invalid_number ... ok
Nov 18 04:06:16.447 INFO [stdout] test failure_invalid_number_in_other_position ... ok
Nov 18 04:06:16.447 INFO [stdout] test divide_two_numbers ... ok
Nov 18 04:06:16.447 INFO [stdout] test all_operators_together ... ok
Nov 18 04:06:16.447 INFO [stdout] test addition_adds ... ok
Nov 18 04:06:16.447 INFO [stdout] test add_two_numbers ... ok
Nov 18 04:06:16.447 INFO [stdout] test add_three_numbers ... ok
Nov 18 04:06:16.447 INFO [stdout] test multiply_three_numbers ... ok
Nov 18 04:06:16.447 INFO [stdout] test multiply_two_numbers ... ok
Nov 18 04:06:16.447 INFO [stdout] test single_number ... ok
Nov 18 04:06:16.447 INFO [stdout] test subtract_two_numbers ... ok
Nov 18 04:06:16.447 INFO [stdout] test subtraction_subtracts ... ok
Nov 18 04:06:16.447 INFO [stdout] test multiplication_multiplies ... ok
Nov 18 04:06:16.447 INFO [stdout] test failure_not_a_number ... ok
Nov 18 04:06:16.447 INFO [stdout] 
Nov 18 04:06:16.447 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:06:16.447 INFO [stdout] 
Nov 18 04:06:16.447 INFO [stdout] 
Nov 18 04:06:16.447 INFO [stdout] running 8 tests
Nov 18 04:06:16.447 INFO [stdout] test cups ... ok
Nov 18 04:06:16.447 INFO [stdout] test ounces ... ok
Nov 18 04:06:16.460 INFO [stdout] test failure_unknown_unit ... ok
Nov 18 04:06:16.460 INFO [stdout] test tablespoons ... ok
Nov 18 04:06:16.460 INFO [stdout] test failure_invalid_size ... ok
Nov 18 04:06:16.460 INFO [stdout] test failure_expected_whitespace_after_unit ... ok
Nov 18 04:06:16.460 INFO [stdout] test failure_expected_whitespace_after_size ... ok
Nov 18 04:06:16.460 INFO [stdout] test failure_expected_name ... ok
Nov 18 04:06:16.460 INFO [stdout] 
Nov 18 04:06:16.460 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:06:16.460 INFO [stdout] 
Nov 18 04:06:16.475 INFO [stderr]    Doc-tests peresil
Nov 18 04:06:17.396 INFO [stdout] 
Nov 18 04:06:17.396 INFO [stdout] running 1 test
Nov 18 04:06:18.491 INFO [stdout] test src/lib.rs -  (line 5) ... ok
Nov 18 04:06:18.491 INFO [stdout] 
Nov 18 04:06:18.492 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:06:18.492 INFO [stdout] 
Nov 18 04:06:18.497 INFO [stderr] su: No module specific data is present
Nov 18 04:06:19.108 INFO running `"docker" "inspect" "5f65a38c579737758e85e57b87631a47a3752afb94e485d0ee404c673b53907e"`
Nov 18 04:06:19.360 INFO running `"docker" "rm" "-f" "5f65a38c579737758e85e57b87631a47a3752afb94e485d0ee404c673b53907e"`
Nov 18 04:06:19.654 INFO [stdout] 5f65a38c579737758e85e57b87631a47a3752afb94e485d0ee404c673b53907e