Dec 06 20:27:43.510 INFO testing test-case-derive-0.2.1 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 06 20:27:43.510 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:43.952 INFO [stdout] 10cc6a2dddd5964ece3355e49391411908cddaa665ffe42a8171b9654d72dcfc
Dec 06 20:27:43.956 INFO running `"docker" "start" "-a" "10cc6a2dddd5964ece3355e49391411908cddaa665ffe42a8171b9654d72dcfc"`
Dec 06 20:27:44.968 INFO [stderr] usermod: no changes
Dec 06 20:27:45.043 INFO [stderr]    Compiling test-case-derive v0.2.1 (/source)
Dec 06 20:27:45.652 INFO [stderr] warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead
Dec 06 20:27:45.652 INFO [stderr]  --> src/prelude.rs:3:9
Dec 06 20:27:45.652 INFO [stderr]   |
Dec 06 20:27:45.652 INFO [stderr] 3 | pub use std::ascii::AsciiExt;
Dec 06 20:27:45.652 INFO [stderr]   |         ^^^^^^^^^^^^^^^^^^^^
Dec 06 20:27:45.652 INFO [stderr]   |
Dec 06 20:27:45.652 INFO [stderr]   = note: #[warn(deprecated)] on by default
Dec 06 20:27:45.652 INFO [stderr] 
Dec 06 20:27:45.768 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:45.770 INFO [stderr]    --> src/lib.rs:214:12
Dec 06 20:27:45.770 INFO [stderr]     |
Dec 06 20:27:45.770 INFO [stderr] 214 | #![feature(proc_macro)]
Dec 06 20:27:45.770 INFO [stderr]     |            ^^^^^^^^^^
Dec 06 20:27:45.770 INFO [stderr]     |
Dec 06 20:27:45.772 INFO [stderr]     = note: #[warn(stable_features)] on by default
Dec 06 20:27:45.772 INFO [stderr] 
Dec 06 20:27:46.993 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.99s
Dec 06 20:27:46.996 INFO [stderr] su: No module specific data is present
Dec 06 20:27:47.479 INFO running `"docker" "inspect" "10cc6a2dddd5964ece3355e49391411908cddaa665ffe42a8171b9654d72dcfc"`
Dec 06 20:27:47.802 INFO running `"docker" "rm" "-f" "10cc6a2dddd5964ece3355e49391411908cddaa665ffe42a8171b9654d72dcfc"`
Dec 06 20:27:47.968 INFO [stdout] 10cc6a2dddd5964ece3355e49391411908cddaa665ffe42a8171b9654d72dcfc
Dec 06 20:27:47.980 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:48.422 INFO [stdout] f5e7ae365585b0f6f45ea7285ebef4671a56c3863affe4308425a7f7fb4bdf61
Dec 06 20:27:48.424 INFO running `"docker" "start" "-a" "f5e7ae365585b0f6f45ea7285ebef4671a56c3863affe4308425a7f7fb4bdf61"`
Dec 06 20:27:50.052 INFO [stderr] usermod: no changes
Dec 06 20:27:50.148 INFO [stderr]    Compiling test-case-derive v0.2.1 (/source)
Dec 06 20:27:51.207 INFO [stderr] warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead
Dec 06 20:27:51.207 INFO [stderr]  --> src/prelude.rs:3:9
Dec 06 20:27:51.207 INFO [stderr]   |
Dec 06 20:27:51.207 INFO [stderr] 3 | pub use std::ascii::AsciiExt;
Dec 06 20:27:51.207 INFO [stderr]   |         ^^^^^^^^^^^^^^^^^^^^
Dec 06 20:27:51.207 INFO [stderr]   |
Dec 06 20:27:51.207 INFO [stderr]   = note: #[warn(deprecated)] on by default
Dec 06 20:27:51.207 INFO [stderr] 
Dec 06 20:27:51.276 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:51.276 INFO [stderr]  --> tests/test_cases.rs:2:12
Dec 06 20:27:51.276 INFO [stderr]   |
Dec 06 20:27:51.276 INFO [stderr] 2 | #![feature(proc_macro)]
Dec 06 20:27:51.276 INFO [stderr]   |            ^^^^^^^^^^
Dec 06 20:27:51.276 INFO [stderr]   |
Dec 06 20:27:51.276 INFO [stderr]   = note: #[warn(stable_features)] on by default
Dec 06 20:27:51.276 INFO [stderr] 
Dec 06 20:27:51.356 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:51.356 INFO [stderr]    --> src/lib.rs:214:12
Dec 06 20:27:51.356 INFO [stderr]     |
Dec 06 20:27:51.356 INFO [stderr] 214 | #![feature(proc_macro)]
Dec 06 20:27:51.356 INFO [stderr]     |            ^^^^^^^^^^
Dec 06 20:27:51.356 INFO [stderr]     |
Dec 06 20:27:51.356 INFO [stderr]     = note: #[warn(stable_features)] on by default
Dec 06 20:27:51.356 INFO [stderr] 
Dec 06 20:27:52.356 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.28s
Dec 06 20:27:52.363 INFO [stderr] su: No module specific data is present
Dec 06 20:27:52.946 INFO running `"docker" "inspect" "f5e7ae365585b0f6f45ea7285ebef4671a56c3863affe4308425a7f7fb4bdf61"`
Dec 06 20:27:53.222 INFO running `"docker" "rm" "-f" "f5e7ae365585b0f6f45ea7285ebef4671a56c3863affe4308425a7f7fb4bdf61"`
Dec 06 20:27:53.577 INFO [stdout] f5e7ae365585b0f6f45ea7285ebef4671a56c3863affe4308425a7f7fb4bdf61
Dec 06 20:27:53.586 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:54.038 INFO [stdout] 58957ba3df8d9d8db243c10e5cc310f9bdabde6665f9b12b65485d031cedfebe
Dec 06 20:27:54.040 INFO running `"docker" "start" "-a" "58957ba3df8d9d8db243c10e5cc310f9bdabde6665f9b12b65485d031cedfebe"`
Dec 06 20:27:55.914 INFO [stderr] usermod: no changes
Dec 06 20:27:55.996 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 06 20:27:56.008 INFO [stderr]      Running /target/debug/deps/test_case_derive-d8b4936563efe1bf
Dec 06 20:27:56.009 INFO [stdout] 
Dec 06 20:27:56.009 INFO [stdout] running 0 tests
Dec 06 20:27:56.009 INFO [stdout] 
Dec 06 20:27:56.009 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:27:56.009 INFO [stdout] 
Dec 06 20:27:56.011 INFO [stderr]      Running /target/debug/deps/acceptance_tests-a1d31b3400a59c0a
Dec 06 20:27:56.017 INFO [stdout] 
Dec 06 20:27:56.018 INFO [stdout] running 7 tests
Dec 06 20:27:56.141 INFO [stdout] test acceptance::escapes_names_starting_with_digit ... ok
Dec 06 20:27:56.141 INFO [stdout] test acceptance::escapes_unnecessary_leading_underscore ... ok
Dec 06 20:27:56.141 INFO [stdout] test acceptance::runs_all_tests ... ok
Dec 06 20:27:56.141 INFO [stdout] test acceptance::removes_repeated_underscores ... ok
Dec 06 20:27:56.141 INFO [stdout] test acceptance::marks_inconclusive_tests_as_ignored ... ok
Dec 06 20:27:56.141 INFO [stdout] test acceptance::lowers_test_case_name ... ok
Dec 06 20:27:56.141 INFO [stdout] test acceptance::escapes_rust_keywords ... ok
Dec 06 20:27:56.141 INFO [stdout] 
Dec 06 20:27:56.141 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:27:56.141 INFO [stdout] 
Dec 06 20:27:56.143 INFO [stderr]      Running /target/debug/deps/test_cases-c39233aaaaf50c65
Dec 06 20:27:56.151 INFO [stdout] 
Dec 06 20:27:56.151 INFO [stdout] running 32 tests
Dec 06 20:27:56.157 INFO [stdout] test test_cases::abs_tests::returns_opposite_number_for_non_positive_input ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::basic_test::_1 ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::fancy_addition::some_2_some_3 ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::inconclusive_tests::this_test_is_inconclusive_and_will_always_be ... ignored
Dec 06 20:27:56.157 INFO [stdout] test test_cases::keyword_test::_true ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::abs_tests::returns_0_for_0 ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::abs_tests::returns_given_number_for_positive_input ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::arg_expressions::_2_4_6_to_string ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::fancy_addition::some_2_3_some_4 ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::fancy_addition::treats_none_as_0 ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::leading_underscore_in_test_name::dummy ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::lowercase_test_name::dummy_code ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::multiple_test_cases::_2 ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::multiplication_tests::when_both_operands_are_possitive ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::multiplication_tests::when_operands_are_swapped ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::name::_2nd_test ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::name::_4_5 ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::name::test_1_8_9 ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::name::test_3_6_9 ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::nested::nested_test_case::_1_1 ... ok
Dec 06 20:27:56.157 INFO [stdout] test test_cases::nested::using_fn_from_super::_20_22 ... ok
Dec 06 20:27:56.164 INFO [stderr] su: No module specific data is present
Dec 06 20:27:56.164 INFO [stdout] test test_cases::result::_2 ... ok
Dec 06 20:27:56.164 INFO [stdout] test test_cases::result::_4 ... ok
Dec 06 20:27:56.164 INFO [stdout] test test_cases::result_and_name::_4_5 ... ok
Dec 06 20:27:56.164 INFO [stdout] test test_cases::inconclusive_tests::should_not_take_into_account_keyword_on_argument_position ... ok
Dec 06 20:27:56.164 INFO [stdout] test test_cases::nested::using_fn_from_super::_42 ... ok
Dec 06 20:27:56.164 INFO [stdout] test test_cases::multiple_test_cases::_4 ... ok
Dec 06 20:27:56.164 INFO [stdout] test test_cases::multiplication_tests::when_both_operands_are_negative ... ok
Dec 06 20:27:56.164 INFO [stdout] test test_cases::result_and_name::test_no_1 ... ok
Dec 06 20:27:56.164 INFO [stdout] test test_cases::result_expresion_with_name::test_result_expression ... ok
Dec 06 20:27:56.164 INFO [stdout] test test_cases::result_with_mod_sep::_42 ... ok
Dec 06 20:27:56.164 INFO [stdout] test test_cases::result_expression::_2_2 ... ok
Dec 06 20:27:56.164 INFO [stdout] 
Dec 06 20:27:56.164 INFO [stdout] test result: ok. 31 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 06 20:27:56.164 INFO [stdout] 
Dec 06 20:27:56.760 INFO running `"docker" "inspect" "58957ba3df8d9d8db243c10e5cc310f9bdabde6665f9b12b65485d031cedfebe"`
Dec 06 20:27:57.106 INFO running `"docker" "rm" "-f" "58957ba3df8d9d8db243c10e5cc310f9bdabde6665f9b12b65485d031cedfebe"`
Dec 06 20:27:57.380 INFO [stdout] 58957ba3df8d9d8db243c10e5cc310f9bdabde6665f9b12b65485d031cedfebe