[INFO] crate pvm 0.1.0 is already in cache
[INFO] testing pvm-0.1.0 against 1.38.0 for beta-1.39-1
[INFO] extracting crate pvm 0.1.0 into work/builds/worker-6/source
[INFO] validating manifest of crates.io crate pvm 0.1.0 on toolchain 1.38.0
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+1.38.0" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started tweaking crates.io crate pvm 0.1.0
[INFO] finished tweaking crates.io crate pvm 0.1.0
[INFO] tweaked toml for crates.io crate pvm 0.1.0 written to work/builds/worker-6/source/Cargo.toml
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+1.38.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+1.38.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-6/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.38.0" "build" "--frozen"`
[INFO] [stdout] 1759178afd467b520efe87a79e87a46d6b112cf7a4b89be745d02c2695f2b4b8
[INFO] running `"docker" "start" "-a" "1759178afd467b520efe87a79e87a46d6b112cf7a4b89be745d02c2695f2b4b8"`
[INFO] [stderr]    Compiling pvm v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.70s
[INFO] running `"docker" "inspect" "1759178afd467b520efe87a79e87a46d6b112cf7a4b89be745d02c2695f2b4b8"`
[INFO] running `"docker" "rm" "-f" "1759178afd467b520efe87a79e87a46d6b112cf7a4b89be745d02c2695f2b4b8"`
[INFO] [stdout] 1759178afd467b520efe87a79e87a46d6b112cf7a4b89be745d02c2695f2b4b8
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-6/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.38.0" "test" "--frozen" "--no-run"`
[INFO] [stdout] 2f518ccf2737e0e416fb886643b0875eeee5222ee50dbeea928f62e0eeb60873
[INFO] running `"docker" "start" "-a" "2f518ccf2737e0e416fb886643b0875eeee5222ee50dbeea928f62e0eeb60873"`
[INFO] [stderr]    Compiling pvm v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr] warning: unused import: `std::io`
[INFO] [stderr]  --> tests/calculator1.rs:5:5
[INFO] [stderr]   |
[INFO] [stderr] 5 | use std::io;
[INFO] [stderr]   |     ^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: trait objects without an explicit `dyn` are deprecated
[INFO] [stderr]    --> tests/calculator1.rs:108:42
[INFO] [stderr]     |
[INFO] [stderr] 108 |     pub fn gen(total : usize, rng : &mut rand::Rng) -> Syntax {
[INFO] [stderr]     |                                          ^^^^^^^^^ help: use `dyn`: `dyn rand::Rng`
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(bare_trait_objects)]` on by default
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.26s
[INFO] running `"docker" "inspect" "2f518ccf2737e0e416fb886643b0875eeee5222ee50dbeea928f62e0eeb60873"`
[INFO] running `"docker" "rm" "-f" "2f518ccf2737e0e416fb886643b0875eeee5222ee50dbeea928f62e0eeb60873"`
[INFO] [stdout] 2f518ccf2737e0e416fb886643b0875eeee5222ee50dbeea928f62e0eeb60873
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-6/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.38.0" "test" "--frozen"`
[INFO] [stdout] d8eb797d6e38f89723b8de3fc1da69f00013d949b13e6184dadf065d00e4c8cc
[INFO] running `"docker" "start" "-a" "d8eb797d6e38f89723b8de3fc1da69f00013d949b13e6184dadf065d00e4c8cc"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/pvm-180ffb5dbb50a320
[INFO] [stdout] 
[INFO] [stdout] running 34 tests
[INFO] [stdout] test machine::tests::ambersand_predicate ... ok
[INFO] [stdout] test machine::tests::char_range_links ... ok
[INFO] [stdout] test ast::tests::simple_iteration_grammar ... ok
[INFO] [stdout] test ast::tests::simple_lookahead_grammar ... ok
[INFO] [stdout] test ast::tests::simple_optional_subparser ... ok
[INFO] [stdout] test machine::tests::direct_left_recursion ... ok
[INFO] [stdout] test ast::tests::simple_char_grammar_rules ... ok
[INFO] [stdout] test machine::tests::direct_left_recursion_with_tail ... ok
[INFO] [stdout] test machine::tests::one_or_more_chars ... ok
[INFO] [stdout] test machine::tests::partial_commit_zero_or_more ... ok
[INFO] [stdout] test machine::tests::not_predicate ... ok
[INFO] [stdout] test machine::tests::optional_predicate ... ok
[INFO] [stdout] test machine::tests::self_reference_impossible_parser ... ok
[INFO] [stdout] test machine::tests::simple_char ... ok
[INFO] [stdout] test machine::tests::simple_char_range ... ok
[INFO] [stdout] test machine::tests::simple_char_choice ... ok
[INFO] [stdout] test machine::tests::simple_char_sequence ... ok
[INFO] [stdout] test machine::tests::simple_token_stream_result ... ok
[INFO] [stdout] test machine::tests::simple_subparser ... ok
[INFO] [stdout] test machine::tests::skip_parser_with_toggle ... ok
[INFO] [stdout] test machine::tests::skip_parser ... ok
[INFO] [stdout] test machine::tests::zero_or_more_chars ... ok
[INFO] [stdout] test machine::tests::three_subparser ... ok
[INFO] [stdout] test parser::tests::direct_left_recursion ... ok
[INFO] [stdout] test parser::tests::parenthetical_and_lookahead ... ok
[INFO] [stdout] test parser::tests::simple_char_grammar ... ok
[INFO] [stdout] test parser::tests::simple_parentheticals ... ok
[INFO] [stdout] test parser::tests::indirect_left_recursion ... ok
[INFO] [stdout] test parser::tests::simple_choice_grammar ... ok
[INFO] [stdout] test parser::tests::simple_prefix_grammar ... ok
[INFO] [stdout] test parser::tests::simple_suffix_grammar ... ok
[INFO] [stdout] test parser::tests::tokenizer ... ok
[INFO] [stdout] test tests::add_multiply_variable_expression ... ok
[INFO] [stdout] test parser::tests::dogfood ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/calculator1-2439aefc7e9f5e4f
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test constants ... ok
[INFO] [stdout] test simple_expressions ... ok
[INFO] [stdout] test random_expressions ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/simple-634b7db33d1cb94a
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test simple ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests pvm
[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
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "d8eb797d6e38f89723b8de3fc1da69f00013d949b13e6184dadf065d00e4c8cc"`
[INFO] running `"docker" "rm" "-f" "d8eb797d6e38f89723b8de3fc1da69f00013d949b13e6184dadf065d00e4c8cc"`
[INFO] [stdout] d8eb797d6e38f89723b8de3fc1da69f00013d949b13e6184dadf065d00e4c8cc