Dec 15 01:49:18.537 INFO testing phile-0.1.4 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 01:49:18.537 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 15 01:49:18.911 INFO [stdout] 5dd1820d6a980604986b13568b7dcd7d55c046a2338b782f6cac02648ab9af95
Dec 15 01:49:18.913 INFO running `"docker" "start" "-a" "5dd1820d6a980604986b13568b7dcd7d55c046a2338b782f6cac02648ab9af95"`
Dec 15 01:49:20.527 INFO [stderr] usermod: no changes
Dec 15 01:49:20.670 INFO [stderr]    Compiling phile v0.1.4 (/source)
Dec 15 01:49:30.491 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.92s
Dec 15 01:49:30.491 INFO [stderr] su: No module specific data is present
Dec 15 01:49:31.108 INFO running `"docker" "inspect" "5dd1820d6a980604986b13568b7dcd7d55c046a2338b782f6cac02648ab9af95"`
Dec 15 01:49:31.393 INFO running `"docker" "rm" "-f" "5dd1820d6a980604986b13568b7dcd7d55c046a2338b782f6cac02648ab9af95"`
Dec 15 01:49:31.683 INFO [stdout] 5dd1820d6a980604986b13568b7dcd7d55c046a2338b782f6cac02648ab9af95
Dec 15 01:49:31.758 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 15 01:49:32.172 INFO [stdout] 4005a4dd6bc86cf72b299fed8889c890b3aef279c3081cfa5daa9b7a085c09a9
Dec 15 01:49:32.176 INFO running `"docker" "start" "-a" "4005a4dd6bc86cf72b299fed8889c890b3aef279c3081cfa5daa9b7a085c09a9"`
Dec 15 01:49:33.327 INFO [stderr] usermod: no changes
Dec 15 01:49:33.483 INFO [stderr]    Compiling quickcheck v0.4.1
Dec 15 01:49:37.483 INFO [stderr]    Compiling phile v0.1.4 (/source)
Dec 15 01:49:42.931 INFO [stderr] warning: unused import: `unicode_xid::UnicodeXID`
Dec 15 01:49:42.931 INFO [stderr]   --> tests/lexer.rs:50:5
Dec 15 01:49:42.931 INFO [stderr]    |
Dec 15 01:49:42.931 INFO [stderr] 50 | use unicode_xid::UnicodeXID;
Dec 15 01:49:42.931 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^
Dec 15 01:49:42.931 INFO [stderr]    |
Dec 15 01:49:42.931 INFO [stderr]    = note: #[warn(unused_imports)] on by default
Dec 15 01:49:42.931 INFO [stderr] 
Dec 15 01:49:42.955 INFO [stderr] warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead
Dec 15 01:49:42.955 INFO [stderr]   --> tests/lexer.rs:47:5
Dec 15 01:49:42.955 INFO [stderr]    |
Dec 15 01:49:42.955 INFO [stderr] 47 | use std::ascii::AsciiExt;
Dec 15 01:49:42.955 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^
Dec 15 01:49:42.955 INFO [stderr]    |
Dec 15 01:49:42.955 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 15 01:49:42.955 INFO [stderr] 
Dec 15 01:49:43.679 INFO [stderr] warning: unused import: `std::ascii::AsciiExt`
Dec 15 01:49:43.679 INFO [stderr]   --> tests/lexer.rs:47:5
Dec 15 01:49:43.679 INFO [stderr]    |
Dec 15 01:49:43.679 INFO [stderr] 47 | use std::ascii::AsciiExt;
Dec 15 01:49:43.679 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^
Dec 15 01:49:43.681 INFO [stderr] 
Dec 15 01:49:44.676 INFO [stderr] warning: function is never used: `is_hor_ws`
Dec 15 01:49:44.676 INFO [stderr]    --> tests/lexer.rs:774:1
Dec 15 01:49:44.676 INFO [stderr]     |
Dec 15 01:49:44.676 INFO [stderr] 774 | fn is_hor_ws(ch: char) -> bool {
Dec 15 01:49:44.676 INFO [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 15 01:49:44.676 INFO [stderr]     |
Dec 15 01:49:44.676 INFO [stderr]     = note: #[warn(dead_code)] on by default
Dec 15 01:49:44.676 INFO [stderr] 
Dec 15 01:49:48.891 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 15.53s
Dec 15 01:49:48.891 INFO [stderr] su: No module specific data is present
Dec 15 01:49:49.647 INFO running `"docker" "inspect" "4005a4dd6bc86cf72b299fed8889c890b3aef279c3081cfa5daa9b7a085c09a9"`
Dec 15 01:49:49.983 INFO running `"docker" "rm" "-f" "4005a4dd6bc86cf72b299fed8889c890b3aef279c3081cfa5daa9b7a085c09a9"`
Dec 15 01:49:50.231 INFO [stdout] 4005a4dd6bc86cf72b299fed8889c890b3aef279c3081cfa5daa9b7a085c09a9
Dec 15 01:49:50.238 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 15 01:49:50.692 INFO [stdout] d4fab5e6093cebedb6a9183376642f39abc97ddf32c0ebd76ec1090f5a3cdbdc
Dec 15 01:49:50.699 INFO running `"docker" "start" "-a" "d4fab5e6093cebedb6a9183376642f39abc97ddf32c0ebd76ec1090f5a3cdbdc"`
Dec 15 01:49:51.680 INFO [stderr] usermod: no changes
Dec 15 01:49:51.796 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Dec 15 01:49:51.809 INFO [stderr]      Running /target/debug/deps/phile-f4aff3df5d768398
Dec 15 01:49:51.814 INFO [stdout] 
Dec 15 01:49:51.814 INFO [stdout] running 0 tests
Dec 15 01:49:51.814 INFO [stdout] 
Dec 15 01:49:51.814 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 01:49:51.814 INFO [stdout] 
Dec 15 01:49:51.816 INFO [stderr]      Running /target/debug/deps/lexer-4824eb2d8e0bdc54
Dec 15 01:49:51.818 INFO [stdout] 
Dec 15 01:49:51.818 INFO [stdout] running 30 tests
Dec 15 01:49:51.975 INFO [stdout] test no_sources ... ok
Dec 15 01:49:51.979 INFO [stdout] test multiple_empty_sources ... ok
Dec 15 01:49:51.983 INFO [stdout] test shrink_valid_line_comment_items ... ok
Dec 15 01:49:52.126 INFO [stdout] test shrink_valid_line_comment_size ... ok
Dec 15 01:49:52.126 INFO [stdout] test shrink_valid_number_items ... ok
Dec 15 01:49:52.126 INFO [stdout] test shrink_valid_punctuation ... ok
Dec 15 01:49:52.151 INFO [stdout] test shrink_valid_source ... ok
Dec 15 01:49:52.155 INFO [stdout] test shrink_valid_string_items ... ok
Dec 15 01:49:52.203 INFO [stdout] test shrink_valid_string_size ... ok
Dec 15 01:49:52.215 INFO [stdout] test shrink_valid_whitespace_items ... ok
Dec 15 01:49:52.222 INFO [stdout] test shrink_valid_whitespace_size ... ok
Dec 15 01:49:52.246 INFO [stdout] test shrink_valid_word_items ... ok
Dec 15 01:49:52.445 INFO [stdout] test shrink_valid_word_size ... ok
Dec 15 01:49:52.535 INFO [stdout] test single_empty_source ... ok
Dec 15 01:49:52.727 INFO [stdout] test identifier_with_inner_unicode_digit ... ok
Dec 15 01:49:53.207 INFO [stdout] test unicode_digit_is_not_numeric ... ok
Dec 15 01:49:53.763 INFO [stdout] test invalid_source ... ok
Dec 15 01:49:56.471 INFO [stdout] test valid_punct ... ok
Dec 15 01:49:56.555 INFO [stdout] test all_valid_punctuation ... ok
Dec 15 01:49:56.848 INFO [stdout] test interesting_valid_sources ... ok
Dec 15 01:49:58.155 INFO [stdout] test ascii_digit_is_numeric ... ok
Dec 15 01:49:58.383 INFO [stdout] test valid_number ... ok
Dec 15 01:49:58.400 INFO [stdout] test windows_newline_in_comment ... ok
Dec 15 01:49:58.835 INFO [stdout] test valid_line_comment ... ok
Dec 15 01:49:58.927 INFO [stdout] test any_valid_token ... ok
Dec 15 01:49:59.699 INFO [stdout] test valid_whitespace ... ok
Dec 15 01:49:59.750 INFO [stdout] test random_sources ... ok
Dec 15 01:49:59.758 INFO [stdout] test valid_string ... ok
Dec 15 01:50:03.717 INFO [stdout] test valid_word ... ok
Dec 15 01:50:11.009 INFO [stdout] test valid_source ... ok
Dec 15 01:50:11.009 INFO [stdout] 
Dec 15 01:50:11.009 INFO [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 01:50:11.009 INFO [stdout] 
Dec 15 01:50:11.010 INFO [stderr]      Running /target/debug/deps/parser-4caabc18907038e3
Dec 15 01:50:11.012 INFO [stdout] 
Dec 15 01:50:11.012 INFO [stdout] running 54 tests
Dec 15 01:50:11.013 INFO [stdout] test empty_source ... ok
Dec 15 01:50:11.681 INFO [stdout] test invalid_atomic_expression ... ok
Dec 15 01:50:11.771 INFO [stdout] test invalid_cast_expression ... ok
Dec 15 01:50:11.840 INFO [stdout] test invalid_atomic_type ... ok
Dec 15 01:50:11.995 INFO [stdout] test invalid_array_type ... ok
Dec 15 01:50:11.995 INFO [stdout] test invalid_block_expression ... ok
Dec 15 01:50:12.027 INFO [stdout] test invalid_array_expression ... ok
Dec 15 01:50:12.055 INFO [stdout] test invalid_call_expression ... ok
Dec 15 01:50:12.283 INFO [stdout] test invalid_function_type ... ok
Dec 15 01:50:12.463 INFO [stdout] test invalid_impl_def ... ok
Dec 15 01:50:12.564 INFO [stdout] test invalid_if_expression ... ok
Dec 15 01:50:12.751 INFO [stdout] test invalid_postfix_type ... ok
Dec 15 01:50:12.764 INFO [stdout] test invalid_binary_expression ... ok
Dec 15 01:50:12.791 INFO [stdout] test invalid_fn_def ... ok
Dec 15 01:50:12.815 INFO [stdout] test invalid_prefix_expression ... ok
Dec 15 01:50:12.856 INFO [stdout] test invalid_conditional_expression ... ok
Dec 15 01:50:12.963 INFO [stdout] test invalid_prefix_type ... ok
Dec 15 01:50:13.087 INFO [stdout] test invalid_enum_decl ... ok
Dec 15 01:50:13.123 INFO [stdout] test statement_position_and_multiline_range ... ok
Dec 15 01:50:13.123 INFO [stdout] test invalid_function_expression ... ok
Dec 15 01:50:13.267 INFO [stdout] test valid_additive_expression ... ok
Dec 15 01:50:13.272 INFO [stdout] test valid_and_expression ... ok
Dec 15 01:50:13.355 INFO [stdout] test invalid_tuple_type ... ok
Dec 15 01:50:13.382 INFO [stdout] test invalid_tuple_expression ... ok
Dec 15 01:50:13.466 INFO [stdout] test valid_array_type ... ok
Dec 15 01:50:13.519 INFO [stdout] test valid_atomic_expression ... ok
Dec 15 01:50:13.519 INFO [stdout] test invalid_subscript_expression ... ok
Dec 15 01:50:13.532 INFO [stdout] test valid_closure ... ok
Dec 15 01:50:13.576 INFO [stdout] test valid_cast_expression ... ok
Dec 15 01:50:13.635 INFO [stdout] test invalid_member_access_expression ... ok
Dec 15 01:50:13.640 INFO [stdout] test valid_comparison_expression ... ok
Dec 15 01:50:13.671 INFO [stdout] test valid_comparison_expression_noassoc ... ok
Dec 15 01:50:13.674 INFO [stdout] test valid_enum_decl ... ok
Dec 15 01:50:13.739 INFO [stdout] test valid_conditional_expression ... ok
Dec 15 01:50:13.795 INFO [stdout] test valid_if_expression ... ok
Dec 15 01:50:13.804 INFO [stdout] test valid_function_type ... ok
Dec 15 01:50:13.884 INFO [stdout] test valid_function_call ... ok
Dec 15 01:50:13.899 INFO [stdout] test valid_multiplicative_expression ... ok
Dec 15 01:50:13.915 INFO [stdout] test valid_impl_def ... ok
Dec 15 01:50:13.959 INFO [stdout] test valid_member_access ... ok
Dec 15 01:50:13.977 INFO [stdout] test valid_non_atomic_term ... ok
Dec 15 01:50:14.006 INFO [stdout] test valid_named_type ... ok
Dec 15 01:50:14.014 INFO [stdout] test valid_or_expression ... ok
Dec 15 01:50:14.019 INFO [stdout] test valid_prefix_expression ... ok
Dec 15 01:50:14.066 INFO [stdout] test valid_struct_or_class_decl ... ok
Dec 15 01:50:14.117 INFO [stdout] test valid_postfix_type ... ok
Dec 15 01:50:14.117 INFO [stdout] test valid_prefix_type ... ok
Dec 15 01:50:14.117 INFO [stdout] test valid_subscript ... ok
Dec 15 01:50:14.166 INFO [stdout] test valid_range_expression ... ok
Dec 15 01:50:14.168 INFO [stdout] test valid_tuple_type ... ok
Dec 15 01:50:14.220 INFO [stdout] test valid_variable_decl ... ok
Dec 15 01:50:14.296 INFO [stdout] test invalid_toplevel ... ok
Dec 15 01:50:14.330 INFO [stdout] test invalid_struct_or_class_decl ... ok
Dec 15 01:50:53.579 INFO [stdout] test valid_fn_def ... ok
Dec 15 01:50:53.579 INFO [stdout] 
Dec 15 01:50:53.579 INFO [stdout] test result: ok. 54 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 01:50:53.579 INFO [stdout] 
Dec 15 01:50:53.581 INFO [stderr]    Doc-tests phile
Dec 15 01:50:55.499 INFO [stdout] 
Dec 15 01:50:55.500 INFO [stdout] running 0 tests
Dec 15 01:50:55.500 INFO [stdout] 
Dec 15 01:50:55.500 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 01:50:55.500 INFO [stdout] 
Dec 15 01:50:55.511 INFO [stderr] su: No module specific data is present
Dec 15 01:50:56.075 INFO running `"docker" "inspect" "d4fab5e6093cebedb6a9183376642f39abc97ddf32c0ebd76ec1090f5a3cdbdc"`
Dec 15 01:50:56.341 INFO running `"docker" "rm" "-f" "d4fab5e6093cebedb6a9183376642f39abc97ddf32c0ebd76ec1090f5a3cdbdc"`
Dec 15 01:50:56.614 INFO [stdout] d4fab5e6093cebedb6a9183376642f39abc97ddf32c0ebd76ec1090f5a3cdbdc