Dec 07 03:33:28.685 INFO testing pvm-0.1.0 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 03:33:28.685 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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"`
Dec 07 03:33:29.130 INFO [stdout] 33af501a95977fa6071c9eb8ec9cb19c5a548da38177c38ac5ef28f091908210
Dec 07 03:33:29.136 INFO running `"docker" "start" "-a" "33af501a95977fa6071c9eb8ec9cb19c5a548da38177c38ac5ef28f091908210"`
Dec 07 03:33:30.276 INFO [stderr] usermod: no changes
Dec 07 03:33:30.312 INFO [stderr]    Compiling pvm v0.1.0 (/source)
Dec 07 03:33:32.165 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.88s
Dec 07 03:33:32.169 INFO [stderr] su: No module specific data is present
Dec 07 03:33:32.454 INFO running `"docker" "inspect" "33af501a95977fa6071c9eb8ec9cb19c5a548da38177c38ac5ef28f091908210"`
Dec 07 03:33:32.547 INFO running `"docker" "rm" "-f" "33af501a95977fa6071c9eb8ec9cb19c5a548da38177c38ac5ef28f091908210"`
Dec 07 03:33:32.694 INFO [stdout] 33af501a95977fa6071c9eb8ec9cb19c5a548da38177c38ac5ef28f091908210
Dec 07 03:33:32.696 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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"`
Dec 07 03:33:32.941 INFO [stdout] 557bf29383fc558d28462cce9df69280ec8e4c8cba893aee606ac2a25ea68bed
Dec 07 03:33:32.944 INFO running `"docker" "start" "-a" "557bf29383fc558d28462cce9df69280ec8e4c8cba893aee606ac2a25ea68bed"`
Dec 07 03:33:33.943 INFO [stderr] usermod: no changes
Dec 07 03:33:34.054 INFO [stderr]    Compiling pvm v0.1.0 (/source)
Dec 07 03:33:35.736 INFO [stderr] warning: unused import: `std::io`
Dec 07 03:33:35.736 INFO [stderr]  --> tests/calculator1.rs:5:5
Dec 07 03:33:35.736 INFO [stderr]   |
Dec 07 03:33:35.736 INFO [stderr] 5 | use std::io;
Dec 07 03:33:35.736 INFO [stderr]   |     ^^^^^^^
Dec 07 03:33:35.736 INFO [stderr]   |
Dec 07 03:33:35.736 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 07 03:33:35.736 INFO [stderr] 
Dec 07 03:33:38.688 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.71s
Dec 07 03:33:38.692 INFO [stderr] su: No module specific data is present
Dec 07 03:33:39.264 INFO running `"docker" "inspect" "557bf29383fc558d28462cce9df69280ec8e4c8cba893aee606ac2a25ea68bed"`
Dec 07 03:33:39.490 INFO running `"docker" "rm" "-f" "557bf29383fc558d28462cce9df69280ec8e4c8cba893aee606ac2a25ea68bed"`
Dec 07 03:33:39.842 INFO [stdout] 557bf29383fc558d28462cce9df69280ec8e4c8cba893aee606ac2a25ea68bed
Dec 07 03:33:39.846 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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"`
Dec 07 03:33:40.228 INFO [stdout] 0eed9f1c08c64bf6344f0e2d899b92e39e6674efd4411babceb95bf7232e880e
Dec 07 03:33:40.230 INFO running `"docker" "start" "-a" "0eed9f1c08c64bf6344f0e2d899b92e39e6674efd4411babceb95bf7232e880e"`
Dec 07 03:33:41.047 INFO [stderr] usermod: no changes
Dec 07 03:33:41.124 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 07 03:33:41.128 INFO [stderr]      Running /target/debug/deps/pvm-6dda9949a9597615
Dec 07 03:33:41.128 INFO [stdout] 
Dec 07 03:33:41.128 INFO [stdout] running 34 tests
Dec 07 03:33:41.135 INFO [stdout] test ast::tests::simple_iteration_grammar ... ok
Dec 07 03:33:41.135 INFO [stdout] test ast::tests::simple_lookahead_grammar ... ok
Dec 07 03:33:41.135 INFO [stdout] test ast::tests::simple_optional_subparser ... ok
Dec 07 03:33:41.135 INFO [stdout] test ast::tests::simple_char_grammar_rules ... ok
Dec 07 03:33:41.135 INFO [stdout] test machine::tests::not_predicate ... ok
Dec 07 03:33:41.135 INFO [stdout] test machine::tests::self_reference_impossible_parser ... ok
Dec 07 03:33:41.135 INFO [stdout] test machine::tests::direct_left_recursion_with_tail ... ok
Dec 07 03:33:41.135 INFO [stdout] test machine::tests::ambersand_predicate ... ok
Dec 07 03:33:41.135 INFO [stdout] test machine::tests::one_or_more_chars ... ok
Dec 07 03:33:41.136 INFO [stdout] test machine::tests::optional_predicate ... ok
Dec 07 03:33:41.136 INFO [stdout] test machine::tests::partial_commit_zero_or_more ... ok
Dec 07 03:33:41.136 INFO [stdout] test machine::tests::simple_char_range ... ok
Dec 07 03:33:41.136 INFO [stdout] test machine::tests::simple_char_choice ... ok
Dec 07 03:33:41.136 INFO [stdout] test machine::tests::simple_char_sequence ... ok
Dec 07 03:33:41.136 INFO [stdout] test machine::tests::simple_char ... ok
Dec 07 03:33:41.136 INFO [stdout] test machine::tests::simple_subparser ... ok
Dec 07 03:33:41.136 INFO [stdout] test machine::tests::simple_token_stream_result ... ok
Dec 07 03:33:41.136 INFO [stdout] test machine::tests::skip_parser ... ok
Dec 07 03:33:41.136 INFO [stdout] test machine::tests::three_subparser ... ok
Dec 07 03:33:41.136 INFO [stdout] test parser::tests::parenthetical_and_lookahead ... ok
Dec 07 03:33:41.136 INFO [stdout] test machine::tests::skip_parser_with_toggle ... ok
Dec 07 03:33:41.136 INFO [stdout] test machine::tests::zero_or_more_chars ... ok
Dec 07 03:33:41.136 INFO [stdout] test parser::tests::direct_left_recursion ... ok
Dec 07 03:33:41.136 INFO [stdout] test machine::tests::char_range_links ... ok
Dec 07 03:33:41.136 INFO [stdout] test machine::tests::direct_left_recursion ... ok
Dec 07 03:33:41.138 INFO [stdout] test parser::tests::simple_suffix_grammar ... ok
Dec 07 03:33:41.138 INFO [stdout] test parser::tests::tokenizer ... ok
Dec 07 03:33:41.148 INFO [stdout] test parser::tests::indirect_left_recursion ... ok
Dec 07 03:33:41.148 INFO [stdout] test parser::tests::simple_choice_grammar ... ok
Dec 07 03:33:41.148 INFO [stdout] test parser::tests::simple_char_grammar ... ok
Dec 07 03:33:41.148 INFO [stdout] test parser::tests::simple_prefix_grammar ... ok
Dec 07 03:33:41.148 INFO [stdout] test tests::add_multiply_variable_expression ... ok
Dec 07 03:33:41.178 INFO [stdout] test parser::tests::dogfood ... ok
Dec 07 03:33:41.180 INFO [stdout] test parser::tests::simple_parentheticals ... ok
Dec 07 03:33:41.180 INFO [stderr]      Running /target/debug/deps/calculator1-16428b7ec2441c5f
Dec 07 03:33:41.180 INFO [stdout] 
Dec 07 03:33:41.180 INFO [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 03:33:41.180 INFO [stdout] 
Dec 07 03:33:41.180 INFO [stdout] 
Dec 07 03:33:41.180 INFO [stdout] running 3 tests
Dec 07 03:33:41.180 INFO [stdout] test constants ... ok
Dec 07 03:33:41.192 INFO [stdout] test simple_expressions ... ok
Dec 07 03:33:58.810 INFO [stdout] test random_expressions ... ok
Dec 07 03:33:58.810 INFO [stdout] 
Dec 07 03:33:58.810 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 03:33:58.810 INFO [stdout] 
Dec 07 03:33:58.811 INFO [stderr]      Running /target/debug/deps/simple-9ab2613623dedeb6
Dec 07 03:33:58.813 INFO [stdout] 
Dec 07 03:33:58.813 INFO [stdout] running 1 test
Dec 07 03:33:58.813 INFO [stdout] test simple ... ok
Dec 07 03:33:58.813 INFO [stdout] 
Dec 07 03:33:58.813 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 03:33:58.813 INFO [stdout] 
Dec 07 03:33:58.813 INFO [stderr]    Doc-tests pvm
Dec 07 03:33:59.564 INFO [stdout] 
Dec 07 03:33:59.564 INFO [stdout] running 0 tests
Dec 07 03:33:59.564 INFO [stdout] 
Dec 07 03:33:59.564 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 03:33:59.564 INFO [stdout] 
Dec 07 03:33:59.567 INFO [stderr] su: No module specific data is present
Dec 07 03:34:00.569 INFO running `"docker" "inspect" "0eed9f1c08c64bf6344f0e2d899b92e39e6674efd4411babceb95bf7232e880e"`
Dec 07 03:34:00.834 INFO running `"docker" "rm" "-f" "0eed9f1c08c64bf6344f0e2d899b92e39e6674efd4411babceb95bf7232e880e"`
Dec 07 03:34:01.176 INFO [stdout] 0eed9f1c08c64bf6344f0e2d899b92e39e6674efd4411babceb95bf7232e880e