Nov 18 04:03:42.577 INFO testing pest-2.0.1 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 04:03:42.577 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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:42.961 INFO [stdout] 782f7dfbfb513a218ea320e81b3f90866663e0fa55200d2a028df64b2c153fe7
Nov 18 04:03:42.971 INFO running `"docker" "start" "-a" "782f7dfbfb513a218ea320e81b3f90866663e0fa55200d2a028df64b2c153fe7"`
Nov 18 04:03:44.294 INFO [stderr] usermod: no changes
Nov 18 04:03:44.365 INFO [stderr]    Compiling pest v2.0.1 (/source)
Nov 18 04:03:47.735 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.40s
Nov 18 04:03:47.735 INFO [stderr] su: No module specific data is present
Nov 18 04:03:48.770 INFO running `"docker" "inspect" "782f7dfbfb513a218ea320e81b3f90866663e0fa55200d2a028df64b2c153fe7"`
Nov 18 04:03:49.013 INFO running `"docker" "rm" "-f" "782f7dfbfb513a218ea320e81b3f90866663e0fa55200d2a028df64b2c153fe7"`
Nov 18 04:03:49.316 INFO [stdout] 782f7dfbfb513a218ea320e81b3f90866663e0fa55200d2a028df64b2c153fe7
Nov 18 04:03:49.322 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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:49.707 INFO [stdout] ff40eb4d0b39119cd24d2e265c6a5391a5f3661274019380f3c1f90e6bbde6b2
Nov 18 04:03:49.712 INFO running `"docker" "start" "-a" "ff40eb4d0b39119cd24d2e265c6a5391a5f3661274019380f3c1f90e6bbde6b2"`
Nov 18 04:03:51.121 INFO [stderr] usermod: no changes
Nov 18 04:03:51.199 INFO [stderr]    Compiling pest v2.0.1 (/source)
Nov 18 04:04:02.070 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 10.90s
Nov 18 04:04:02.071 INFO [stderr] su: No module specific data is present
Nov 18 04:04:02.450 INFO running `"docker" "inspect" "ff40eb4d0b39119cd24d2e265c6a5391a5f3661274019380f3c1f90e6bbde6b2"`
Nov 18 04:04:02.597 INFO running `"docker" "rm" "-f" "ff40eb4d0b39119cd24d2e265c6a5391a5f3661274019380f3c1f90e6bbde6b2"`
Nov 18 04:04:02.851 INFO [stdout] ff40eb4d0b39119cd24d2e265c6a5391a5f3661274019380f3c1f90e6bbde6b2
Nov 18 04:04:02.856 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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:03.455 INFO [stdout] e779a930349a5bffb073a2235e56dd3374ccb893b6fb313acf1f84d3a53c81e1
Nov 18 04:04:03.457 INFO running `"docker" "start" "-a" "e779a930349a5bffb073a2235e56dd3374ccb893b6fb313acf1f84d3a53c81e1"`
Nov 18 04:04:04.171 INFO [stderr] usermod: no changes
Nov 18 04:04:04.235 INFO [stdout] 
Nov 18 04:04:04.235 INFO [stdout] running 46 tests
Nov 18 04:04:04.235 INFO [stdout] test error::tests::display_parsing_error_unknown ... ok
Nov 18 04:04:04.235 INFO [stdout] test error::tests::display_custom_span_two_lines_inverted_cols ... ok
Nov 18 04:04:04.235 INFO [stdout] test error::tests::display_custom_pos ... ok
Nov 18 04:04:04.235 INFO [stdout] test error::tests::mapped_parsing_error ... ok
Nov 18 04:04:04.235 INFO [stdout] test iterators::flat_pairs::tests::double_ended_iter_for_flat_pairs ... ok
Nov 18 04:04:04.235 INFO [stdout] test iterators::pair::tests::pair_into_inner ... ok
Nov 18 04:04:04.235 INFO [stdout] test iterators::flat_pairs::tests::iter_for_flat_pairs ... ok
Nov 18 04:04:04.235 INFO [stdout] test iterators::pairs::tests::as_str ... ok
Nov 18 04:04:04.235 INFO [stdout] test iterators::pairs::tests::concat ... ok
Nov 18 04:04:04.235 INFO [stdout] test iterators::pairs::tests::double_ended_iter_for_pairs ... ok
Nov 18 04:04:04.235 INFO [stdout] test iterators::pairs::tests::iter_for_pairs ... ok
Nov 18 04:04:04.235 INFO [stdout] test iterators::pairs::tests::pairs_debug ... ok
Nov 18 04:04:04.235 INFO [stdout] test iterators::pairs::tests::pairs_display ... ok
Nov 18 04:04:04.235 INFO [stdout] test iterators::tokens::tests::double_ended_iter_for_tokens ... ok
Nov 18 04:04:04.235 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Nov 18 04:04:04.235 INFO [stderr]      Running /target/debug/deps/pest-4529682e9e4cfec0
Nov 18 04:04:04.251 INFO [stdout] test error::tests::display_custom_span_three_lines ... ok
Nov 18 04:04:04.251 INFO [stdout] test error::tests::display_custom_span_two_lines ... ok
Nov 18 04:04:04.251 INFO [stdout] test error::tests::error_with_path ... ok
Nov 18 04:04:04.251 INFO [stdout] test error::tests::display_parsing_error_negatives ... ok
Nov 18 04:04:04.251 INFO [stdout] test error::tests::display_parsing_error_positives ... ok
Nov 18 04:04:04.251 INFO [stdout] test error::tests::display_parsing_error_mixed ... ok
Nov 18 04:04:04.251 INFO [stdout] test macros::tests::fails_with ... ok
Nov 18 04:04:04.251 INFO [stdout] test macros::tests::parses_to ... ok
Nov 18 04:04:04.316 INFO [stdout] test position::tests::cmp ... ok
Nov 18 04:04:04.316 INFO [stdout] test position::tests::empty ... ok
Nov 18 04:04:04.317 INFO [stdout] test position::tests::hash ... ok
Nov 18 04:04:04.317 INFO [stdout] test position::tests::line_of ... ok
Nov 18 04:04:04.317 INFO [stdout] test position::tests::line_of_between_new_line ... ok
Nov 18 04:04:04.317 INFO [stdout] test position::tests::line_of_empty ... ok
Nov 18 04:04:04.317 INFO [stdout] test position::tests::line_of_new_line ... ok
Nov 18 04:04:04.317 INFO [stdout] test position::tests::line_col ... ok
Nov 18 04:04:04.317 INFO [stdout] test position::tests::match_insensitive ... ok
Nov 18 04:04:04.317 INFO [stdout] test position::tests::match_range ... ok
Nov 18 04:04:04.317 INFO [stdout] test position::tests::skip ... ok
Nov 18 04:04:04.317 INFO [stdout] test position::tests::skip_empty ... ok
Nov 18 04:04:04.317 INFO [stdout] test position::tests::parts ... ok
Nov 18 04:04:04.383 INFO [stdout] test span::tests::split ... ok
Nov 18 04:04:04.383 INFO [stdout] test position::tests::skip_until ... ok
Nov 18 04:04:04.383 INFO [stdout] test stack::test::iter ... ok
Nov 18 04:04:04.383 INFO [stdout] test stack::test::stack_ops ... ok
Nov 18 04:04:04.383 INFO [stdout] test stack::test::snapshot_with_empty ... ok
Nov 18 04:04:04.383 INFO [stdout] test macros::tests::missing_end ... ok
Nov 18 04:04:04.383 INFO [stdout] test macros::tests::wrong_negatives ... ok
Nov 18 04:04:04.383 INFO [stdout] test macros::tests::empty ... ok
Nov 18 04:04:04.383 INFO [stdout] test macros::tests::wrong_pos ... ok
Nov 18 04:04:04.383 INFO [stdout] test position::tests::cmp_panic ... ok
Nov 18 04:04:04.383 INFO [stdout] test macros::tests::wrong_positives ... ok
Nov 18 04:04:04.383 INFO [stdout] 
Nov 18 04:04:04.383 INFO [stdout] test result: ok. 46 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:04:04.383 INFO [stdout] 
Nov 18 04:04:04.383 INFO [stdout] 
Nov 18 04:04:04.383 INFO [stdout] running 4 tests
Nov 18 04:04:04.383 INFO [stdout] test expression ... ok
Nov 18 04:04:04.383 INFO [stdout] test number ... ok
Nov 18 04:04:04.383 INFO [stdout] test parens ... ok
Nov 18 04:04:04.383 INFO [stdout] test prec_climb ... ok
Nov 18 04:04:04.383 INFO [stdout] 
Nov 18 04:04:04.383 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:04:04.384 INFO [stdout] 
Nov 18 04:04:04.384 INFO [stdout] 
Nov 18 04:04:04.384 INFO [stdout] running 11 tests
Nov 18 04:04:04.384 INFO [stdout] test number_minus_zero ... ok
Nov 18 04:04:04.384 INFO [stdout] test null ... ok
Nov 18 04:04:04.384 INFO [stdout] test float_with_exp ... ok
Nov 18 04:04:04.384 INFO [stdout] test number_zero ... ok
Nov 18 04:04:04.384 INFO [stdout] test object ... ok
Nov 18 04:04:04.385 INFO [stdout] test string_with_escapes ... ok
Nov 18 04:04:04.385 INFO [stdout] test array ... ok
Nov 18 04:04:04.385 INFO [stdout] test ast ... ok
Nov 18 04:04:04.385 INFO [stdout] test float ... ok
Nov 18 04:04:04.385 INFO [stdout] test array_empty ... ok
Nov 18 04:04:04.385 INFO [stdout] test bool ... ok
Nov 18 04:04:04.385 INFO [stdout] 
Nov 18 04:04:04.385 INFO [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:04:04.385 INFO [stdout] 
Nov 18 04:04:04.385 INFO [stderr]      Running /target/debug/deps/calculator-8028a4fb87993777
Nov 18 04:04:04.385 INFO [stderr]      Running /target/debug/deps/json-91380800b3a60c74
Nov 18 04:04:04.385 INFO [stderr]    Doc-tests pest
Nov 18 04:04:05.538 INFO [stdout] 
Nov 18 04:04:05.538 INFO [stdout] running 57 tests
Nov 18 04:04:08.687 INFO [stdout] test src/error.rs - error::Error<R>::with_path (line 150) ... ok
Nov 18 04:04:10.255 INFO [stdout] test src/error.rs - error::Error<R>::new_from_pos (line 66) ... ok
Nov 18 04:04:10.463 INFO [stdout] test src/iterators/flat_pairs.rs - iterators::flat_pairs::FlatPairs<'i, R>::tokens (line 48) ... ok
Nov 18 04:04:10.523 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::as_rule (line 50) ... ok
Nov 18 04:04:11.452 INFO [stdout] test src/error.rs - error::Error<R>::renamed_rules (line 186) ... ok
Nov 18 04:04:13.764 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::as_str (line 79) ... ok
Nov 18 04:04:13.890 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::as_span (line 136) ... ok
Nov 18 04:04:13.943 INFO [stdout] test src/error.rs - error::Error<R>::new_from_span (line 104) ... ok
Nov 18 04:04:13.944 INFO [stdout] test src/lib.rs -  (line 49) ... ignored
Nov 18 04:04:16.546 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::into_inner (line 166) ... ok
Nov 18 04:04:16.839 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::tokens (line 194) ... ok
Nov 18 04:04:17.583 INFO [stdout] test src/iterators/pairs.rs - iterators::pairs::Pairs<'i, R>::concat (line 89) ... ok
Nov 18 04:04:19.375 INFO [stdout] test src/iterators/pair.rs - iterators::pair::Pair<'i, R>::into_span (line 109) ... ok
Nov 18 04:04:19.667 INFO [stdout] test src/iterators/pairs.rs - iterators::pairs::Pairs<'i, R>::as_str (line 56) ... ok
Nov 18 04:04:21.319 INFO [stdout] test src/iterators/pairs.rs - iterators::pairs::Pairs<'i, R>::flatten (line 117) ... ok
Nov 18 04:04:22.095 INFO [stdout] test src/iterators/pairs.rs - iterators::pairs::Pairs<'i, R>::tokens (line 147) ... ok
Nov 18 04:04:22.235 INFO [stdout] test src/macros.rs - fails_with (line 261) ... ok
Nov 18 04:04:27.213 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::atomic (line 758) ... ok
Nov 18 04:04:27.387 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::atomicity (line 144) ... ok
Nov 18 04:04:29.053 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::end_of_input (line 659) ... ok
Nov 18 04:04:29.815 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::match_char_by (line 448) ... ok
Nov 18 04:04:29.816 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::lookahead (line 691) ... ok
Nov 18 04:04:30.222 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::match_insensitive (line 513) ... ok
Nov 18 04:04:30.225 INFO [stdout] test src/macros.rs - parses_to (line 160) ... ok
Nov 18 04:04:31.012 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::match_range (line 544) ... ok
Nov 18 04:04:33.039 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::new (line 101) ... ok
Nov 18 04:04:35.040 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::restore_on_err (line 1001) ... ok
Nov 18 04:04:35.138 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::position (line 123) ... ok
Nov 18 04:04:36.519 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::optional (line 411) ... ok
Nov 18 04:04:36.719 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::match_string (line 482) ... ok
Nov 18 04:04:36.719 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::repeat (line 368) ... ok
Nov 18 04:04:38.567 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::rule (line 167) ... ok
Nov 18 04:04:38.735 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::sequence (line 321) ... ok
Nov 18 04:04:42.039 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::skip (line 575) ... ok
Nov 18 04:04:42.056 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_peek (line 847) ... ok
Nov 18 04:04:44.760 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_drop (line 974) ... ok
Nov 18 04:04:44.945 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::skip_until (line 606) ... ok
Nov 18 04:04:45.688 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_match_peek (line 902) ... ok
Nov 18 04:04:45.791 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_match_pop (line 935) ... ok
Nov 18 04:04:46.827 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_push (line 811) ... ok
Nov 18 04:04:47.023 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::stack_pop (line 875) ... ok
Nov 18 04:04:48.927 INFO [stdout] test src/position.rs - position::Position<'i>::from_start (line 34) ... ok
Nov 18 04:04:48.927 INFO [stdout] test src/prec_climber.rs - prec_climber::PrecClimber<R>::climb (line 154) ... ignored
Nov 18 04:04:49.711 INFO [stdout] test src/parser_state.rs - parser_state::ParserState<'i, R>::start_of_input (line 629) ... ok
Nov 18 04:04:50.927 INFO [stdout] test src/position.rs - position::Position<'i>::line_col (line 92) ... ok
Nov 18 04:04:51.103 INFO [stdout] test src/parser_state.rs - parser_state::state (line 62) ... ok
Nov 18 04:04:51.103 INFO [stdout] test src/position.rs - position::Position<'i>::span (line 69) ... ok
Nov 18 04:04:51.372 INFO [stdout] test src/prec_climber.rs - prec_climber::Operator<R>::new (line 45) ... ok
Nov 18 04:04:51.858 INFO [stdout] test src/position.rs - position::Position<'i>::pos (line 49) ... ok
Nov 18 04:04:52.964 INFO [stdout] test src/position.rs - position::Position<'i>::line_of (line 154) ... ok
Nov 18 04:04:53.263 INFO [stdout] test src/prec_climber.rs - prec_climber::PrecClimber<R>::new (line 100) ... ok
Nov 18 04:04:53.447 INFO [stdout] test src/span.rs - span::Span<'i>::as_str (line 133) ... ok
Nov 18 04:04:54.083 INFO [stdout] test src/span.rs - span::Span<'i>::end (line 55) ... ok
Nov 18 04:04:54.083 INFO [stdout] test src/span.rs - span::Span<'i>::end_pos (line 92) ... ok
Nov 18 04:04:54.255 INFO [stdout] test src/span.rs - span::Span<'i>::start_pos (line 73) ... ok
Nov 18 04:04:54.294 INFO [stdout] test src/span.rs - span::Span<'i>::start (line 37) ... ok
Nov 18 04:04:54.414 INFO [stdout] test src/span.rs - span::Span<'i>::split (line 111) ... ok
Nov 18 04:04:54.414 INFO [stdout] 
Nov 18 04:04:54.414 INFO [stdout] test result: ok. 55 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out
Nov 18 04:04:54.414 INFO [stdout] 
Nov 18 04:04:54.462 INFO [stderr] su: No module specific data is present
Nov 18 04:04:54.819 INFO running `"docker" "inspect" "e779a930349a5bffb073a2235e56dd3374ccb893b6fb313acf1f84d3a53c81e1"`
Nov 18 04:04:55.076 INFO running `"docker" "rm" "-f" "e779a930349a5bffb073a2235e56dd3374ccb893b6fb313acf1f84d3a53c81e1"`
Nov 18 04:04:55.463 INFO [stdout] e779a930349a5bffb073a2235e56dd3374ccb893b6fb313acf1f84d3a53c81e1