Dec 06 20:27:45.517 INFO testing test-case-derive-0.2.1 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 20:27:45.518 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 06 20:27:46.109 INFO [stdout] 52b821e36bbcc014b6e0a1ae0e3c3c668f0a385b17cf4b11361c5492f6eb979d
Dec 06 20:27:46.112 INFO running `"docker" "start" "-a" "52b821e36bbcc014b6e0a1ae0e3c3c668f0a385b17cf4b11361c5492f6eb979d"`
Dec 06 20:27:47.348 INFO [stderr] usermod: no changes
Dec 06 20:27:47.436 INFO [stderr]    Compiling test-case-derive v0.2.1 (/source)
Dec 06 20:27:48.119 INFO [stderr] warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead
Dec 06 20:27:48.123 INFO [stderr]  --> src/prelude.rs:3:9
Dec 06 20:27:48.123 INFO [stderr]   |
Dec 06 20:27:48.123 INFO [stderr] 3 | pub use std::ascii::AsciiExt;
Dec 06 20:27:48.123 INFO [stderr]   |         ^^^^^^^^^^^^^^^^^^^^
Dec 06 20:27:48.123 INFO [stderr]   |
Dec 06 20:27:48.123 INFO [stderr]   = note: #[warn(deprecated)] on by default
Dec 06 20:27:48.123 INFO [stderr] 
Dec 06 20:27:48.241 INFO [stderr] warning: the feature `proc_macro` has been stable since 1.29.0 and no longer requires an attribute to enable
Dec 06 20:27:48.241 INFO [stderr]    --> src/lib.rs:214:12
Dec 06 20:27:48.241 INFO [stderr]     |
Dec 06 20:27:48.241 INFO [stderr] 214 | #![feature(proc_macro)]
Dec 06 20:27:48.241 INFO [stderr]     |            ^^^^^^^^^^
Dec 06 20:27:48.241 INFO [stderr]     |
Dec 06 20:27:48.241 INFO [stderr]     = note: #[warn(stable_features)] on by default
Dec 06 20:27:48.241 INFO [stderr] 
Dec 06 20:27:49.712 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.34s
Dec 06 20:27:49.716 INFO [stderr] su: No module specific data is present
Dec 06 20:27:50.632 INFO running `"docker" "inspect" "52b821e36bbcc014b6e0a1ae0e3c3c668f0a385b17cf4b11361c5492f6eb979d"`
Dec 06 20:27:51.058 INFO running `"docker" "rm" "-f" "52b821e36bbcc014b6e0a1ae0e3c3c668f0a385b17cf4b11361c5492f6eb979d"`
Dec 06 20:27:51.443 INFO [stdout] 52b821e36bbcc014b6e0a1ae0e3c3c668f0a385b17cf4b11361c5492f6eb979d
Dec 06 20:27:51.446 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 06 20:27:51.936 INFO [stdout] 80dbd694b083d573fef5bfc392be758193f5d53e6164eec980f3a0f1347f2027
Dec 06 20:27:51.940 INFO running `"docker" "start" "-a" "80dbd694b083d573fef5bfc392be758193f5d53e6164eec980f3a0f1347f2027"`
Dec 06 20:27:53.035 INFO [stderr] usermod: no changes
Dec 06 20:27:53.132 INFO [stderr]    Compiling test-case-derive v0.2.1 (/source)
Dec 06 20:27:55.324 INFO [stderr] warning: the feature `proc_macro` has been stable since 1.29.0 and no longer requires an attribute to enable
Dec 06 20:27:55.324 INFO [stderr]  --> tests/test_cases.rs:2:12
Dec 06 20:27:55.324 INFO [stderr]   |
Dec 06 20:27:55.324 INFO [stderr] 2 | #![feature(proc_macro)]
Dec 06 20:27:55.324 INFO [stderr]   |            ^^^^^^^^^^
Dec 06 20:27:55.324 INFO [stderr]   |
Dec 06 20:27:55.324 INFO [stderr]   = note: #[warn(stable_features)] on by default
Dec 06 20:27:55.324 INFO [stderr] 
Dec 06 20:27:55.324 INFO [stderr] warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead
Dec 06 20:27:55.324 INFO [stderr]  --> src/prelude.rs:3:9
Dec 06 20:27:55.324 INFO [stderr]   |
Dec 06 20:27:55.324 INFO [stderr] 3 | pub use std::ascii::AsciiExt;
Dec 06 20:27:55.324 INFO [stderr]   |         ^^^^^^^^^^^^^^^^^^^^
Dec 06 20:27:55.324 INFO [stderr]   |
Dec 06 20:27:55.324 INFO [stderr]   = note: #[warn(deprecated)] on by default
Dec 06 20:27:55.324 INFO [stderr] 
Dec 06 20:27:55.663 INFO [stderr] warning: the feature `proc_macro` has been stable since 1.29.0 and no longer requires an attribute to enable
Dec 06 20:27:55.663 INFO [stderr]    --> src/lib.rs:214:12
Dec 06 20:27:55.663 INFO [stderr]     |
Dec 06 20:27:55.663 INFO [stderr] 214 | #![feature(proc_macro)]
Dec 06 20:27:55.663 INFO [stderr]     |            ^^^^^^^^^^
Dec 06 20:27:55.663 INFO [stderr]     |
Dec 06 20:27:55.663 INFO [stderr]     = note: #[warn(stable_features)] on by default
Dec 06 20:27:55.663 INFO [stderr] 
Dec 06 20:27:56.143 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.07s
Dec 06 20:27:56.165 INFO [stderr] su: No module specific data is present
Dec 06 20:27:56.738 INFO running `"docker" "inspect" "80dbd694b083d573fef5bfc392be758193f5d53e6164eec980f3a0f1347f2027"`
Dec 06 20:27:57.192 INFO running `"docker" "rm" "-f" "80dbd694b083d573fef5bfc392be758193f5d53e6164eec980f3a0f1347f2027"`
Dec 06 20:27:57.485 INFO [stdout] 80dbd694b083d573fef5bfc392be758193f5d53e6164eec980f3a0f1347f2027
Dec 06 20:27:57.487 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 06 20:27:57.962 INFO [stdout] 7dd9cd826c090c62beb0bf2c334cef5f7a665e8a4f2b37f1c2ae0ba215d63615
Dec 06 20:27:57.965 INFO running `"docker" "start" "-a" "7dd9cd826c090c62beb0bf2c334cef5f7a665e8a4f2b37f1c2ae0ba215d63615"`
Dec 06 20:27:59.176 INFO [stderr] usermod: no changes
Dec 06 20:27:59.252 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 06 20:27:59.252 INFO [stderr]      Running /target/debug/deps/test_case_derive-6ea52d024bf0cbb2
Dec 06 20:27:59.262 INFO [stdout] 
Dec 06 20:27:59.262 INFO [stdout] running 0 tests
Dec 06 20:27:59.262 INFO [stdout] 
Dec 06 20:27:59.262 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:27:59.262 INFO [stdout] 
Dec 06 20:27:59.264 INFO [stderr]      Running /target/debug/deps/acceptance_tests-d95cfa2016b665e6
Dec 06 20:27:59.265 INFO [stdout] 
Dec 06 20:27:59.265 INFO [stdout] running 7 tests
Dec 06 20:27:59.412 INFO [stdout] test acceptance::escapes_unnecessary_leading_underscore ... ok
Dec 06 20:27:59.412 INFO [stdout] test acceptance::escapes_rust_keywords ... ok
Dec 06 20:27:59.412 INFO [stdout] test acceptance::escapes_names_starting_with_digit ... ok
Dec 06 20:27:59.412 INFO [stdout] test acceptance::lowers_test_case_name ... ok
Dec 06 20:27:59.412 INFO [stdout] test acceptance::marks_inconclusive_tests_as_ignored ... ok
Dec 06 20:27:59.413 INFO [stdout] test acceptance::runs_all_tests ... ok
Dec 06 20:27:59.413 INFO [stdout] test acceptance::removes_repeated_underscores ... ok
Dec 06 20:27:59.413 INFO [stdout] 
Dec 06 20:27:59.413 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:27:59.413 INFO [stdout] 
Dec 06 20:27:59.414 INFO [stderr]      Running /target/debug/deps/test_cases-ccb685cc16e2bf80
Dec 06 20:27:59.420 INFO [stdout] 
Dec 06 20:27:59.420 INFO [stdout] running 32 tests
Dec 06 20:27:59.420 INFO [stdout] test test_cases::abs_tests::returns_0_for_0 ... ok
Dec 06 20:27:59.420 INFO [stdout] test test_cases::abs_tests::returns_given_number_for_positive_input ... ok
Dec 06 20:27:59.420 INFO [stdout] test test_cases::abs_tests::returns_opposite_number_for_non_positive_input ... ok
Dec 06 20:27:59.420 INFO [stdout] test test_cases::inconclusive_tests::this_test_is_inconclusive_and_will_always_be ... ignored
Dec 06 20:27:59.420 INFO [stdout] test test_cases::fancy_addition::treats_none_as_0 ... ok
Dec 06 20:27:59.420 INFO [stdout] test test_cases::leading_underscore_in_test_name::dummy ... ok
Dec 06 20:27:59.429 INFO [stdout] test test_cases::fancy_addition::some_2_some_3 ... ok
Dec 06 20:27:59.429 INFO [stdout] test test_cases::inconclusive_tests::should_not_take_into_account_keyword_on_argument_position ... ok
Dec 06 20:27:59.429 INFO [stdout] test test_cases::fancy_addition::some_2_3_some_4 ... ok
Dec 06 20:27:59.429 INFO [stdout] test test_cases::basic_test::_1 ... ok
Dec 06 20:27:59.429 INFO [stdout] test test_cases::lowercase_test_name::dummy_code ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::keyword_test::_true ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::multiplication_tests::when_operands_are_swapped ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::multiplication_tests::when_both_operands_are_possitive ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::multiple_test_cases::_2 ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::arg_expressions::_2_4_6_to_string ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::multiplication_tests::when_both_operands_are_negative ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::multiple_test_cases::_4 ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::name::_2nd_test ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::name::_4_5 ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::name::test_1_8_9 ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::name::test_3_6_9 ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::nested::nested_test_case::_1_1 ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::nested::using_fn_from_super::_20_22 ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::nested::using_fn_from_super::_42 ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::result::_2 ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::result::_4 ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::result_and_name::_4_5 ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::result_and_name::test_no_1 ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::result_expresion_with_name::test_result_expression ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::result_expression::_2_2 ... ok
Dec 06 20:27:59.432 INFO [stdout] test test_cases::result_with_mod_sep::_42 ... ok
Dec 06 20:27:59.432 INFO [stdout] 
Dec 06 20:27:59.432 INFO [stdout] test result: ok. 31 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 06 20:27:59.432 INFO [stdout] 
Dec 06 20:27:59.437 INFO [stderr] su: No module specific data is present
Dec 06 20:28:00.519 INFO running `"docker" "inspect" "7dd9cd826c090c62beb0bf2c334cef5f7a665e8a4f2b37f1c2ae0ba215d63615"`
Dec 06 20:28:00.868 INFO running `"docker" "rm" "-f" "7dd9cd826c090c62beb0bf2c334cef5f7a665e8a4f2b37f1c2ae0ba215d63615"`
Dec 06 20:28:01.136 INFO [stdout] 7dd9cd826c090c62beb0bf2c334cef5f7a665e8a4f2b37f1c2ae0ba215d63615