Dec 15 01:54:14.414 INFO testing pest-2.0.2 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 01:54:14.414 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 15 01:54:14.613 INFO [stdout] 6cbdff60b5594351314a5b3267225b953fd6dccac31dd17e6f25aaf1d2a5f600
Dec 15 01:54:14.614 INFO running `"docker" "start" "-a" "6cbdff60b5594351314a5b3267225b953fd6dccac31dd17e6f25aaf1d2a5f600"`
Dec 15 01:54:15.197 INFO [stderr] usermod: no changes
Dec 15 01:54:15.228 INFO [stderr]    Compiling pest v2.0.2 (/source)
Dec 15 01:54:18.059 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.84s
Dec 15 01:54:18.064 INFO [stderr] su: No module specific data is present
Dec 15 01:54:18.339 INFO running `"docker" "inspect" "6cbdff60b5594351314a5b3267225b953fd6dccac31dd17e6f25aaf1d2a5f600"`
Dec 15 01:54:18.446 INFO running `"docker" "rm" "-f" "6cbdff60b5594351314a5b3267225b953fd6dccac31dd17e6f25aaf1d2a5f600"`
Dec 15 01:54:18.537 INFO [stdout] 6cbdff60b5594351314a5b3267225b953fd6dccac31dd17e6f25aaf1d2a5f600
Dec 15 01:54:18.539 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 15 01:54:18.791 INFO [stdout] 1dc601b309592819f6d9a5beccc7a195b58fec688d5dc909c4075aae4525afd9
Dec 15 01:54:18.794 INFO running `"docker" "start" "-a" "1dc601b309592819f6d9a5beccc7a195b58fec688d5dc909c4075aae4525afd9"`
Dec 15 01:54:19.129 INFO [stderr] usermod: no changes
Dec 15 01:54:19.167 INFO [stderr]    Compiling pest v2.0.2 (/source)
Dec 15 01:54:29.548 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 10.40s
Dec 15 01:54:29.553 INFO [stderr] su: No module specific data is present
Dec 15 01:54:29.884 INFO running `"docker" "inspect" "1dc601b309592819f6d9a5beccc7a195b58fec688d5dc909c4075aae4525afd9"`
Dec 15 01:54:29.975 INFO running `"docker" "rm" "-f" "1dc601b309592819f6d9a5beccc7a195b58fec688d5dc909c4075aae4525afd9"`
Dec 15 01:54:30.065 INFO [stdout] 1dc601b309592819f6d9a5beccc7a195b58fec688d5dc909c4075aae4525afd9
Dec 15 01:54:30.069 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 15 01:54:30.271 INFO [stdout] f91448cdc6b519edbbc2d91ed59be974af0fdd03f5babea7c1c0f54ffd33ced3
Dec 15 01:54:30.273 INFO running `"docker" "start" "-a" "f91448cdc6b519edbbc2d91ed59be974af0fdd03f5babea7c1c0f54ffd33ced3"`
Dec 15 01:54:31.263 INFO [stderr] usermod: no changes
Dec 15 01:54:31.331 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 15 01:54:31.337 INFO [stderr]      Running /target/debug/deps/pest-3442f94c8992b80b
Dec 15 01:54:31.346 INFO [stdout] 
Dec 15 01:54:31.346 INFO [stdout] running 46 tests
Dec 15 01:54:31.347 INFO [stdout] test error::tests::display_parsing_error_mixed ... ok
Dec 15 01:54:31.347 INFO [stdout] test error::tests::display_parsing_error_negatives ... ok
Dec 15 01:54:31.347 INFO [stdout] test error::tests::display_parsing_error_positives ... ok
Dec 15 01:54:31.347 INFO [stdout] test error::tests::display_parsing_error_unknown ... ok
Dec 15 01:54:31.347 INFO [stdout] test iterators::flat_pairs::tests::double_ended_iter_for_flat_pairs ... ok
Dec 15 01:54:31.347 INFO [stdout] test iterators::flat_pairs::tests::iter_for_flat_pairs ... ok
Dec 15 01:54:31.347 INFO [stdout] test error::tests::mapped_parsing_error ... ok
Dec 15 01:54:31.347 INFO [stdout] test error::tests::error_with_path ... ok
Dec 15 01:54:31.347 INFO [stdout] test iterators::pair::tests::pair_into_inner ... ok
Dec 15 01:54:31.347 INFO [stdout] test iterators::pairs::tests::as_str ... ok
Dec 15 01:54:31.347 INFO [stdout] test iterators::pairs::tests::concat ... ok
Dec 15 01:54:31.347 INFO [stdout] test iterators::pairs::tests::double_ended_iter_for_pairs ... ok
Dec 15 01:54:31.347 INFO [stdout] test iterators::pairs::tests::iter_for_pairs ... ok
Dec 15 01:54:31.347 INFO [stdout] test iterators::pairs::tests::pairs_debug ... ok
Dec 15 01:54:31.347 INFO [stdout] test iterators::pairs::tests::pairs_display ... ok
Dec 15 01:54:31.347 INFO [stdout] test iterators::tokens::tests::double_ended_iter_for_tokens ... ok
Dec 15 01:54:31.363 INFO [stdout] test error::tests::display_custom_pos ... ok
Dec 15 01:54:31.367 INFO [stdout] test error::tests::display_custom_span_three_lines ... ok
Dec 15 01:54:31.367 INFO [stdout] test error::tests::display_custom_span_two_lines ... ok
Dec 15 01:54:31.367 INFO [stdout] test macros::tests::parses_to ... ok
Dec 15 01:54:31.367 INFO [stdout] test macros::tests::fails_with ... ok
Dec 15 01:54:31.375 INFO [stdout] test error::tests::display_custom_span_two_lines_inverted_cols ... ok
Dec 15 01:54:31.375 INFO [stdout] test position::tests::empty ... ok
Dec 15 01:54:31.375 INFO [stdout] test position::tests::cmp ... ok
Dec 15 01:54:31.375 INFO [stdout] test position::tests::line_col ... ok
Dec 15 01:54:31.375 INFO [stdout] test position::tests::line_of ... ok
Dec 15 01:54:31.375 INFO [stdout] test position::tests::line_of_between_new_line ... ok
Dec 15 01:54:31.375 INFO [stdout] test position::tests::line_of_empty ... ok
Dec 15 01:54:31.375 INFO [stdout] test position::tests::line_of_new_line ... ok
Dec 15 01:54:31.375 INFO [stdout] test position::tests::match_insensitive ... ok
Dec 15 01:54:31.375 INFO [stdout] test position::tests::match_range ... ok
Dec 15 01:54:31.383 INFO [stdout] test position::tests::hash ... ok
Dec 15 01:54:31.398 INFO [stdout] test position::tests::parts ... ok
Dec 15 01:54:31.399 INFO [stdout] test position::tests::skip ... ok
Dec 15 01:54:31.399 INFO [stdout] test position::tests::skip_empty ... ok
Dec 15 01:54:31.399 INFO [stdout] test span::tests::split ... ok
Dec 15 01:54:31.399 INFO [stdout] test position::tests::skip_until ... ok
Dec 15 01:54:31.407 INFO [stdout] test stack::test::iter ... ok
Dec 15 01:54:31.407 INFO [stdout] test stack::test::snapshot_with_empty ... ok
Dec 15 01:54:31.411 INFO [stdout] test stack::test::stack_ops ... ok
Dec 15 01:54:31.437 INFO [stdout] test macros::tests::missing_end ... ok
Dec 15 01:54:31.455 INFO [stdout] test macros::tests::wrong_negatives ... ok
Dec 15 01:54:31.455 INFO [stdout] test macros::tests::wrong_positives ... ok
Dec 15 01:54:31.455 INFO [stdout] test macros::tests::wrong_pos ... ok
Dec 15 01:54:31.455 INFO [stdout] test position::tests::cmp_panic ... ok
Dec 15 01:54:31.455 INFO [stdout] test macros::tests::empty ... ok
Dec 15 01:54:31.455 INFO [stdout] 
Dec 15 01:54:31.455 INFO [stdout] test result: ok. 46 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 01:54:31.455 INFO [stdout] 
Dec 15 01:54:31.458 INFO [stdout] 
Dec 15 01:54:31.458 INFO [stderr]      Running /target/debug/deps/calculator-6d36684f9e2426a9
Dec 15 01:54:31.458 INFO [stdout] running 4 tests
Dec 15 01:54:31.458 INFO [stdout] test prec_climb ... ok
Dec 15 01:54:31.458 INFO [stdout] test parens ... ok
Dec 15 01:54:31.458 INFO [stdout] test expression ... ok
Dec 15 01:54:31.467 INFO [stdout] test number ... ok
Dec 15 01:54:31.467 INFO [stderr]      Running /target/debug/deps/json-88fad1fec8411cdb
Dec 15 01:54:31.467 INFO [stdout] 
Dec 15 01:54:31.468 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 01:54:31.468 INFO [stdout] 
Dec 15 01:54:31.475 INFO [stdout] 
Dec 15 01:54:31.475 INFO [stdout] running 11 tests
Dec 15 01:54:31.475 INFO [stdout] test array_empty ... ok
Dec 15 01:54:31.475 INFO [stdout] test array ... ok
Dec 15 01:54:31.475 INFO [stdout] test number_zero ... ok
Dec 15 01:54:31.475 INFO [stdout] test object ... ok
Dec 15 01:54:31.475 INFO [stdout] test string_with_escapes ... ok
Dec 15 01:54:31.483 INFO [stdout] test ast ... ok
Dec 15 01:54:31.483 INFO [stdout] test null ... ok
Dec 15 01:54:31.483 INFO [stdout] test number_minus_zero ... ok
Dec 15 01:54:31.491 INFO [stdout] test bool ... ok
Dec 15 01:54:31.491 INFO [stderr]    Doc-tests pest
Dec 15 01:54:31.491 INFO [stdout] test float_with_exp ... ok
Dec 15 01:54:31.491 INFO [stdout] test float ... ok
Dec 15 01:54:31.491 INFO [stdout] 
Dec 15 01:54:31.491 INFO [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 01:54:31.491 INFO [stdout] 
Dec 15 01:54:32.902 INFO [stdout] 
Dec 15 01:54:32.903 INFO [stdout] running 57 tests
Dec 15 01:54:40.171 INFO [stdout] test src/error.rs - error::Error<R>::new_from_span (line 113) ... ok
Dec 15 01:54:41.149 INFO [stdout] test src/error.rs - error::Error<R>::renamed_rules (line 195) ... ok
Dec 15 01:54:42.749 INFO [stdout] test src/error.rs - error::Error<R>::with_path (line 159) ... ok
Dec 15 01:54:42.764 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::as_str (line 79) ... ok
Dec 15 01:54:44.434 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::as_rule (line 50) ... ok
Dec 15 01:54:44.687 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::as_span (line 136) ... ok
Dec 15 01:54:44.699 INFO [stdout] test src/error.rs - error::Error<R>::new_from_pos (line 75) ... ok
Dec 15 01:54:45.015 INFO [stdout] test src/iterators/flat_pairs.rs - iterators::flat_pairs::FlatPairs<'i, R>::tokens (line 48) ... ok
Dec 15 01:54:45.015 INFO [stdout] test src/lib.rs -  (line 49) ... ignored
Dec 15 01:54:54.195 INFO [stdout] test src/iterators/pairs.rs - iterators::pairs::Pairs<'i, R>::as_str (line 56) ... ok
Dec 15 01:54:54.220 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::into_inner (line 166) ... ok
Dec 15 01:54:54.543 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::into_span (line 109) ... ok
Dec 15 01:54:55.299 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::tokens (line 194) ... ok
Dec 15 01:54:56.240 INFO [stdout] test src/iterators/pairs.rs - iterators::pairs::Pairs<'i, R>::flatten (line 117) ... ok
Dec 15 01:54:56.259 INFO [stdout] test src/iterators/pairs.rs - iterators::pairs::Pairs<'i, R>::concat (line 89) ... ok
Dec 15 01:54:56.259 INFO [stdout] test src/macros.rs - fails_with (line 261) ... ok
Dec 15 01:54:56.731 INFO [stdout] test src/iterators/pairs.rs - iterators::pairs::Pairs<'i, R>::tokens (line 147) ... ok
Dec 15 01:55:00.495 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::end_of_input (line 659) ... ok
Dec 15 01:55:00.983 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::match_insensitive (line 513) ... ok
Dec 15 01:55:01.356 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::atomicity (line 144) ... ok
Dec 15 01:55:01.819 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::match_range (line 544) ... ok
Dec 15 01:55:01.851 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::atomic (line 758) ... ok
Dec 15 01:55:02.347 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::lookahead (line 691) ... ok
Dec 15 01:55:02.675 INFO [stdout] test src/macros.rs - parses_to (line 160) ... ok
Dec 15 01:55:03.867 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::match_char_by (line 448) ... ok
Dec 15 01:55:05.145 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::new (line 101) ... ok
Dec 15 01:55:05.907 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::optional (line 411) ... ok
Dec 15 01:55:06.467 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::position (line 123) ... ok
Dec 15 01:55:06.851 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::repeat (line 368) ... ok
Dec 15 01:55:07.070 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::match_string (line 482) ... ok
Dec 15 01:55:07.351 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::rule (line 167) ... ok
Dec 15 01:55:09.051 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::restore_on_err (line 1001) ... ok
Dec 15 01:55:11.847 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::skip (line 575) ... ok
Dec 15 01:55:12.255 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_drop (line 974) ... ok
Dec 15 01:55:12.674 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::sequence (line 321) ... ok
Dec 15 01:55:13.876 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::skip_until (line 606) ... ok
Dec 15 01:55:14.595 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_match_peek (line 902) ... ok
Dec 15 01:55:15.567 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_match_pop (line 935) ... ok
Dec 15 01:55:16.083 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_pop (line 875) ... ok
Dec 15 01:55:16.091 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_peek (line 847) ... ok
Dec 15 01:55:17.575 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::start_of_input (line 629) ... ok
Dec 15 01:55:19.575 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_push (line 811) ... ok
Dec 15 01:55:19.575 INFO [stdout] test src/prec_climber.rs - prec_climber::PrecClimber<R>::climb (line 154) ... ignored
Dec 15 01:55:20.515 INFO [stdout] test src/position.rs - position::Position<'i>::from_start (line 34) ... ok
Dec 15 01:55:20.763 INFO [stdout] test src/parser_state.rs - parser_state::state (line 62) ... ok
Dec 15 01:55:22.123 INFO [stdout] test src/position.rs - position::Position<'i>::line_col (line 92) ... ok
Dec 15 01:55:22.315 INFO [stdout] test src/position.rs - position::Position<'i>::pos (line 49) ... ok
Dec 15 01:55:22.419 INFO [stdout] test src/position.rs - position::Position<'i>::line_of (line 154) ... ok
Dec 15 01:55:23.023 INFO [stdout] test src/prec_climber.rs - prec_climber::Operator<R>::new (line 45) ... ok
Dec 15 01:55:23.342 INFO [stdout] test src/position.rs - position::Position<'i>::span (line 69) ... ok
Dec 15 01:55:26.018 INFO [stdout] test src/span.rs - span::Span<'i>::split (line 111) ... ok
Dec 15 01:55:26.135 INFO [stdout] test src/prec_climber.rs - prec_climber::PrecClimber<R>::new (line 100) ... ok
Dec 15 01:55:26.395 INFO [stdout] test src/span.rs - span::Span<'i>::as_str (line 133) ... ok
Dec 15 01:55:26.660 INFO [stdout] test src/span.rs - span::Span<'i>::end (line 55) ... ok
Dec 15 01:55:26.669 INFO [stdout] test src/span.rs - span::Span<'i>::end_pos (line 92) ... ok
Dec 15 01:55:27.069 INFO [stdout] test src/span.rs - span::Span<'i>::start_pos (line 73) ... ok
Dec 15 01:55:27.142 INFO [stdout] test src/span.rs - span::Span<'i>::start (line 37) ... ok
Dec 15 01:55:27.143 INFO [stdout] 
Dec 15 01:55:27.143 INFO [stdout] test result: ok. 55 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out
Dec 15 01:55:27.143 INFO [stdout] 
Dec 15 01:55:27.199 INFO [stderr] su: No module specific data is present
Dec 15 01:55:27.619 INFO running `"docker" "inspect" "f91448cdc6b519edbbc2d91ed59be974af0fdd03f5babea7c1c0f54ffd33ced3"`
Dec 15 01:55:27.776 INFO running `"docker" "rm" "-f" "f91448cdc6b519edbbc2d91ed59be974af0fdd03f5babea7c1c0f54ffd33ced3"`
Dec 15 01:55:27.870 INFO [stdout] f91448cdc6b519edbbc2d91ed59be974af0fdd03f5babea7c1c0f54ffd33ced3