Nov 18 04:03:40.064 INFO testing pest-2.0.1 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 04:03:40.064 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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:03:40.543 INFO [stdout] 0c69bb1495169597378f3512325a89e019b299482a8655f47ccdd077bdc1a6a2
Nov 18 04:03:40.551 INFO running `"docker" "start" "-a" "0c69bb1495169597378f3512325a89e019b299482a8655f47ccdd077bdc1a6a2"`
Nov 18 04:03:41.646 INFO [stderr] usermod: no changes
Nov 18 04:03:41.690 INFO [stderr]    Compiling pest v2.0.1 (/source)
Nov 18 04:03:44.839 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.17s
Nov 18 04:03:44.842 INFO [stderr] su: No module specific data is present
Nov 18 04:03:45.913 INFO running `"docker" "inspect" "0c69bb1495169597378f3512325a89e019b299482a8655f47ccdd077bdc1a6a2"`
Nov 18 04:03:46.135 INFO running `"docker" "rm" "-f" "0c69bb1495169597378f3512325a89e019b299482a8655f47ccdd077bdc1a6a2"`
Nov 18 04:03:46.451 INFO [stdout] 0c69bb1495169597378f3512325a89e019b299482a8655f47ccdd077bdc1a6a2
Nov 18 04:03:46.460 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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:03:46.834 INFO [stdout] 94e7d3b180b628e96224eeeae9928b8ee869240c87604330d1a37c77c6e7e30f
Nov 18 04:03:46.839 INFO running `"docker" "start" "-a" "94e7d3b180b628e96224eeeae9928b8ee869240c87604330d1a37c77c6e7e30f"`
Nov 18 04:03:47.734 INFO [stderr] usermod: no changes
Nov 18 04:03:47.781 INFO [stderr]    Compiling pest v2.0.1 (/source)
Nov 18 04:03:59.583 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.82s
Nov 18 04:03:59.587 INFO [stderr] su: No module specific data is present
Nov 18 04:04:00.585 INFO running `"docker" "inspect" "94e7d3b180b628e96224eeeae9928b8ee869240c87604330d1a37c77c6e7e30f"`
Nov 18 04:04:00.871 INFO running `"docker" "rm" "-f" "94e7d3b180b628e96224eeeae9928b8ee869240c87604330d1a37c77c6e7e30f"`
Nov 18 04:04:01.259 INFO [stdout] 94e7d3b180b628e96224eeeae9928b8ee869240c87604330d1a37c77c6e7e30f
Nov 18 04:04:01.268 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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:04:01.860 INFO [stdout] de63a210df8c7f53ecf29d365b2823725634488642650e5f3e26d6cf34b9f02f
Nov 18 04:04:01.862 INFO running `"docker" "start" "-a" "de63a210df8c7f53ecf29d365b2823725634488642650e5f3e26d6cf34b9f02f"`
Nov 18 04:04:02.479 INFO [stderr] usermod: no changes
Nov 18 04:04:02.515 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
Nov 18 04:04:02.515 INFO [stderr]      Running /target/debug/deps/pest-ed4a564a91d21205
Nov 18 04:04:02.517 INFO [stdout] 
Nov 18 04:04:02.517 INFO [stdout] running 46 tests
Nov 18 04:04:02.517 INFO [stdout] test error::tests::display_parsing_error_unknown ... ok
Nov 18 04:04:02.518 INFO [stdout] test error::tests::display_custom_pos ... ok
Nov 18 04:04:02.518 INFO [stdout] test error::tests::display_parsing_error_mixed ... ok
Nov 18 04:04:02.518 INFO [stdout] test error::tests::display_custom_span_two_lines ... ok
Nov 18 04:04:02.519 INFO [stdout] test error::tests::display_parsing_error_positives ... ok
Nov 18 04:04:02.519 INFO [stdout] test error::tests::display_parsing_error_negatives ... ok
Nov 18 04:04:02.523 INFO [stdout] test iterators::pairs::tests::as_str ... ok
Nov 18 04:04:02.523 INFO [stdout] test iterators::pairs::tests::concat ... ok
Nov 18 04:04:02.523 INFO [stdout] test iterators::pairs::tests::double_ended_iter_for_pairs ... ok
Nov 18 04:04:02.524 INFO [stdout] test iterators::pairs::tests::iter_for_pairs ... ok
Nov 18 04:04:02.524 INFO [stdout] test iterators::pairs::tests::pairs_debug ... ok
Nov 18 04:04:02.524 INFO [stdout] test iterators::pairs::tests::pairs_display ... ok
Nov 18 04:04:02.525 INFO [stdout] test iterators::tokens::tests::double_ended_iter_for_tokens ... ok
Nov 18 04:04:02.525 INFO [stdout] test iterators::pair::tests::pair_into_inner ... ok
Nov 18 04:04:02.525 INFO [stdout] test error::tests::error_with_path ... ok
Nov 18 04:04:02.525 INFO [stdout] test iterators::flat_pairs::tests::double_ended_iter_for_flat_pairs ... ok
Nov 18 04:04:02.526 INFO [stdout] test error::tests::mapped_parsing_error ... ok
Nov 18 04:04:02.526 INFO [stdout] test iterators::flat_pairs::tests::iter_for_flat_pairs ... ok
Nov 18 04:04:02.527 INFO [stdout] test macros::tests::fails_with ... ok
Nov 18 04:04:02.527 INFO [stdout] test error::tests::display_custom_span_three_lines ... ok
Nov 18 04:04:02.527 INFO [stdout] test macros::tests::parses_to ... ok
Nov 18 04:04:02.527 INFO [stdout] test position::tests::cmp ... ok
Nov 18 04:04:02.527 INFO [stdout] test error::tests::display_custom_span_two_lines_inverted_cols ... ok
Nov 18 04:04:02.527 INFO [stdout] test position::tests::empty ... ok
Nov 18 04:04:02.527 INFO [stdout] test position::tests::hash ... ok
Nov 18 04:04:02.527 INFO [stdout] test position::tests::line_col ... ok
Nov 18 04:04:02.527 INFO [stdout] test position::tests::line_of ... ok
Nov 18 04:04:02.529 INFO [stdout] test position::tests::line_of_between_new_line ... ok
Nov 18 04:04:02.529 INFO [stdout] test position::tests::line_of_empty ... ok
Nov 18 04:04:02.529 INFO [stdout] test position::tests::line_of_new_line ... ok
Nov 18 04:04:02.529 INFO [stdout] test position::tests::match_insensitive ... ok
Nov 18 04:04:02.529 INFO [stdout] test position::tests::parts ... ok
Nov 18 04:04:02.529 INFO [stdout] test position::tests::match_range ... ok
Nov 18 04:04:02.529 INFO [stdout] test position::tests::skip ... ok
Nov 18 04:04:02.529 INFO [stdout] test position::tests::skip_empty ... ok
Nov 18 04:04:02.529 INFO [stdout] test position::tests::skip_until ... ok
Nov 18 04:04:02.529 INFO [stdout] test span::tests::split ... ok
Nov 18 04:04:02.531 INFO [stdout] test stack::test::iter ... ok
Nov 18 04:04:02.531 INFO [stdout] test stack::test::snapshot_with_empty ... ok
Nov 18 04:04:02.539 INFO [stdout] test stack::test::stack_ops ... ok
Nov 18 04:04:02.565 INFO [stdout] test macros::tests::empty ... ok
Nov 18 04:04:02.566 INFO [stdout] test macros::tests::wrong_pos ... ok
Nov 18 04:04:02.567 INFO [stdout] test macros::tests::missing_end ... ok
Nov 18 04:04:02.580 INFO [stdout] test macros::tests::wrong_negatives ... ok
Nov 18 04:04:02.580 INFO [stdout] test macros::tests::wrong_positives ... ok
Nov 18 04:04:02.581 INFO [stdout] test position::tests::cmp_panic ... ok
Nov 18 04:04:02.581 INFO [stdout] 
Nov 18 04:04:02.581 INFO [stdout] test result: ok. 46 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:04:02.581 INFO [stdout] 
Nov 18 04:04:02.587 INFO [stderr]      Running /target/debug/deps/calculator-92229885520ed2b2
Nov 18 04:04:02.593 INFO [stdout] 
Nov 18 04:04:02.593 INFO [stdout] running 4 tests
Nov 18 04:04:02.593 INFO [stdout] test expression ... ok
Nov 18 04:04:02.594 INFO [stdout] test number ... ok
Nov 18 04:04:02.594 INFO [stdout] test parens ... ok
Nov 18 04:04:02.595 INFO [stdout] test prec_climb ... ok
Nov 18 04:04:02.595 INFO [stdout] 
Nov 18 04:04:02.595 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:04:02.595 INFO [stdout] 
Nov 18 04:04:02.598 INFO [stderr]      Running /target/debug/deps/json-f687155c856c5191
Nov 18 04:04:02.601 INFO [stdout] 
Nov 18 04:04:02.601 INFO [stdout] running 11 tests
Nov 18 04:04:02.603 INFO [stdout] test ast ... ok
Nov 18 04:04:02.604 INFO [stdout] test bool ... ok
Nov 18 04:04:02.604 INFO [stdout] test float ... ok
Nov 18 04:04:02.604 INFO [stdout] test string_with_escapes ... ok
Nov 18 04:04:02.604 INFO [stdout] test number_zero ... ok
Nov 18 04:04:02.604 INFO [stdout] test object ... ok
Nov 18 04:04:02.615 INFO [stdout] test array ... ok
Nov 18 04:04:02.615 INFO [stderr]    Doc-tests pest
Nov 18 04:04:02.615 INFO [stdout] test float_with_exp ... ok
Nov 18 04:04:02.616 INFO [stdout] test number_minus_zero ... ok
Nov 18 04:04:02.616 INFO [stdout] test array_empty ... ok
Nov 18 04:04:02.616 INFO [stdout] test null ... ok
Nov 18 04:04:02.616 INFO [stdout] 
Nov 18 04:04:02.617 INFO [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:04:02.617 INFO [stdout] 
Nov 18 04:04:03.823 INFO [stdout] 
Nov 18 04:04:03.823 INFO [stdout] running 57 tests
Nov 18 04:04:05.576 INFO [stdout] test src/error.rs - error::Error<R>::with_path (line 150) ... ok
Nov 18 04:04:06.825 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::as_str (line 79) ... ok
Nov 18 04:04:07.752 INFO [stdout] test src/error.rs - error::Error<R>::renamed_rules (line 186) ... ok
Nov 18 04:04:07.774 INFO [stdout] test src/iterators/flat_pairs.rs - iterators::flat_pairs::FlatPairs<'i, R>::tokens (line 48) ... ok
Nov 18 04:04:08.361 INFO [stdout] test src/error.rs - error::Error<R>::new_from_span (line 104) ... ok
Nov 18 04:04:09.178 INFO [stdout] test src/error.rs - error::Error<R>::new_from_pos (line 66) ... ok
Nov 18 04:04:09.411 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::as_rule (line 50) ... ok
Nov 18 04:04:10.639 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::as_span (line 136) ... ok
Nov 18 04:04:10.639 INFO [stdout] test src/lib.rs -  (line 49) ... ignored
Nov 18 04:04:13.427 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::into_inner (line 166) ... ok
Nov 18 04:04:14.126 INFO [stdout] test src/iterators/pairs.rs - iterators::pairs::Pairs<'i, R>::as_str (line 56) ... ok
Nov 18 04:04:15.120 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::into_span (line 109) ... ok
Nov 18 04:04:15.515 INFO [stdout] test src/iterators/pairs.rs - iterators::pairs::Pairs<'i, R>::flatten (line 117) ... ok
Nov 18 04:04:16.265 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::tokens (line 194) ... ok
Nov 18 04:04:17.251 INFO [stdout] test src/iterators/pairs.rs - iterators::pairs::Pairs<'i, R>::concat (line 89) ... ok
Nov 18 04:04:17.507 INFO [stdout] test src/iterators/pairs.rs - iterators::pairs::Pairs<'i, R>::tokens (line 147) ... ok
Nov 18 04:04:21.175 INFO [stdout] test src/macros.rs - fails_with (line 261) ... ok
Nov 18 04:04:22.215 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::atomic (line 758) ... ok
Nov 18 04:04:22.519 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::atomicity (line 144) ... ok
Nov 18 04:04:22.987 INFO [stdout] test src/macros.rs - parses_to (line 160) ... ok
Nov 18 04:04:25.015 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::end_of_input (line 659) ... ok
Nov 18 04:04:25.335 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::match_char_by (line 448) ... ok
Nov 18 04:04:25.609 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::lookahead (line 691) ... ok
Nov 18 04:04:27.235 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::match_insensitive (line 513) ... ok
Nov 18 04:04:29.748 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::match_string (line 482) ... ok
Nov 18 04:04:29.749 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::new (line 101) ... ok
Nov 18 04:04:30.729 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::match_range (line 544) ... ok
Nov 18 04:04:31.484 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::position (line 123) ... ok
Nov 18 04:04:31.879 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::optional (line 411) ... ok
Nov 18 04:04:32.510 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::repeat (line 368) ... ok
Nov 18 04:04:32.679 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::restore_on_err (line 1001) ... ok
Nov 18 04:04:33.595 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::rule (line 167) ... ok
Nov 18 04:04:36.907 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_peek (line 847) ... ok
Nov 18 04:04:37.043 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::sequence (line 321) ... ok
Nov 18 04:04:37.903 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::skip_until (line 606) ... ok
Nov 18 04:04:37.911 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::skip (line 575) ... ok
Nov 18 04:04:38.999 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_match_peek (line 902) ... ok
Nov 18 04:04:40.351 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_match_pop (line 935) ... ok
Nov 18 04:04:41.340 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_drop (line 974) ... ok
Nov 18 04:04:41.851 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_pop (line 875) ... ok
Nov 18 04:04:43.627 INFO [stdout] test src/position.rs - position::Position<'i>::from_start (line 34) ... ok
Nov 18 04:04:45.175 INFO [stdout] test src/position.rs - position::Position<'i>::line_col (line 92) ... ok
Nov 18 04:04:45.175 INFO [stdout] test src/prec_climber.rs - prec_climber::PrecClimber<R>::climb (line 154) ... ignored
Nov 18 04:04:45.251 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::start_of_input (line 629) ... ok
Nov 18 04:04:45.279 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_push (line 811) ... ok
Nov 18 04:04:46.243 INFO [stdout] test src/parser_state.rs - parser_state::state (line 62) ... ok
Nov 18 04:04:47.755 INFO [stdout] test src/position.rs - position::Position<'i>::pos (line 49) ... ok
Nov 18 04:04:47.995 INFO [stdout] test src/position.rs - position::Position<'i>::line_of (line 154) ... ok
Nov 18 04:04:48.791 INFO [stdout] test src/prec_climber.rs - prec_climber::Operator<R>::new (line 45) ... ok
Nov 18 04:04:49.431 INFO [stdout] test src/position.rs - position::Position<'i>::span (line 69) ... ok
Nov 18 04:04:50.859 INFO [stdout] test src/span.rs - span::Span<'i>::end (line 55) ... ok
Nov 18 04:04:51.201 INFO [stdout] test src/span.rs - span::Span<'i>::as_str (line 133) ... ok
Nov 18 04:04:51.667 INFO [stdout] test src/prec_climber.rs - prec_climber::PrecClimber<R>::new (line 100) ... ok
Nov 18 04:04:52.283 INFO [stdout] test src/span.rs - span::Span<'i>::split (line 111) ... ok
Nov 18 04:04:52.314 INFO [stdout] test src/span.rs - span::Span<'i>::end_pos (line 92) ... ok
Nov 18 04:04:52.458 INFO [stdout] test src/span.rs - span::Span<'i>::start (line 37) ... ok
Nov 18 04:04:52.635 INFO [stdout] test src/span.rs - span::Span<'i>::start_pos (line 73) ... ok
Nov 18 04:04:52.635 INFO [stdout] 
Nov 18 04:04:52.635 INFO [stdout] test result: ok. 55 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out
Nov 18 04:04:52.635 INFO [stdout] 
Nov 18 04:04:52.686 INFO [stderr] su: No module specific data is present
Nov 18 04:04:53.195 INFO running `"docker" "inspect" "de63a210df8c7f53ecf29d365b2823725634488642650e5f3e26d6cf34b9f02f"`
Nov 18 04:04:53.424 INFO running `"docker" "rm" "-f" "de63a210df8c7f53ecf29d365b2823725634488642650e5f3e26d6cf34b9f02f"`
Nov 18 04:04:53.647 INFO [stdout] de63a210df8c7f53ecf29d365b2823725634488642650e5f3e26d6cf34b9f02f