Nov 17 20:53:17.407 INFO testing test-case-derive-0.2.1 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 17 20:53:17.410 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 17 20:53:17.751 INFO [stdout] 1c4d5c5201a51956c66b36c7d3d5559d5cd6c0c98aeabb034beea8b63e95661d
Nov 17 20:53:17.763 INFO running `"docker" "start" "-a" "1c4d5c5201a51956c66b36c7d3d5559d5cd6c0c98aeabb034beea8b63e95661d"`
Nov 17 20:53:18.749 INFO [stderr] usermod: no changes
Nov 17 20:53:18.840 INFO [stderr]    Compiling test-case-derive v0.2.1 (/source)
Nov 17 20:53:21.738 INFO [stderr] warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead
Nov 17 20:53:21.738 INFO [stderr]  --> src/prelude.rs:3:9
Nov 17 20:53:21.738 INFO [stderr]   |
Nov 17 20:53:21.738 INFO [stderr] 3 | pub use std::ascii::AsciiExt;
Nov 17 20:53:21.738 INFO [stderr]   |         ^^^^^^^^^^^^^^^^^^^^
Nov 17 20:53:21.738 INFO [stderr]   |
Nov 17 20:53:21.738 INFO [stderr]   = note: #[warn(deprecated)] on by default
Nov 17 20:53:21.738 INFO [stderr] 
Nov 17 20:53:21.904 INFO [stderr] warning: the feature `proc_macro` has been stable since 1.29.0 and no longer requires an attribute to enable
Nov 17 20:53:21.904 INFO [stderr]    --> src/lib.rs:214:12
Nov 17 20:53:21.904 INFO [stderr]     |
Nov 17 20:53:21.904 INFO [stderr] 214 | #![feature(proc_macro)]
Nov 17 20:53:21.904 INFO [stderr]     |            ^^^^^^^^^^
Nov 17 20:53:21.904 INFO [stderr]     |
Nov 17 20:53:21.904 INFO [stderr]     = note: #[warn(stable_features)] on by default
Nov 17 20:53:21.906 INFO [stderr] 
Nov 17 20:53:23.614 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.83s
Nov 17 20:53:23.623 INFO [stderr] su: No module specific data is present
Nov 17 20:53:24.434 INFO running `"docker" "inspect" "1c4d5c5201a51956c66b36c7d3d5559d5cd6c0c98aeabb034beea8b63e95661d"`
Nov 17 20:53:24.671 INFO running `"docker" "rm" "-f" "1c4d5c5201a51956c66b36c7d3d5559d5cd6c0c98aeabb034beea8b63e95661d"`
Nov 17 20:53:25.003 INFO [stdout] 1c4d5c5201a51956c66b36c7d3d5559d5cd6c0c98aeabb034beea8b63e95661d
Nov 17 20:53:25.011 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 17 20:53:25.499 INFO [stdout] 0b3b43fc5ac0a2d8564938adf5e19537217e40523fd1f3818e599d3be064a977
Nov 17 20:53:25.504 INFO running `"docker" "start" "-a" "0b3b43fc5ac0a2d8564938adf5e19537217e40523fd1f3818e599d3be064a977"`
Nov 17 20:53:26.926 INFO [stderr] usermod: no changes
Nov 17 20:53:26.986 INFO [stderr]    Compiling test-case-derive v0.2.1 (/source)
Nov 17 20:53:28.449 INFO [stderr] warning: the feature `proc_macro` has been stable since 1.29.0 and no longer requires an attribute to enable
Nov 17 20:53:28.450 INFO [stderr]  --> tests/test_cases.rs:2:12
Nov 17 20:53:28.450 INFO [stderr]   |
Nov 17 20:53:28.450 INFO [stderr] 2 | #![feature(proc_macro)]
Nov 17 20:53:28.451 INFO [stderr]   |            ^^^^^^^^^^
Nov 17 20:53:28.451 INFO [stderr]   |
Nov 17 20:53:28.452 INFO [stderr]   = note: #[warn(stable_features)] on by default
Nov 17 20:53:28.452 INFO [stderr] 
Nov 17 20:53:30.847 INFO [stderr] warning: use of deprecated item 'std::ascii::AsciiExt': use inherent methods instead
Nov 17 20:53:30.847 INFO [stderr]  --> src/prelude.rs:3:9
Nov 17 20:53:30.848 INFO [stderr]   |
Nov 17 20:53:30.848 INFO [stderr] 3 | pub use std::ascii::AsciiExt;
Nov 17 20:53:30.848 INFO [stderr]   |         ^^^^^^^^^^^^^^^^^^^^
Nov 17 20:53:30.849 INFO [stderr]   |
Nov 17 20:53:30.849 INFO [stderr]   = note: #[warn(deprecated)] on by default
Nov 17 20:53:30.849 INFO [stderr] 
Nov 17 20:53:31.013 INFO [stderr] warning: the feature `proc_macro` has been stable since 1.29.0 and no longer requires an attribute to enable
Nov 17 20:53:31.013 INFO [stderr]    --> src/lib.rs:214:12
Nov 17 20:53:31.013 INFO [stderr]     |
Nov 17 20:53:31.013 INFO [stderr] 214 | #![feature(proc_macro)]
Nov 17 20:53:31.013 INFO [stderr]     |            ^^^^^^^^^^
Nov 17 20:53:31.013 INFO [stderr]     |
Nov 17 20:53:31.013 INFO [stderr]     = note: #[warn(stable_features)] on by default
Nov 17 20:53:31.013 INFO [stderr] 
Nov 17 20:53:31.205 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.26s
Nov 17 20:53:31.210 INFO [stderr] su: No module specific data is present
Nov 17 20:53:31.834 INFO running `"docker" "inspect" "0b3b43fc5ac0a2d8564938adf5e19537217e40523fd1f3818e599d3be064a977"`
Nov 17 20:53:32.154 INFO running `"docker" "rm" "-f" "0b3b43fc5ac0a2d8564938adf5e19537217e40523fd1f3818e599d3be064a977"`
Nov 17 20:53:32.435 INFO [stdout] 0b3b43fc5ac0a2d8564938adf5e19537217e40523fd1f3818e599d3be064a977
Nov 17 20:53:32.444 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 17 20:53:32.881 INFO [stdout] 78051fcf34e7f9b91bf3aa44b29e9b88d8c840f4ff2a523fc38a352ce4d86652
Nov 17 20:53:32.882 INFO running `"docker" "start" "-a" "78051fcf34e7f9b91bf3aa44b29e9b88d8c840f4ff2a523fc38a352ce4d86652"`
Nov 17 20:53:34.467 INFO [stderr] usermod: no changes
Nov 17 20:53:34.531 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Nov 17 20:53:34.543 INFO [stderr]      Running /target/debug/deps/test_case_derive-2f07949e0cfffef3
Nov 17 20:53:34.547 INFO [stderr]      Running /target/debug/deps/acceptance_tests-39c55b60a7119d40
Nov 17 20:53:34.547 INFO [stdout] 
Nov 17 20:53:34.547 INFO [stdout] running 0 tests
Nov 17 20:53:34.547 INFO [stdout] 
Nov 17 20:53:34.547 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 20:53:34.547 INFO [stdout] 
Nov 17 20:53:34.552 INFO [stdout] 
Nov 17 20:53:34.552 INFO [stdout] running 7 tests
Nov 17 20:53:34.661 INFO [stdout] test acceptance::escapes_names_starting_with_digit ... ok
Nov 17 20:53:34.661 INFO [stdout] test acceptance::escapes_unnecessary_leading_underscore ... ok
Nov 17 20:53:34.661 INFO [stdout] test acceptance::lowers_test_case_name ... ok
Nov 17 20:53:34.661 INFO [stdout] test acceptance::runs_all_tests ... ok
Nov 17 20:53:34.661 INFO [stdout] test acceptance::marks_inconclusive_tests_as_ignored ... ok
Nov 17 20:53:34.667 INFO [stdout] test acceptance::removes_repeated_underscores ... ok
Nov 17 20:53:34.668 INFO [stdout] test acceptance::escapes_rust_keywords ... ok
Nov 17 20:53:34.668 INFO [stdout] 
Nov 17 20:53:34.668 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 20:53:34.668 INFO [stdout] 
Nov 17 20:53:34.668 INFO [stderr]      Running /target/debug/deps/test_cases-9ad84989986ede8d
Nov 17 20:53:34.673 INFO [stdout] 
Nov 17 20:53:34.673 INFO [stdout] running 32 tests
Nov 17 20:53:34.673 INFO [stdout] test test_cases::fancy_addition::some_2_some_3 ... ok
Nov 17 20:53:34.674 INFO [stdout] test test_cases::abs_tests::returns_given_number_for_positive_input ... ok
Nov 17 20:53:34.674 INFO [stdout] test test_cases::basic_test::_1 ... ok
Nov 17 20:53:34.674 INFO [stdout] test test_cases::inconclusive_tests::this_test_is_inconclusive_and_will_always_be ... ignored
Nov 17 20:53:34.674 INFO [stdout] test test_cases::fancy_addition::some_2_3_some_4 ... ok
Nov 17 20:53:34.674 INFO [stdout] test test_cases::inconclusive_tests::should_not_take_into_account_keyword_on_argument_position ... ok
Nov 17 20:53:34.674 INFO [stdout] test test_cases::keyword_test::_true ... ok
Nov 17 20:53:34.674 INFO [stdout] test test_cases::multiple_test_cases::_2 ... ok
Nov 17 20:53:34.674 INFO [stdout] test test_cases::multiple_test_cases::_4 ... ok
Nov 17 20:53:34.679 INFO [stdout] test test_cases::multiplication_tests::when_both_operands_are_possitive ... ok
Nov 17 20:53:34.679 INFO [stdout] test test_cases::abs_tests::returns_opposite_number_for_non_positive_input ... ok
Nov 17 20:53:34.680 INFO [stdout] test test_cases::arg_expressions::_2_4_6_to_string ... ok
Nov 17 20:53:34.687 INFO [stdout] test test_cases::multiplication_tests::when_operands_are_swapped ... ok
Nov 17 20:53:34.687 INFO [stdout] test test_cases::name::_4_5 ... ok
Nov 17 20:53:34.687 INFO [stdout] test test_cases::name::_2nd_test ... ok
Nov 17 20:53:34.699 INFO [stdout] test test_cases::name::test_1_8_9 ... ok
Nov 17 20:53:34.699 INFO [stdout] test test_cases::nested::nested_test_case::_1_1 ... ok
Nov 17 20:53:34.699 INFO [stdout] test test_cases::name::test_3_6_9 ... ok
Nov 17 20:53:34.699 INFO [stdout] test test_cases::abs_tests::returns_0_for_0 ... ok
Nov 17 20:53:34.699 INFO [stdout] test test_cases::lowercase_test_name::dummy_code ... ok
Nov 17 20:53:34.699 INFO [stdout] test test_cases::fancy_addition::treats_none_as_0 ... ok
Nov 17 20:53:34.699 INFO [stdout] test test_cases::leading_underscore_in_test_name::dummy ... ok
Nov 17 20:53:34.699 INFO [stdout] test test_cases::multiplication_tests::when_both_operands_are_negative ... ok
Nov 17 20:53:34.699 INFO [stdout] test test_cases::nested::using_fn_from_super::_20_22 ... ok
Nov 17 20:53:34.699 INFO [stdout] test test_cases::result_and_name::test_no_1 ... ok
Nov 17 20:53:34.699 INFO [stdout] test test_cases::result_and_name::_4_5 ... ok
Nov 17 20:53:34.699 INFO [stdout] test test_cases::nested::using_fn_from_super::_42 ... ok
Nov 17 20:53:34.699 INFO [stdout] test test_cases::result::_2 ... ok
Nov 17 20:53:34.699 INFO [stdout] test test_cases::result::_4 ... ok
Nov 17 20:53:34.707 INFO [stdout] test test_cases::result_with_mod_sep::_42 ... ok
Nov 17 20:53:34.707 INFO [stdout] test test_cases::result_expression::_2_2 ... ok
Nov 17 20:53:34.707 INFO [stdout] test test_cases::result_expresion_with_name::test_result_expression ... ok
Nov 17 20:53:34.707 INFO [stdout] 
Nov 17 20:53:34.707 INFO [stdout] test result: ok. 31 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Nov 17 20:53:34.707 INFO [stdout] 
Nov 17 20:53:34.711 INFO [stderr] su: No module specific data is present
Nov 17 20:53:35.377 INFO running `"docker" "inspect" "78051fcf34e7f9b91bf3aa44b29e9b88d8c840f4ff2a523fc38a352ce4d86652"`
Nov 17 20:53:35.739 INFO running `"docker" "rm" "-f" "78051fcf34e7f9b91bf3aa44b29e9b88d8c840f4ff2a523fc38a352ce4d86652"`
Nov 17 20:53:36.103 INFO [stdout] 78051fcf34e7f9b91bf3aa44b29e9b88d8c840f4ff2a523fc38a352ce4d86652