[INFO] fetching crate pest_vm 2.1.0...
[INFO] testing pest_vm-2.1.0 against master#a77da2d454e6caa227a85b16410b95f93495e7e0 for pr-91031
[INFO] extracting crate pest_vm 2.1.0 into /workspace/builds/worker-14/source
[INFO] validating manifest of crates.io crate pest_vm 2.1.0 on toolchain a77da2d454e6caa227a85b16410b95f93495e7e0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate pest_vm 2.1.0
[INFO] finished tweaking crates.io crate pest_vm 2.1.0
[INFO] tweaked toml for crates.io crate pest_vm 2.1.0 written to /workspace/builds/worker-14/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] a11d69939e2cf2d7ca5e2b762d0e51b57a12fe03a14b84b41f3db34581603c0a
[INFO] running `Command { std: "docker" "start" "-a" "a11d69939e2cf2d7ca5e2b762d0e51b57a12fe03a14b84b41f3db34581603c0a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a11d69939e2cf2d7ca5e2b762d0e51b57a12fe03a14b84b41f3db34581603c0a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a11d69939e2cf2d7ca5e2b762d0e51b57a12fe03a14b84b41f3db34581603c0a", kill_on_drop: false }`
[INFO] [stdout] a11d69939e2cf2d7ca5e2b762d0e51b57a12fe03a14b84b41f3db34581603c0a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e3c03b54691667790fa2d1a5ed79aa7c1cde15324a982fd6d219dfa2832279c8
[INFO] running `Command { std: "docker" "start" "-a" "e3c03b54691667790fa2d1a5ed79aa7c1cde15324a982fd6d219dfa2832279c8", kill_on_drop: false }`
[INFO] [stderr]    Compiling pest_vm v2.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.73s
[INFO] running `Command { std: "docker" "inspect" "e3c03b54691667790fa2d1a5ed79aa7c1cde15324a982fd6d219dfa2832279c8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e3c03b54691667790fa2d1a5ed79aa7c1cde15324a982fd6d219dfa2832279c8", kill_on_drop: false }`
[INFO] [stdout] e3c03b54691667790fa2d1a5ed79aa7c1cde15324a982fd6d219dfa2832279c8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 0cd79c9b870906a8058505cfc38e2ef2b71f34021a989f9cd59d07ed65a6f6b3
[INFO] running `Command { std: "docker" "start" "-a" "0cd79c9b870906a8058505cfc38e2ef2b71f34021a989f9cd59d07ed65a6f6b3", kill_on_drop: false }`
[INFO] [stderr]    Compiling pest_vm v2.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 4.29s
[INFO] running `Command { std: "docker" "inspect" "0cd79c9b870906a8058505cfc38e2ef2b71f34021a989f9cd59d07ed65a6f6b3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0cd79c9b870906a8058505cfc38e2ef2b71f34021a989f9cd59d07ed65a6f6b3", kill_on_drop: false }`
[INFO] [stdout] 0cd79c9b870906a8058505cfc38e2ef2b71f34021a989f9cd59d07ed65a6f6b3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 52bf1b81e16b5d46e45c17d4221a4481b6ee4b0fc1200610997bfd6d1102372f
[INFO] running `Command { std: "docker" "start" "-a" "52bf1b81e16b5d46e45c17d4221a4481b6ee4b0fc1200610997bfd6d1102372f", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/pest_vm-eae0aa3fecb9b6eb)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/grammar.rs (/opt/rustwide/target/debug/deps/grammar-fff8e3220ec6ee42)
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 72 tests
[INFO] [stdout] test peek ... ok
[INFO] [stdout] test optional_empty ... ok
[INFO] [stdout] test ascii_alphanumerics ... ok
[INFO] [stdout] test ascii_alphas ... ok
[INFO] [stdout] test ascii_oct_digits ... ok
[INFO] [stdout] test ascii_bin_digits ... ok
[INFO] [stdout] test peek_all ... ok
[INFO] [stdout] test ascii_alpha_lowers ... ok
[INFO] [stdout] test peek_slice_23 ... ok
[INFO] [stdout] test double_neg_pred ... ok
[INFO] [stdout] test insensitive ... ok
[INFO] [stdout] test pos_pred ... ok
[INFO] [stdout] test choice_range ... ok
[INFO] [stdout] test pop_fail ... ok
[INFO] [stdout] test neg_pred ... ok
[INFO] [stdout] test newline ... ok
[INFO] [stdout] test ascii_nonzero_digits ... ok
[INFO] [stdout] test ascii_digits ... ok
[INFO] [stdout] test repeat_max_atomic_once ... ok
[INFO] [stdout] test repeat_atomic_strings ... ok
[INFO] [stdout] test checkpoint_restore ... ok
[INFO] [stdout] test ascii_hex_digits ... ok
[INFO] [stdout] test asciis ... ok
[INFO] [stdout] test optional_string ... ok
[INFO] [stdout] test ident ... ok
[INFO] [stdout] test range ... ok
[INFO] [stdout] test ascii_alpha_uppers ... ok
[INFO] [stdout] test pop ... ok
[INFO] [stdout] test pop_all ... ok
[INFO] [stdout] test choice_string ... ok
[INFO] [stdout] test repeat_min_max_thrice ... ok
[INFO] [stdout] test repeat_atomic_empty ... ok
[INFO] [stdout] test repeat_comment ... ok
[INFO] [stdout] test repeat_exact ... ok
[INFO] [stdout] test repeat_min_max_atomic_twice ... ok
[INFO] [stdout] test repeat_mutate_stack ... ok
[INFO] [stdout] test repeat_max_twice ... ok
[INFO] [stdout] test repeat_empty ... ok
[INFO] [stdout] test repeat_max_once ... ok
[INFO] [stdout] test repeat_min_max_atomic_thrice ... ok
[INFO] [stdout] test repeat_min_thrice ... ok
[INFO] [stdout] test repeat_max_atomic_twice ... ok
[INFO] [stdout] test repeat_min_twice ... ok
[INFO] [stdout] test repeat_once_atomic_strings ... ok
[INFO] [stdout] test repeat_once_strings ... ok
[INFO] [stdout] test repeat_min_atomic_thrice ... ok
[INFO] [stdout] test repeat_min_atomic_twice ... ok
[INFO] [stdout] test repeat_min_max_twice ... ok
[INFO] [stdout] test repeat_strings ... ok
[INFO] [stdout] test sequence ... ok
[INFO] [stdout] test sequence_atomic ... ok
[INFO] [stdout] test string ... ok
[INFO] [stdout] test sequence_compound ... ok
[INFO] [stdout] test unicode ... ok
[INFO] [stdout] test soi_at_start ... ok
[INFO] [stdout] test sequence_compound_nested ... ok
[INFO] [stdout] test sequence_non_atomic ... ok
[INFO] [stdout] test shadowing ... ok
[INFO] [stdout] test sequence_atomic_compound ... ok
[INFO] [stdout] test repeat_max_atomic_thrice - should panic ... ok
[INFO] [stdout] test repeat_atomic_space - should panic ... ok
[INFO] [stdout] test repeat_once_atomic_empty - should panic ... ok
[INFO] [stdout] test repeat_once_atomic_space - should panic ... ok
[INFO] [stdout] test repeat_min_atomic_once - should panic ... ok
[INFO] [stdout] test repeat_max_thrice - should panic ... ok
[INFO] [stdout] test repeat_min_atomic_space - should panic ... ok
[INFO] [stdout] test repeat_min_max_atomic_space - should panic ... ok
[INFO] [stdout] test repeat_min_once - should panic ... ok
[INFO] [stdout] test repeat_max_atomic_space - should panic ... ok
[INFO] [stdout] test repeat_once_empty - should panic ... ok
[INFO] [stdout] test sequence_compound_nested_space - should panic ... ok
[INFO] [stdout] test sequence_atomic_space - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 72 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.25s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/lists.rs (/opt/rustwide/target/debug/deps/lists-c98b0939da44f164)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test items ... ok
[INFO] [stdout] test children ... ok
[INFO] [stdout] test nested_item ... ok
[INFO] [stdout] test nested_then_not ... ok
[INFO] [stdout] test item ... ok
[INFO] [stdout] test nested_items ... ok
[INFO] [stdout] test nested_two_levels ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/reporting.rs (/opt/rustwide/target/debug/deps/reporting-0165b4bedeea91be)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test nested ... ok
[INFO] [stdout] test choices_a_progress ... ok
[INFO] [stdout] test mixed_progress ... ok
[INFO] [stdout] test choices_b_progress ... ok
[INFO] [stdout] test choices_no_progress ... ok
[INFO] [stdout] test negative ... ok
[INFO] [stdout] test negative_match ... ok
[INFO] [stdout] test choices ... ok
[INFO] [stdout] test mixed ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests pest_vm
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "52bf1b81e16b5d46e45c17d4221a4481b6ee4b0fc1200610997bfd6d1102372f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "52bf1b81e16b5d46e45c17d4221a4481b6ee4b0fc1200610997bfd6d1102372f", kill_on_drop: false }`
[INFO] [stdout] 52bf1b81e16b5d46e45c17d4221a4481b6ee4b0fc1200610997bfd6d1102372f