[INFO] fetching crate pest_vm 2.1.0...
[INFO] testing pest_vm-2.1.0 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] extracting crate pest_vm 2.1.0 into /workspace/builds/worker-2/source
[INFO] validating manifest of crates.io crate pest_vm 2.1.0 on toolchain 722e1797249a965b6335aebd65d777f917e498f1
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "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-2/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "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" "+722e1797249a965b6335aebd65d777f917e498f1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8d21d7025cd01b19d2819561db0946a37f5802b9492bb86449f3725423b11346
[INFO] running `Command { std: "docker" "start" "-a" "8d21d7025cd01b19d2819561db0946a37f5802b9492bb86449f3725423b11346", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8d21d7025cd01b19d2819561db0946a37f5802b9492bb86449f3725423b11346", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8d21d7025cd01b19d2819561db0946a37f5802b9492bb86449f3725423b11346", kill_on_drop: false }`
[INFO] [stdout] 8d21d7025cd01b19d2819561db0946a37f5802b9492bb86449f3725423b11346
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "+722e1797249a965b6335aebd65d777f917e498f1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 609fe472caa3669762cd4b95a695b88721c391c6815388aa7e4d6189a769a7b5
[INFO] running `Command { std: "docker" "start" "-a" "609fe472caa3669762cd4b95a695b88721c391c6815388aa7e4d6189a769a7b5", kill_on_drop: false }`
[INFO] [stderr]    Compiling ucd-trie v0.1.3
[INFO] [stderr]    Compiling maplit v1.0.2
[INFO] [stderr]    Compiling pest v2.1.3
[INFO] [stderr]    Compiling pest_meta v2.1.3
[INFO] [stderr]    Compiling pest_vm v2.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.51s
[INFO] running `Command { std: "docker" "inspect" "609fe472caa3669762cd4b95a695b88721c391c6815388aa7e4d6189a769a7b5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "609fe472caa3669762cd4b95a695b88721c391c6815388aa7e4d6189a769a7b5", kill_on_drop: false }`
[INFO] [stdout] 609fe472caa3669762cd4b95a695b88721c391c6815388aa7e4d6189a769a7b5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] b5165772c7cd87367883c9e5a3bd8cf982c9d547d14aa9980f988a282e9a6f2d
[INFO] running `Command { std: "docker" "start" "-a" "b5165772c7cd87367883c9e5a3bd8cf982c9d547d14aa9980f988a282e9a6f2d", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling pest_vm v2.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 5.60s
[INFO] running `Command { std: "docker" "inspect" "b5165772c7cd87367883c9e5a3bd8cf982c9d547d14aa9980f988a282e9a6f2d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b5165772c7cd87367883c9e5a3bd8cf982c9d547d14aa9980f988a282e9a6f2d", kill_on_drop: false }`
[INFO] [stdout] b5165772c7cd87367883c9e5a3bd8cf982c9d547d14aa9980f988a282e9a6f2d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] c3df5e015b33e67c73370c4597e5ce45177148392cd28a3c800fb019321a08c3
[INFO] running `Command { std: "docker" "start" "-a" "c3df5e015b33e67c73370c4597e5ce45177148392cd28a3c800fb019321a08c3", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.85s
[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 ascii_alphas ... ok
[INFO] [stdout] test ascii_nonzero_digits ... ok
[INFO] [stdout] test ascii_alphanumerics ... ok
[INFO] [stdout] test checkpoint_restore ... ok
[INFO] [stdout] test ascii_alpha_uppers ... ok
[INFO] [stdout] test ascii_alpha_lowers ... ok
[INFO] [stdout] test double_neg_pred ... ok
[INFO] [stdout] test ascii_digits ... ok
[INFO] [stdout] test ascii_hex_digits ... ok
[INFO] [stdout] test choice_string ... ok
[INFO] [stdout] test asciis ... ok
[INFO] [stdout] test ascii_oct_digits ... ok
[INFO] [stdout] test insensitive ... ok
[INFO] [stdout] test ascii_bin_digits ... ok
[INFO] [stdout] test choice_range ... ok
[INFO] [stdout] test ident ... ok
[INFO] [stdout] test newline ... ok
[INFO] [stdout] test optional_string ... ok
[INFO] [stdout] test optional_empty ... ok
[INFO] [stdout] test neg_pred ... ok
[INFO] [stdout] test peek_all ... ok
[INFO] [stdout] test peek ... ok
[INFO] [stdout] test peek_slice_23 ... ok
[INFO] [stdout] test pop ... ok
[INFO] [stdout] test range ... ok
[INFO] [stdout] test pop_all ... ok
[INFO] [stdout] test repeat_max_atomic_once ... ok
[INFO] [stdout] test pop_fail ... ok
[INFO] [stdout] test repeat_atomic_empty ... ok
[INFO] [stdout] test pos_pred ... ok
[INFO] [stdout] test repeat_exact ... ok
[INFO] [stdout] test repeat_max_once ... ok
[INFO] [stdout] test repeat_max_atomic_twice ... ok
[INFO] [stdout] test repeat_atomic_strings ... ok
[INFO] [stdout] test repeat_comment ... ok
[INFO] [stdout] test repeat_max_twice ... ok
[INFO] [stdout] test repeat_empty ... ok
[INFO] [stdout] test repeat_min_atomic_twice ... ok
[INFO] [stdout] test repeat_min_max_atomic_thrice ... ok
[INFO] [stdout] test repeat_min_max_atomic_twice ... ok
[INFO] [stdout] test repeat_min_atomic_thrice ... ok
[INFO] [stdout] test repeat_min_max_twice ... ok
[INFO] [stdout] test repeat_mutate_stack ... ok
[INFO] [stdout] test repeat_min_thrice ... ok
[INFO] [stdout] test repeat_min_max_thrice ... ok
[INFO] [stdout] test repeat_min_twice ... ok
[INFO] [stdout] test sequence_atomic ... ok
[INFO] [stdout] test repeat_once_atomic_strings ... ok
[INFO] [stdout] test sequence_atomic_compound ... ok
[INFO] [stdout] test sequence ... ok
[INFO] [stdout] test sequence_compound ... ok
[INFO] [stdout] test repeat_strings ... ok
[INFO] [stdout] test repeat_once_strings ... ok
[INFO] [stdout] test shadowing ... ok
[INFO] [stdout] test soi_at_start ... ok
[INFO] [stdout] test string ... ok
[INFO] [stdout] test sequence_non_atomic ... ok
[INFO] [stdout] test unicode ... ok
[INFO] [stdout] test sequence_compound_nested ... ok
[INFO] [stderr]      Running tests/lists.rs (/opt/rustwide/target/debug/deps/lists-c98b0939da44f164)
[INFO] [stdout] test repeat_max_atomic_space - should panic ... ok
[INFO] [stdout] test repeat_max_thrice - should panic ... ok
[INFO] [stdout] test repeat_atomic_space - should panic ... ok
[INFO] [stdout] test repeat_max_atomic_thrice - should panic ... ok
[INFO] [stdout] test repeat_min_atomic_once - should panic ... ok
[INFO] [stdout] test repeat_min_atomic_space - should panic ... ok
[INFO] [stdout] test repeat_min_once - should panic ... ok
[INFO] [stdout] test repeat_min_max_atomic_space - should panic ... ok
[INFO] [stdout] test repeat_once_atomic_empty - should panic ... ok
[INFO] [stdout] test repeat_once_empty - should panic ... ok
[INFO] [stdout] test sequence_atomic_space - should panic ... ok
[INFO] [stdout] test repeat_once_atomic_space - should panic ... ok
[INFO] [stdout] test sequence_compound_nested_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.16s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test children ... ok
[INFO] [stdout] test nested_items ... ok
[INFO] [stdout] test nested_then_not ... ok
[INFO] [stdout] test nested_item ... ok
[INFO] [stdout] test nested_two_levels ... ok
[INFO] [stdout] test item ... ok
[INFO] [stdout] test items ... 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 choices_b_progress ... ok
[INFO] [stdout] test mixed ... ok
[INFO] [stdout] test choices_no_progress ... ok
[INFO] [stdout] test choices ... ok
[INFO] [stdout] test choices_a_progress ... ok
[INFO] [stdout] test mixed_progress ... ok
[INFO] [stdout] test negative_match ... ok
[INFO] [stdout] test negative ... ok
[INFO] [stdout] test nested ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[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" "c3df5e015b33e67c73370c4597e5ce45177148392cd28a3c800fb019321a08c3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c3df5e015b33e67c73370c4597e5ce45177148392cd28a3c800fb019321a08c3", kill_on_drop: false }`
[INFO] [stdout] c3df5e015b33e67c73370c4597e5ce45177148392cd28a3c800fb019321a08c3