Nov 18 03:59:34.870 INFO testing phile-0.1.4 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 03:59:34.870 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 03:59:35.101 INFO [stdout] e2a7a0a644a701c163a2de793a45271d7ae3da2d01bb8ccfdcfb7bbb4becc482
Nov 18 03:59:35.104 INFO running `"docker" "start" "-a" "e2a7a0a644a701c163a2de793a45271d7ae3da2d01bb8ccfdcfb7bbb4becc482"`
Nov 18 03:59:36.995 INFO [stderr] usermod: no changes
Nov 18 03:59:37.161 INFO [stderr]    Compiling phile v0.1.4 (/source)
Nov 18 03:59:46.071 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.03s
Nov 18 03:59:46.071 INFO [stderr] su: No module specific data is present
Nov 18 03:59:46.708 INFO running `"docker" "inspect" "e2a7a0a644a701c163a2de793a45271d7ae3da2d01bb8ccfdcfb7bbb4becc482"`
Nov 18 03:59:47.018 INFO running `"docker" "rm" "-f" "e2a7a0a644a701c163a2de793a45271d7ae3da2d01bb8ccfdcfb7bbb4becc482"`
Nov 18 03:59:47.291 INFO [stdout] e2a7a0a644a701c163a2de793a45271d7ae3da2d01bb8ccfdcfb7bbb4becc482
Nov 18 03:59:47.298 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 03:59:47.731 INFO [stdout] 6f1108a9731a1a257ee1c047c4a6ceff914a25cabe3622a1e70e7c1d82e183ba
Nov 18 03:59:47.734 INFO running `"docker" "start" "-a" "6f1108a9731a1a257ee1c047c4a6ceff914a25cabe3622a1e70e7c1d82e183ba"`
Nov 18 03:59:48.885 INFO [stderr] usermod: no changes
Nov 18 03:59:49.046 INFO [stderr]    Compiling phile v0.1.4 (/source)
Nov 18 03:59:52.732 INFO [stderr] warning: unused import: `unicode_xid::UnicodeXID`
Nov 18 03:59:52.732 INFO [stderr]   --> tests/lexer.rs:50:5
Nov 18 03:59:52.733 INFO [stderr]    |
Nov 18 03:59:52.733 INFO [stderr] 50 | use unicode_xid::UnicodeXID;
Nov 18 03:59:52.733 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^
Nov 18 03:59:52.733 INFO [stderr]    |
Nov 18 03:59:52.734 INFO [stderr]    = note: #[warn(unused_imports)] on by default
Nov 18 03:59:52.734 INFO [stderr] 
Nov 18 03:59:52.759 INFO [stderr] warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead
Nov 18 03:59:52.759 INFO [stderr]   --> tests/lexer.rs:47:5
Nov 18 03:59:52.759 INFO [stderr]    |
Nov 18 03:59:52.759 INFO [stderr] 47 | use std::ascii::AsciiExt;
Nov 18 03:59:52.759 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^
Nov 18 03:59:52.759 INFO [stderr]    |
Nov 18 03:59:52.759 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 18 03:59:52.759 INFO [stderr] 
Nov 18 03:59:54.303 INFO [stderr] warning: unused import: `std::ascii::AsciiExt`
Nov 18 03:59:54.303 INFO [stderr]   --> tests/lexer.rs:47:5
Nov 18 03:59:54.303 INFO [stderr]    |
Nov 18 03:59:54.303 INFO [stderr] 47 | use std::ascii::AsciiExt;
Nov 18 03:59:54.303 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^
Nov 18 03:59:54.303 INFO [stderr] 
Nov 18 03:59:55.300 INFO [stderr] warning: function is never used: `is_hor_ws`
Nov 18 03:59:55.300 INFO [stderr]    --> tests/lexer.rs:774:1
Nov 18 03:59:55.301 INFO [stderr]     |
Nov 18 03:59:55.301 INFO [stderr] 774 | fn is_hor_ws(ch: char) -> bool {
Nov 18 03:59:55.301 INFO [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 18 03:59:55.301 INFO [stderr]     |
Nov 18 03:59:55.302 INFO [stderr]     = note: #[warn(dead_code)] on by default
Nov 18 03:59:55.302 INFO [stderr] 
Nov 18 04:00:00.054 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.12s
Nov 18 04:00:00.054 INFO [stderr] su: No module specific data is present
Nov 18 04:00:00.637 INFO running `"docker" "inspect" "6f1108a9731a1a257ee1c047c4a6ceff914a25cabe3622a1e70e7c1d82e183ba"`
Nov 18 04:00:01.167 INFO running `"docker" "rm" "-f" "6f1108a9731a1a257ee1c047c4a6ceff914a25cabe3622a1e70e7c1d82e183ba"`
Nov 18 04:00:01.576 INFO [stdout] 6f1108a9731a1a257ee1c047c4a6ceff914a25cabe3622a1e70e7c1d82e183ba
Nov 18 04:00:01.582 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 04:00:02.071 INFO [stdout] d5ed883da6d14045efdde2e62d73f20fa8dd0f251fad934006114243d61945f2
Nov 18 04:00:02.077 INFO running `"docker" "start" "-a" "d5ed883da6d14045efdde2e62d73f20fa8dd0f251fad934006114243d61945f2"`
Nov 18 04:00:03.143 INFO [stderr] usermod: no changes
Nov 18 04:00:03.235 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Nov 18 04:00:03.243 INFO [stderr]      Running /target/debug/deps/phile-8f3b12464662958b
Nov 18 04:00:03.246 INFO [stdout] 
Nov 18 04:00:03.246 INFO [stdout] running 0 tests
Nov 18 04:00:03.246 INFO [stdout] 
Nov 18 04:00:03.246 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:00:03.247 INFO [stdout] 
Nov 18 04:00:03.249 INFO [stderr]      Running /target/debug/deps/lexer-aa184bc74c8ff84f
Nov 18 04:00:03.251 INFO [stdout] 
Nov 18 04:00:03.251 INFO [stdout] running 30 tests
Nov 18 04:00:03.479 INFO [stdout] test multiple_empty_sources ... ok
Nov 18 04:00:03.491 INFO [stdout] test no_sources ... ok
Nov 18 04:00:03.491 INFO [stdout] test shrink_valid_line_comment_items ... ok
Nov 18 04:00:03.691 INFO [stdout] test shrink_valid_line_comment_size ... ok
Nov 18 04:00:03.711 INFO [stdout] test shrink_valid_number_items ... ok
Nov 18 04:00:03.717 INFO [stdout] test shrink_valid_punctuation ... ok
Nov 18 04:00:03.754 INFO [stdout] test shrink_valid_source ... ok
Nov 18 04:00:03.765 INFO [stdout] test shrink_valid_string_items ... ok
Nov 18 04:00:03.808 INFO [stdout] test identifier_with_inner_unicode_digit ... ok
Nov 18 04:00:03.809 INFO [stdout] test shrink_valid_whitespace_items ... ok
Nov 18 04:00:03.813 INFO [stdout] test shrink_valid_string_size ... ok
Nov 18 04:00:03.827 INFO [stdout] test shrink_valid_whitespace_size ... ok
Nov 18 04:00:03.829 INFO [stdout] test shrink_valid_word_items ... ok
Nov 18 04:00:03.874 INFO [stdout] test single_empty_source ... ok
Nov 18 04:00:04.078 INFO [stdout] test shrink_valid_word_size ... ok
Nov 18 04:00:04.334 INFO [stdout] test unicode_digit_is_not_numeric ... ok
Nov 18 04:00:07.531 INFO [stdout] test all_valid_punctuation ... ok
Nov 18 04:00:07.627 INFO [stdout] test invalid_source ... ok
Nov 18 04:00:08.971 INFO [stdout] test interesting_valid_sources ... ok
Nov 18 04:00:08.995 INFO [stdout] test valid_line_comment ... ok
Nov 18 04:00:09.459 INFO [stdout] test random_sources ... ok
Nov 18 04:00:09.771 INFO [stdout] test ascii_digit_is_numeric ... ok
Nov 18 04:00:09.859 INFO [stdout] test windows_newline_in_comment ... ok
Nov 18 04:00:10.107 INFO [stdout] test valid_number ... ok
Nov 18 04:00:10.611 INFO [stdout] test any_valid_token ... ok
Nov 18 04:00:11.567 INFO [stdout] test valid_whitespace ... ok
Nov 18 04:00:11.769 INFO [stdout] test valid_punct ... ok
Nov 18 04:00:12.451 INFO [stdout] test valid_string ... ok
Nov 18 04:00:15.695 INFO [stdout] test valid_word ... ok
Nov 18 04:00:24.187 INFO [stdout] test valid_source ... ok
Nov 18 04:00:24.187 INFO [stderr]      Running /target/debug/deps/parser-398c7247117bf520
Nov 18 04:00:24.187 INFO [stdout] 
Nov 18 04:00:24.188 INFO [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:00:24.188 INFO [stdout] 
Nov 18 04:00:24.188 INFO [stdout] 
Nov 18 04:00:24.188 INFO [stdout] running 54 tests
Nov 18 04:00:24.195 INFO [stdout] test empty_source ... ok
Nov 18 04:00:24.694 INFO [stdout] test invalid_atomic_expression ... ok
Nov 18 04:00:24.905 INFO [stdout] test invalid_array_type ... ok
Nov 18 04:00:24.923 INFO [stdout] test invalid_conditional_expression ... ok
Nov 18 04:00:24.952 INFO [stdout] test invalid_block_expression ... ok
Nov 18 04:00:25.111 INFO [stdout] test invalid_cast_expression ... ok
Nov 18 04:00:25.179 INFO [stdout] test invalid_atomic_type ... ok
Nov 18 04:00:25.335 INFO [stdout] test invalid_call_expression ... ok
Nov 18 04:00:25.383 INFO [stdout] test invalid_array_expression ... ok
Nov 18 04:00:25.411 INFO [stdout] test invalid_function_type ... ok
Nov 18 04:00:25.591 INFO [stdout] test invalid_enum_decl ... ok
Nov 18 04:00:25.619 INFO [stdout] test invalid_if_expression ... ok
Nov 18 04:00:25.651 INFO [stdout] test invalid_fn_def ... ok
Nov 18 04:00:25.746 INFO [stdout] test invalid_prefix_type ... ok
Nov 18 04:00:25.785 INFO [stdout] test invalid_impl_def ... ok
Nov 18 04:00:25.895 INFO [stdout] test invalid_postfix_type ... ok
Nov 18 04:00:25.931 INFO [stdout] test invalid_binary_expression ... ok
Nov 18 04:00:26.139 INFO [stdout] test invalid_prefix_expression ... ok
Nov 18 04:00:26.359 INFO [stdout] test invalid_subscript_expression ... ok
Nov 18 04:00:26.399 INFO [stdout] test statement_position_and_multiline_range ... ok
Nov 18 04:00:26.421 INFO [stdout] test valid_additive_expression ... ok
Nov 18 04:00:26.479 INFO [stdout] test invalid_toplevel ... ok
Nov 18 04:00:26.499 INFO [stdout] test valid_and_expression ... ok
Nov 18 04:00:26.503 INFO [stdout] test valid_array_type ... ok
Nov 18 04:00:26.579 INFO [stdout] test valid_cast_expression ... ok
Nov 18 04:00:26.579 INFO [stdout] test invalid_tuple_type ... ok
Nov 18 04:00:26.647 INFO [stdout] test valid_atomic_expression ... ok
Nov 18 04:00:26.659 INFO [stdout] test valid_closure ... ok
Nov 18 04:00:26.659 INFO [stdout] test invalid_struct_or_class_decl ... ok
Nov 18 04:00:26.659 INFO [stdout] test valid_comparison_expression ... ok
Nov 18 04:00:26.695 INFO [stdout] test valid_comparison_expression_noassoc ... ok
Nov 18 04:00:26.715 INFO [stdout] test valid_conditional_expression ... ok
Nov 18 04:00:26.742 INFO [stdout] test valid_function_call ... ok
Nov 18 04:00:26.758 INFO [stdout] test valid_function_type ... ok
Nov 18 04:00:26.807 INFO [stdout] test invalid_tuple_expression ... ok
Nov 18 04:00:26.807 INFO [stdout] test valid_impl_def ... ok
Nov 18 04:00:26.807 INFO [stdout] test valid_enum_decl ... ok
Nov 18 04:00:26.820 INFO [stdout] test invalid_member_access_expression ... ok
Nov 18 04:00:26.864 INFO [stdout] test valid_or_expression ... ok
Nov 18 04:00:26.864 INFO [stdout] test valid_if_expression ... ok
Nov 18 04:00:26.907 INFO [stdout] test valid_member_access ... ok
Nov 18 04:00:26.941 INFO [stdout] test valid_multiplicative_expression ... ok
Nov 18 04:00:26.941 INFO [stdout] test valid_named_type ... ok
Nov 18 04:00:26.942 INFO [stdout] test valid_non_atomic_term ... ok
Nov 18 04:00:26.948 INFO [stdout] test valid_postfix_type ... ok
Nov 18 04:00:26.963 INFO [stdout] test valid_prefix_expression ... ok
Nov 18 04:00:27.003 INFO [stdout] test invalid_function_expression ... ok
Nov 18 04:00:27.004 INFO [stdout] test valid_prefix_type ... ok
Nov 18 04:00:27.015 INFO [stdout] test valid_subscript ... ok
Nov 18 04:00:27.022 INFO [stdout] test valid_tuple_type ... ok
Nov 18 04:00:27.055 INFO [stdout] test valid_variable_decl ... ok
Nov 18 04:00:27.056 INFO [stdout] test valid_range_expression ... ok
Nov 18 04:00:27.091 INFO [stdout] test valid_struct_or_class_decl ... ok
Nov 18 04:01:05.243 INFO [stdout] test valid_fn_def ... ok
Nov 18 04:01:05.243 INFO [stdout] 
Nov 18 04:01:05.243 INFO [stdout] test result: ok. 54 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:01:05.243 INFO [stdout] 
Nov 18 04:01:05.247 INFO [stderr]    Doc-tests phile
Nov 18 04:01:06.798 INFO [stdout] 
Nov 18 04:01:06.799 INFO [stdout] running 0 tests
Nov 18 04:01:06.799 INFO [stdout] 
Nov 18 04:01:06.799 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:01:06.799 INFO [stdout] 
Nov 18 04:01:06.807 INFO [stderr] su: No module specific data is present
Nov 18 04:01:07.080 INFO running `"docker" "inspect" "d5ed883da6d14045efdde2e62d73f20fa8dd0f251fad934006114243d61945f2"`
Nov 18 04:01:07.201 INFO running `"docker" "rm" "-f" "d5ed883da6d14045efdde2e62d73f20fa8dd0f251fad934006114243d61945f2"`
Nov 18 04:01:07.300 INFO [stdout] d5ed883da6d14045efdde2e62d73f20fa8dd0f251fad934006114243d61945f2