Dec 07 18:10:43.025 INFO testing dynparser-0.4.2 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 18:10:43.026 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 18:10:43.626 INFO [stdout] d140e3bdd3ff9dcfcbe9cf5def3bc30ea9214d25fc1b38fcdfff46fdabad554d
Dec 07 18:10:43.630 INFO running `"docker" "start" "-a" "d140e3bdd3ff9dcfcbe9cf5def3bc30ea9214d25fc1b38fcdfff46fdabad554d"`
Dec 07 18:10:45.095 INFO [stderr] usermod: no changes
Dec 07 18:10:45.184 INFO [stderr]    Compiling idata v0.1.0
Dec 07 18:10:45.990 INFO [stderr]    Compiling dynparser v0.4.2 (/source)
Dec 07 18:10:50.518 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.39s
Dec 07 18:10:50.520 INFO [stderr] su: No module specific data is present
Dec 07 18:10:51.288 INFO running `"docker" "inspect" "d140e3bdd3ff9dcfcbe9cf5def3bc30ea9214d25fc1b38fcdfff46fdabad554d"`
Dec 07 18:10:51.666 INFO running `"docker" "rm" "-f" "d140e3bdd3ff9dcfcbe9cf5def3bc30ea9214d25fc1b38fcdfff46fdabad554d"`
Dec 07 18:10:51.960 INFO [stdout] d140e3bdd3ff9dcfcbe9cf5def3bc30ea9214d25fc1b38fcdfff46fdabad554d
Dec 07 18:10:51.968 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 18:10:52.486 INFO [stdout] aa24b6979ae2ecf18ff4fa02884b03bb1cc1ce66371b0440753a1064c9947b1b
Dec 07 18:10:52.488 INFO running `"docker" "start" "-a" "aa24b6979ae2ecf18ff4fa02884b03bb1cc1ce66371b0440753a1064c9947b1b"`
Dec 07 18:10:54.044 INFO [stderr] usermod: no changes
Dec 07 18:10:54.149 INFO [stderr]    Compiling dynparser v0.4.2 (/source)
Dec 07 18:10:59.485 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.41s
Dec 07 18:10:59.488 INFO [stderr] su: No module specific data is present
Dec 07 18:11:00.258 INFO running `"docker" "inspect" "aa24b6979ae2ecf18ff4fa02884b03bb1cc1ce66371b0440753a1064c9947b1b"`
Dec 07 18:11:00.622 INFO running `"docker" "rm" "-f" "aa24b6979ae2ecf18ff4fa02884b03bb1cc1ce66371b0440753a1064c9947b1b"`
Dec 07 18:11:00.908 INFO [stdout] aa24b6979ae2ecf18ff4fa02884b03bb1cc1ce66371b0440753a1064c9947b1b
Dec 07 18:11:00.916 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 18:11:01.546 INFO [stdout] f1bde0b100ca6dc5dc925da1f93620d1682ca54d5a74d32277caa3b795c3d5eb
Dec 07 18:11:01.548 INFO running `"docker" "start" "-a" "f1bde0b100ca6dc5dc925da1f93620d1682ca54d5a74d32277caa3b795c3d5eb"`
Dec 07 18:11:03.087 INFO [stderr] usermod: no changes
Dec 07 18:11:03.148 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Dec 07 18:11:03.148 INFO [stdout] 
Dec 07 18:11:03.148 INFO [stderr]      Running /target/debug/deps/dynparser-5d2a97a59c21cacd
Dec 07 18:11:03.148 INFO [stdout] running 46 tests
Dec 07 18:11:03.148 INFO [stdout] test parser::atom::test::test_parse_literal_with_new_line ... ok
Dec 07 18:11:03.148 INFO [stdout] test parser::atom::test::test_parse_literal_ok2 ... ok
Dec 07 18:11:03.148 INFO [stdout] test parser::atom::test::test_parse_literal_ok ... ok
Dec 07 18:11:03.148 INFO [stdout] test parser::atom::test::test_parse_literal_fail_short_text2parse ... ok
Dec 07 18:11:03.148 INFO [stdout] test parser::atom::test::test_parse_literal_fail2 ... ok
Dec 07 18:11:03.148 INFO [stdout] test parser::atom::test::test_parse_match_eof_ok ... ok
Dec 07 18:11:03.148 INFO [stdout] test parser::atom::test::test_parse_match_err ... ok
Dec 07 18:11:03.148 INFO [stdout] test parser::atom::test::test_parse_match_ok ... ok
Dec 07 18:11:03.150 INFO [stdout] test parser::atom::test::test_parse_literal_fail ... ok
Dec 07 18:11:03.150 INFO [stdout] test parser::expression::test::test_parse_literal_error ... ok
Dec 07 18:11:03.150 INFO [stdout] test parser::atom::test::test_parse_match_eof_error ... ok
Dec 07 18:11:03.150 INFO [stdout] test parser::expression::test::test_parse_and_fail ... ok
Dec 07 18:11:03.150 INFO [stdout] test parser::expression::test::test_parse_and_ok ... ok
Dec 07 18:11:03.156 INFO [stdout] test parser::atom::test::test_parse_dot ... ok
Dec 07 18:11:03.157 INFO [stdout] test parser::expression::test::test_parse_or_ok ... ok
Dec 07 18:11:03.157 INFO [stdout] test parser::test::test_parse_expr_and_ok ... ok
Dec 07 18:11:03.157 INFO [stdout] test parser::expression::test::test_parse_or_fail ... ok
Dec 07 18:11:03.157 INFO [stdout] test parser::expression::test::test_parse_not_ok ... ok
Dec 07 18:11:03.157 INFO [stdout] test parser::expression::test::test_parse_not_fail ... ok
Dec 07 18:11:03.157 INFO [stdout] test parser::test::test_parse_expr_or_ok ... ok
Dec 07 18:11:03.176 INFO [stdout] test parser::expression::test::test_parse_literal_ok ... ok
Dec 07 18:11:03.176 INFO [stdout] test parser::test::test_parse_expr_lit ... ok
Dec 07 18:11:03.176 INFO [stdout] test peg::test::invalid_peg1 ... ok
Dec 07 18:11:03.180 INFO [stdout] test parser::test::test_parse_expr_not_ok ... ok
Dec 07 18:11:03.180 INFO [stdout] test parser::expression::test::test_parse_repeat_ok ... ok
Dec 07 18:11:03.180 INFO [stdout] test parser::expression::test::test_parse_repeat_fail ... ok
Dec 07 18:11:03.180 INFO [stdout] test parser::test::test_parse_expr_repeat_ok ... ok
Dec 07 18:11:03.196 INFO [stdout] test peg::test::parse_literal ... ok
Dec 07 18:11:03.199 INFO [stdout] test peg::test::parse_and_literal ... ok
Dec 07 18:11:03.220 INFO [stdout] test peg::test::parse_dot ... ok
Dec 07 18:11:03.220 INFO [stdout] test peg::test::invalid_peg2 ... ok
Dec 07 18:11:03.236 INFO [stdout] test peg::test::parse_one_or_more ... ok
Dec 07 18:11:03.236 INFO [stdout] test peg::test::parse_dot_with_rep ... ok
Dec 07 18:11:03.236 INFO [stdout] test peg::test::parse_negation ... ok
Dec 07 18:11:03.236 INFO [stdout] test peg::test::parse_klean ... ok
Dec 07 18:11:03.236 INFO [stdout] test peg::test::parse_one_or_zero ... ok
Dec 07 18:11:03.252 INFO [stdout] test peg::test::parse_or_literal ... ok
Dec 07 18:11:03.260 INFO [stdout] test peg::test::peg_incorrect_match ... ok
Dec 07 18:11:03.280 INFO [stdout] test peg::test::parse_ref_rule ... ok
Dec 07 18:11:03.280 INFO [stdout] test peg::test::test_match ... ok
Dec 07 18:11:03.288 INFO [stdout] test peg::test::validate_peg4 ... ok
Dec 07 18:11:03.292 INFO [stdout] test peg::test::validate_peg3 ... ok
Dec 07 18:11:03.316 INFO [stdout] test peg::test::parse_parenth ... ok
Dec 07 18:11:03.316 INFO [stdout] test peg::test::validate_peg5 ... ok
Dec 07 18:11:03.328 INFO [stdout] test peg::test::validate_peg1 ... ok
Dec 07 18:11:03.336 INFO [stdout] test peg::test::validate_peg2 ... ok
Dec 07 18:11:03.336 INFO [stderr]      Running /target/debug/deps/dynparser-26eb5da7dff6d4ff
Dec 07 18:11:03.336 INFO [stdout] 
Dec 07 18:11:03.336 INFO [stdout] test result: ok. 46 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:11:03.336 INFO [stdout] 
Dec 07 18:11:03.342 INFO [stdout] 
Dec 07 18:11:03.342 INFO [stderr]    Doc-tests dynparser
Dec 07 18:11:03.342 INFO [stdout] running 0 tests
Dec 07 18:11:03.342 INFO [stdout] 
Dec 07 18:11:03.342 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:11:03.342 INFO [stdout] 
Dec 07 18:11:04.472 INFO [stdout] 
Dec 07 18:11:04.472 INFO [stdout] running 48 tests
Dec 07 18:11:09.709 INFO [stdout] test src/ast/flat.rs - ast::flat::consume_val (line 287) ... ok
Dec 07 18:11:10.865 INFO [stdout] test src/ast/flat.rs - ast::flat::get_nodename (line 265) ... ok
Dec 07 18:11:11.016 INFO [stdout] test src/ast/flat.rs - ast::flat::get_node_val (line 218) ... ok
Dec 07 18:11:12.176 INFO [stdout] test src/ast/flat.rs - ast::flat::consume_this_value (line 236) ... ok
Dec 07 18:11:13.028 INFO [stdout] test src/ast/flat.rs - ast::flat::peek_first_node (line 197) ... ok
Dec 07 18:11:13.620 INFO [stdout] test src/ast/flat.rs - ast::flat::ast::Node::flatten (line 44) ... ok
Dec 07 18:11:14.069 INFO [stdout] test src/ast/flat.rs - ast::flat::consume_node_end_rule_name (line 138) ... ok
Dec 07 18:11:14.432 INFO [stdout] test src/ast/flat.rs - ast::flat::consume_node_start_rule_name (line 101) ... ok
Dec 07 18:11:15.752 INFO [stdout] test src/ast/flat.rs - ast::flat::split_first_nodes (line 168) ... ok
Dec 07 18:11:17.736 INFO [stdout] test src/ast/mod.rs - ast::Node::passthrow_except (line 99) ... ok
Dec 07 18:11:17.886 INFO [stdout] test src/ast/mod.rs - ast::Node::compact (line 151) ... ok
Dec 07 18:11:18.708 INFO [stdout] test src/ast/mod.rs - ast::Node::prune (line 53) ... ok
Dec 07 18:11:19.116 INFO [stdout] test src/ast/mod.rs - ast::consume_this_value (line 343) ... ok
Dec 07 18:11:19.116 INFO [stdout] test src/ast/mod.rs - ast::check_empty_nodes (line 407) ... ok
Dec 07 18:11:21.924 INFO [stdout] test src/ast/mod.rs - ast::consume_node_get_subnodes_for_rule_name_is (line 372) ... ok
Dec 07 18:11:23.112 INFO [stdout] test src/ast/mod.rs - ast::consume_val (line 287) ... ok
Dec 07 18:11:23.444 INFO [stdout] test src/ast/mod.rs - ast::error (line 22) ... ok
Dec 07 18:11:26.724 INFO [stdout] test src/ast/mod.rs - ast::get_nodename_and_nodes (line 215) ... ok
Dec 07 18:11:27.094 INFO [stdout] test src/ast/mod.rs - ast::get_node_val (line 237) ... ok
Dec 07 18:11:27.381 INFO [stdout] test src/ast/mod.rs - ast::get_nodes_unique_val (line 256) ... ok
Dec 07 18:11:27.535 INFO [stdout] test src/ast/mod.rs - ast::get_nodes_unique_val (line 269) ... ok
Dec 07 18:11:29.165 INFO [stdout] test src/ast/mod.rs - ast::peek_first_node (line 424) ... ok
Dec 07 18:11:31.104 INFO [stdout] test src/ast/mod.rs - ast::split_first_nodes (line 313) ... ok
Dec 07 18:11:32.468 INFO [stdout] test src/lib.rs -  (line 38) ... ok
Dec 07 18:11:32.492 INFO [stdout] test src/lib.rs -  (line 10) ... ok
Dec 07 18:11:33.560 INFO [stdout] test src/lib.rs -  (line 90) ... ok
Dec 07 18:11:35.168 INFO [stdout] test src/lib.rs - ematch (line 248) ... ok
Dec 07 18:11:35.872 INFO [stdout] test src/lib.rs - dot (line 221) ... ok
Dec 07 18:11:36.963 INFO [stdout] test src/lib.rs - and (line 310) ... ok
Dec 07 18:11:38.972 INFO [stdout] test src/lib.rs - ematch (line 268) ... ok
Dec 07 18:11:40.540 INFO [stdout] test src/lib.rs - error (line 176) ... ok
Dec 07 18:11:42.188 INFO [stdout] test src/lib.rs - error (line 189) ... ok
Dec 07 18:11:42.643 INFO [stdout] test src/lib.rs - lit (line 152) ... ok
Dec 07 18:11:43.233 INFO [stdout] test src/lib.rs - not (line 358) ... ok
Dec 07 18:11:45.376 INFO [stdout] test src/lib.rs - ref_rule (line 427) ... ok
Dec 07 18:11:45.376 INFO [stdout] test src/peg/gcode.rs - peg::gcode (line 35) ... ignored
Dec 07 18:11:45.413 INFO [stdout] test src/lib.rs - or (line 334) ... ok
Dec 07 18:11:45.420 INFO [stdout] test src/lib.rs - parse (line 470) ... ok
Dec 07 18:11:46.852 INFO [stdout] test src/lib.rs - rep (line 384) ... ok
Dec 07 18:11:48.284 INFO [stdout] test src/lib.rs - rep (line 398) ... ok
Dec 07 18:11:49.812 INFO [stdout] test src/lib.rs - rules (line 117) ... ok
Dec 07 18:11:49.880 INFO [stdout] test src/parser/expression/mod.rs - parser::expression::SetOfRules::merge (line 85) ... ok
Dec 07 18:11:50.748 INFO [stdout] test src/parser/expression/mod.rs - parser::expression::SetOfRules::add (line 53) ... ok
Dec 07 18:11:51.002 INFO [stdout] test src/peg/gcode.rs - peg::gcode (line 5) ... ok
Dec 07 18:11:51.388 INFO [stdout] test src/peg/mod.rs - peg::rules_from_peg (line 111) ... ok
Dec 07 18:11:51.489 INFO [stdout] test src/peg/mod.rs - peg::rules_from_peg (line 130) ... ok
Dec 07 18:11:51.612 INFO [stdout] test src/peg/mod.rs - peg::rules_from_peg (line 80) ... ok
Dec 07 18:11:51.960 INFO [stdout] test src/peg/peg2code.rs - peg::peg2code (line 11) ... ok
Dec 07 18:11:51.960 INFO [stdout] 
Dec 07 18:11:51.960 INFO [stdout] test result: ok. 47 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 07 18:11:51.960 INFO [stdout] 
Dec 07 18:11:51.983 INFO [stderr] su: No module specific data is present
Dec 07 18:11:52.270 INFO running `"docker" "inspect" "f1bde0b100ca6dc5dc925da1f93620d1682ca54d5a74d32277caa3b795c3d5eb"`
Dec 07 18:11:52.381 INFO running `"docker" "rm" "-f" "f1bde0b100ca6dc5dc925da1f93620d1682ca54d5a74d32277caa3b795c3d5eb"`
Dec 07 18:11:52.530 INFO [stdout] f1bde0b100ca6dc5dc925da1f93620d1682ca54d5a74d32277caa3b795c3d5eb