Dec 14 17:15:58.065 INFO testing test-case-derive-0.2.1 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 14 17:15:58.065 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 14 17:15:58.523 INFO [stdout] 6490e9764f967977c6ce36d2c65afedb1ffba51467c76a852b5d6c2717974f75
Dec 14 17:15:58.527 INFO running `"docker" "start" "-a" "6490e9764f967977c6ce36d2c65afedb1ffba51467c76a852b5d6c2717974f75"`
Dec 14 17:15:59.775 INFO [stderr] usermod: no changes
Dec 14 17:15:59.827 INFO [stderr]    Compiling test-case-derive v0.2.1 (/source)
Dec 14 17:16:00.655 INFO [stderr] warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead
Dec 14 17:16:00.655 INFO [stderr]  --> src/prelude.rs:3:9
Dec 14 17:16:00.655 INFO [stderr]   |
Dec 14 17:16:00.655 INFO [stderr] 3 | pub use std::ascii::AsciiExt;
Dec 14 17:16:00.655 INFO [stderr]   |         ^^^^^^^^^^^^^^^^^^^^
Dec 14 17:16:00.655 INFO [stderr]   |
Dec 14 17:16:00.655 INFO [stderr]   = note: #[warn(deprecated)] on by default
Dec 14 17:16:00.655 INFO [stderr] 
Dec 14 17:16:00.803 INFO [stderr] warning: the feature `proc_macro` has been stable since 1.29.0 and no longer requires an attribute to enable
Dec 14 17:16:00.803 INFO [stderr]    --> src/lib.rs:214:12
Dec 14 17:16:00.803 INFO [stderr]     |
Dec 14 17:16:00.803 INFO [stderr] 214 | #![feature(proc_macro)]
Dec 14 17:16:00.803 INFO [stderr]     |            ^^^^^^^^^^
Dec 14 17:16:00.803 INFO [stderr]     |
Dec 14 17:16:00.803 INFO [stderr]     = note: #[warn(stable_features)] on by default
Dec 14 17:16:00.803 INFO [stderr] 
Dec 14 17:16:02.101 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.30s
Dec 14 17:16:02.103 INFO [stderr] su: No module specific data is present
Dec 14 17:16:02.741 INFO running `"docker" "inspect" "6490e9764f967977c6ce36d2c65afedb1ffba51467c76a852b5d6c2717974f75"`
Dec 14 17:16:02.995 INFO running `"docker" "rm" "-f" "6490e9764f967977c6ce36d2c65afedb1ffba51467c76a852b5d6c2717974f75"`
Dec 14 17:16:03.235 INFO [stdout] 6490e9764f967977c6ce36d2c65afedb1ffba51467c76a852b5d6c2717974f75
Dec 14 17:16:03.239 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 14 17:16:03.772 INFO [stdout] 9e6b7f05c89a28ed57d705d64fe8f9f3c1efc7c763fd32879d775e8032597b22
Dec 14 17:16:03.779 INFO running `"docker" "start" "-a" "9e6b7f05c89a28ed57d705d64fe8f9f3c1efc7c763fd32879d775e8032597b22"`
Dec 14 17:16:05.211 INFO [stderr] usermod: no changes
Dec 14 17:16:05.311 INFO [stderr]    Compiling test-case-derive v0.2.1 (/source)
Dec 14 17:16:06.891 INFO [stderr] warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead
Dec 14 17:16:06.891 INFO [stderr]  --> src/prelude.rs:3:9
Dec 14 17:16:06.891 INFO [stderr]   |
Dec 14 17:16:06.891 INFO [stderr] 3 | pub use std::ascii::AsciiExt;
Dec 14 17:16:06.891 INFO [stderr]   |         ^^^^^^^^^^^^^^^^^^^^
Dec 14 17:16:06.891 INFO [stderr]   |
Dec 14 17:16:06.891 INFO [stderr]   = note: #[warn(deprecated)] on by default
Dec 14 17:16:06.891 INFO [stderr] 
Dec 14 17:16:07.223 INFO [stderr] warning: the feature `proc_macro` has been stable since 1.29.0 and no longer requires an attribute to enable
Dec 14 17:16:07.223 INFO [stderr]    --> src/lib.rs:214:12
Dec 14 17:16:07.223 INFO [stderr]     |
Dec 14 17:16:07.223 INFO [stderr] 214 | #![feature(proc_macro)]
Dec 14 17:16:07.223 INFO [stderr]     |            ^^^^^^^^^^
Dec 14 17:16:07.223 INFO [stderr]     |
Dec 14 17:16:07.223 INFO [stderr]     = note: #[warn(stable_features)] on by default
Dec 14 17:16:07.223 INFO [stderr] 
Dec 14 17:16:07.267 INFO [stderr] warning: the feature `proc_macro` has been stable since 1.29.0 and no longer requires an attribute to enable
Dec 14 17:16:07.267 INFO [stderr]  --> tests/test_cases.rs:2:12
Dec 14 17:16:07.267 INFO [stderr]   |
Dec 14 17:16:07.267 INFO [stderr] 2 | #![feature(proc_macro)]
Dec 14 17:16:07.267 INFO [stderr]   |            ^^^^^^^^^^
Dec 14 17:16:07.268 INFO [stderr]   |
Dec 14 17:16:07.268 INFO [stderr]   = note: #[warn(stable_features)] on by default
Dec 14 17:16:07.268 INFO [stderr] 
Dec 14 17:16:08.108 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.86s
Dec 14 17:16:08.131 INFO [stderr] su: No module specific data is present
Dec 14 17:16:08.799 INFO running `"docker" "inspect" "9e6b7f05c89a28ed57d705d64fe8f9f3c1efc7c763fd32879d775e8032597b22"`
Dec 14 17:16:09.012 INFO running `"docker" "rm" "-f" "9e6b7f05c89a28ed57d705d64fe8f9f3c1efc7c763fd32879d775e8032597b22"`
Dec 14 17:16:09.307 INFO [stdout] 9e6b7f05c89a28ed57d705d64fe8f9f3c1efc7c763fd32879d775e8032597b22
Dec 14 17:16:09.315 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 14 17:16:09.683 INFO [stdout] cb4703a4a094083944992d5f6611b068e96ee90be9835a7e44531c5ef1b7c581
Dec 14 17:16:09.683 INFO running `"docker" "start" "-a" "cb4703a4a094083944992d5f6611b068e96ee90be9835a7e44531c5ef1b7c581"`
Dec 14 17:16:11.274 INFO [stderr] usermod: no changes
Dec 14 17:16:11.360 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 14 17:16:11.360 INFO [stderr]      Running /target/debug/deps/test_case_derive-79f673c4f85ed087
Dec 14 17:16:11.366 INFO [stdout] 
Dec 14 17:16:11.366 INFO [stdout] running 0 tests
Dec 14 17:16:11.366 INFO [stdout] 
Dec 14 17:16:11.366 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 17:16:11.366 INFO [stdout] 
Dec 14 17:16:11.366 INFO [stderr]      Running /target/debug/deps/acceptance_tests-93b76ecf1226265c
Dec 14 17:16:11.371 INFO [stdout] 
Dec 14 17:16:11.371 INFO [stdout] running 7 tests
Dec 14 17:16:11.507 INFO [stdout] test acceptance::escapes_unnecessary_leading_underscore ... ok
Dec 14 17:16:11.507 INFO [stdout] test acceptance::lowers_test_case_name ... ok
Dec 14 17:16:11.507 INFO [stdout] test acceptance::removes_repeated_underscores ... ok
Dec 14 17:16:11.507 INFO [stdout] test acceptance::runs_all_tests ... ok
Dec 14 17:16:11.507 INFO [stdout] test acceptance::escapes_names_starting_with_digit ... ok
Dec 14 17:16:11.507 INFO [stdout] test acceptance::escapes_rust_keywords ... ok
Dec 14 17:16:11.507 INFO [stdout] test acceptance::marks_inconclusive_tests_as_ignored ... ok
Dec 14 17:16:11.507 INFO [stdout] 
Dec 14 17:16:11.507 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 17:16:11.507 INFO [stdout] 
Dec 14 17:16:11.507 INFO [stderr]      Running /target/debug/deps/test_cases-b1fe1b0874144000
Dec 14 17:16:11.512 INFO [stdout] 
Dec 14 17:16:11.512 INFO [stdout] running 32 tests
Dec 14 17:16:11.512 INFO [stdout] test test_cases::abs_tests::returns_opposite_number_for_non_positive_input ... ok
Dec 14 17:16:11.519 INFO [stdout] test test_cases::fancy_addition::some_2_3_some_4 ... ok
Dec 14 17:16:11.519 INFO [stdout] test test_cases::abs_tests::returns_0_for_0 ... ok
Dec 14 17:16:11.519 INFO [stdout] test test_cases::arg_expressions::_2_4_6_to_string ... ok
Dec 14 17:16:11.519 INFO [stdout] test test_cases::basic_test::_1 ... ok
Dec 14 17:16:11.519 INFO [stdout] test test_cases::abs_tests::returns_given_number_for_positive_input ... ok
Dec 14 17:16:11.519 INFO [stdout] test test_cases::fancy_addition::some_2_some_3 ... ok
Dec 14 17:16:11.519 INFO [stdout] test test_cases::fancy_addition::treats_none_as_0 ... ok
Dec 14 17:16:11.519 INFO [stdout] test test_cases::inconclusive_tests::this_test_is_inconclusive_and_will_always_be ... ignored
Dec 14 17:16:11.519 INFO [stdout] test test_cases::inconclusive_tests::should_not_take_into_account_keyword_on_argument_position ... ok
Dec 14 17:16:11.519 INFO [stdout] test test_cases::multiplication_tests::when_both_operands_are_possitive ... ok
Dec 14 17:16:11.519 INFO [stdout] test test_cases::leading_underscore_in_test_name::dummy ... ok
Dec 14 17:16:11.519 INFO [stdout] test test_cases::multiplication_tests::when_operands_are_swapped ... ok
Dec 14 17:16:11.523 INFO [stdout] test test_cases::keyword_test::_true ... ok
Dec 14 17:16:11.523 INFO [stdout] test test_cases::name::_2nd_test ... ok
Dec 14 17:16:11.523 INFO [stdout] test test_cases::name::_4_5 ... ok
Dec 14 17:16:11.523 INFO [stdout] test test_cases::lowercase_test_name::dummy_code ... ok
Dec 14 17:16:11.523 INFO [stdout] test test_cases::multiple_test_cases::_2 ... ok
Dec 14 17:16:11.523 INFO [stdout] test test_cases::multiplication_tests::when_both_operands_are_negative ... ok
Dec 14 17:16:11.523 INFO [stdout] test test_cases::multiple_test_cases::_4 ... ok
Dec 14 17:16:11.523 INFO [stdout] test test_cases::result::_4 ... ok
Dec 14 17:16:11.523 INFO [stdout] test test_cases::result_and_name::_4_5 ... ok
Dec 14 17:16:11.523 INFO [stdout] test test_cases::result::_2 ... ok
Dec 14 17:16:11.523 INFO [stdout] test test_cases::result_and_name::test_no_1 ... ok
Dec 14 17:16:11.523 INFO [stdout] test test_cases::result_expresion_with_name::test_result_expression ... ok
Dec 14 17:16:11.523 INFO [stdout] test test_cases::result_expression::_2_2 ... ok
Dec 14 17:16:11.523 INFO [stdout] test test_cases::result_with_mod_sep::_42 ... ok
Dec 14 17:16:11.527 INFO [stdout] test test_cases::name::test_1_8_9 ... ok
Dec 14 17:16:11.527 INFO [stdout] test test_cases::nested::nested_test_case::_1_1 ... ok
Dec 14 17:16:11.527 INFO [stdout] test test_cases::nested::using_fn_from_super::_42 ... ok
Dec 14 17:16:11.527 INFO [stdout] test test_cases::name::test_3_6_9 ... ok
Dec 14 17:16:11.527 INFO [stdout] test test_cases::nested::using_fn_from_super::_20_22 ... ok
Dec 14 17:16:11.527 INFO [stdout] 
Dec 14 17:16:11.527 INFO [stdout] test result: ok. 31 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 14 17:16:11.527 INFO [stdout] 
Dec 14 17:16:11.531 INFO [stderr] su: No module specific data is present
Dec 14 17:16:12.060 INFO running `"docker" "inspect" "cb4703a4a094083944992d5f6611b068e96ee90be9835a7e44531c5ef1b7c581"`
Dec 14 17:16:12.346 INFO running `"docker" "rm" "-f" "cb4703a4a094083944992d5f6611b068e96ee90be9835a7e44531c5ef1b7c581"`
Dec 14 17:16:12.556 INFO [stdout] cb4703a4a094083944992d5f6611b068e96ee90be9835a7e44531c5ef1b7c581