Dec 15 19:52:10.512 INFO testing cargo-raze-0.1.3 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 19:52:10.512 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 19:52:11.107 INFO [stdout] 6a2355ed19b3c5aa65287b0121bec084c1ce45e3d834604dcfe01aa3291b957e
Dec 15 19:52:11.113 INFO running `"docker" "start" "-a" "6a2355ed19b3c5aa65287b0121bec084c1ce45e3d834604dcfe01aa3291b957e"`
Dec 15 19:52:12.106 INFO [stderr] usermod: no changes
Dec 15 19:52:12.459 INFO [stderr]    Compiling tera v0.11.20
Dec 15 19:52:30.259 INFO [stderr]    Compiling cargo-raze v0.1.3 (/source)
Dec 15 19:52:40.955 INFO [stderr] warning: unused import: `failure::Error`
Dec 15 19:52:40.955 INFO [stderr]   --> src/util.rs:26:5
Dec 15 19:52:40.955 INFO [stderr]    |
Dec 15 19:52:40.955 INFO [stderr] 26 | use failure::Error;
Dec 15 19:52:40.955 INFO [stderr]    |     ^^^^^^^^^^^^^^
Dec 15 19:52:40.955 INFO [stderr]    |
Dec 15 19:52:40.955 INFO [stderr]    = note: #[warn(unused_imports)] on by default
Dec 15 19:52:40.955 INFO [stderr] 
Dec 15 19:52:40.955 INFO [stderr] warning: unused import: `failure::Fail`
Dec 15 19:52:40.955 INFO [stderr]   --> src/util.rs:27:5
Dec 15 19:52:40.955 INFO [stderr]    |
Dec 15 19:52:40.955 INFO [stderr] 27 | use failure::Fail;
Dec 15 19:52:40.955 INFO [stderr]    |     ^^^^^^^^^^^^^
Dec 15 19:52:40.955 INFO [stderr] 
Dec 15 19:52:40.955 INFO [stderr] warning: unused import: `failure::Context`
Dec 15 19:52:40.955 INFO [stderr]   --> src/util.rs:28:5
Dec 15 19:52:40.955 INFO [stderr]    |
Dec 15 19:52:40.955 INFO [stderr] 28 | use failure::Context;
Dec 15 19:52:40.955 INFO [stderr]    |     ^^^^^^^^^^^^^^^^
Dec 15 19:52:40.955 INFO [stderr] 
Dec 15 19:52:40.955 INFO [stderr] warning: unused import: `std::env`
Dec 15 19:52:40.955 INFO [stderr]   --> src/main.rs:55:5
Dec 15 19:52:40.955 INFO [stderr]    |
Dec 15 19:52:40.955 INFO [stderr] 55 | use std::env;
Dec 15 19:52:40.955 INFO [stderr]    |     ^^^^^^^^
Dec 15 19:52:40.955 INFO [stderr] 
Dec 15 19:52:54.985 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 42.85s
Dec 15 19:52:55.002 INFO [stderr] su: No module specific data is present
Dec 15 19:52:55.283 INFO running `"docker" "inspect" "6a2355ed19b3c5aa65287b0121bec084c1ce45e3d834604dcfe01aa3291b957e"`
Dec 15 19:52:55.369 INFO running `"docker" "rm" "-f" "6a2355ed19b3c5aa65287b0121bec084c1ce45e3d834604dcfe01aa3291b957e"`
Dec 15 19:52:55.461 INFO [stdout] 6a2355ed19b3c5aa65287b0121bec084c1ce45e3d834604dcfe01aa3291b957e
Dec 15 19:52:55.464 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 19:52:55.661 INFO [stdout] a85b513a3a385d093d6d7ce9620f36ab9b9307bfec17abd14dffe20ff460b26c
Dec 15 19:52:55.665 INFO running `"docker" "start" "-a" "a85b513a3a385d093d6d7ce9620f36ab9b9307bfec17abd14dffe20ff460b26c"`
Dec 15 19:52:56.203 INFO [stderr] usermod: no changes
Dec 15 19:52:56.497 INFO [stderr]    Compiling hamcrest v0.1.5
Dec 15 19:52:59.030 INFO [stderr]    Compiling cargo-raze v0.1.3 (/source)
Dec 15 19:53:09.400 INFO [stderr] warning: unused import: `failure::Error`
Dec 15 19:53:09.400 INFO [stderr]   --> src/util.rs:26:5
Dec 15 19:53:09.400 INFO [stderr]    |
Dec 15 19:53:09.400 INFO [stderr] 26 | use failure::Error;
Dec 15 19:53:09.401 INFO [stderr]    |     ^^^^^^^^^^^^^^
Dec 15 19:53:09.401 INFO [stderr]    |
Dec 15 19:53:09.401 INFO [stderr]    = note: #[warn(unused_imports)] on by default
Dec 15 19:53:09.401 INFO [stderr] 
Dec 15 19:53:09.401 INFO [stderr] warning: unused import: `failure::Fail`
Dec 15 19:53:09.401 INFO [stderr]   --> src/util.rs:27:5
Dec 15 19:53:09.402 INFO [stderr]    |
Dec 15 19:53:09.402 INFO [stderr] 27 | use failure::Fail;
Dec 15 19:53:09.402 INFO [stderr]    |     ^^^^^^^^^^^^^
Dec 15 19:53:09.402 INFO [stderr] 
Dec 15 19:53:09.402 INFO [stderr] warning: unused import: `failure::Context`
Dec 15 19:53:09.403 INFO [stderr]   --> src/util.rs:28:5
Dec 15 19:53:09.403 INFO [stderr]    |
Dec 15 19:53:09.403 INFO [stderr] 28 | use failure::Context;
Dec 15 19:53:09.403 INFO [stderr]    |     ^^^^^^^^^^^^^^^^
Dec 15 19:53:09.403 INFO [stderr] 
Dec 15 19:53:09.404 INFO [stderr] warning: unused import: `std::env`
Dec 15 19:53:09.404 INFO [stderr]   --> src/main.rs:55:5
Dec 15 19:53:09.404 INFO [stderr]    |
Dec 15 19:53:09.404 INFO [stderr] 55 | use std::env;
Dec 15 19:53:09.405 INFO [stderr]    |     ^^^^^^^^
Dec 15 19:53:09.405 INFO [stderr] 
Dec 15 19:53:24.499 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 28.26s
Dec 15 19:53:24.523 INFO [stderr] su: No module specific data is present
Dec 15 19:53:25.219 INFO running `"docker" "inspect" "a85b513a3a385d093d6d7ce9620f36ab9b9307bfec17abd14dffe20ff460b26c"`
Dec 15 19:53:25.582 INFO running `"docker" "rm" "-f" "a85b513a3a385d093d6d7ce9620f36ab9b9307bfec17abd14dffe20ff460b26c"`
Dec 15 19:53:26.015 INFO [stdout] a85b513a3a385d093d6d7ce9620f36ab9b9307bfec17abd14dffe20ff460b26c
Dec 15 19:53:26.023 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 19:53:26.528 INFO [stdout] c58975c4ed282faaacaab8da937c3bb5720d21924e9c6708e2855eedaf524db5
Dec 15 19:53:26.530 INFO running `"docker" "start" "-a" "c58975c4ed282faaacaab8da937c3bb5720d21924e9c6708e2855eedaf524db5"`
Dec 15 19:53:27.888 INFO [stderr] usermod: no changes
Dec 15 19:53:28.258 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.34s
Dec 15 19:53:28.288 INFO [stderr]      Running /target/debug/deps/cargo_raze-6da304a6afe062f1
Dec 15 19:53:28.314 INFO [stdout] 
Dec 15 19:53:28.322 INFO [stdout] running 25 tests
Dec 15 19:53:28.359 INFO [stdout] test license::tests::more_permissive_licenses_come_first ... ok
Dec 15 19:53:28.359 INFO [stdout] test license::tests::unknown_licenses_are_restricted ... ok
Dec 15 19:53:28.359 INFO [stdout] test license::tests::whitespace_laden_licenses_are_ok ... ok
Dec 15 19:53:28.431 INFO [stdout] test metadata::tests::test_cargo_subcommand_metadata_fetcher_handles_bad_files ... ok
Dec 15 19:53:28.460 INFO [stdout] test metadata::tests::test_cargo_subcommand_metadata_fetcher_works_without_lock ... ok
Dec 15 19:53:28.465 INFO [stdout] test bazel::tests::binaries_get_rust_binary_rules ... ok
Dec 15 19:53:28.476 INFO [stdout] test metadata::tests::test_cargo_subcommand_metadata_fetcher_works_with_lock ... ok
Dec 15 19:53:28.477 INFO [stdout] test planning::tests::test__checks__check_resolve_matches_packages_fails_correctly ... ok
Dec 15 19:53:28.479 INFO [stdout] test bazel::tests::root_crates_get_build_aliases ... ok
Dec 15 19:53:28.479 INFO [stdout] test planning::tests::test_license_loading_dedupes_equivalent_licenses ... ok
Dec 15 19:53:28.487 INFO [stdout] test planning::tests::test_license_loading_works_with_no_license ... ok
Dec 15 19:53:28.488 INFO [stdout] test planning::tests::test_plan_build_minimum_root_dependency ... ok
Dec 15 19:53:28.488 INFO [stdout] test planning::tests::test__checks__check_resolve_matches_packages_works_correctly ... ok
Dec 15 19:53:28.491 INFO [stdout] test planning::tests::test_plan_build_minimum_workspace ... ok
Dec 15 19:53:28.519 INFO [stdout] test bazel::tests::all_plans_contain_root_build_file ... ok
Dec 15 19:53:28.523 INFO [stdout] test util::tests::test_collect_up_to_works_for_one ... ok
Dec 15 19:53:28.529 INFO [stdout] test util::tests::test_collect_up_to_works_for_others_and_bounds_correctly ... ok
Dec 15 19:53:28.550 INFO [stdout] test util::tests::test_collect_up_to_works_for_zero ... ok
Dec 15 19:53:28.550 INFO [stdout] test bazel::tests::crates_generate_build_files ... ok
Dec 15 19:53:28.550 INFO [stdout] test bazel::tests::libraries_get_rust_library_rules ... ok
Dec 15 19:53:28.557 INFO [stdout] test bazel::tests::non_root_crates_dont_get_build_aliases ... ok
Dec 15 19:53:28.577 INFO [stdout] test metadata::tests::test_metadata_deserializes_correctly ... ok
Dec 15 19:53:28.961 INFO [stdout] test planning::tests::test_plan_build_missing_resolve_panics ... ok
Dec 15 19:53:29.033 INFO [stdout] test planning::tests::test_plan_build_missing_package_in_metadata ... ok
Dec 15 19:53:29.035 INFO [stdout] test planning::tests::test_plan_build_verifies_vendored_state ... ok
Dec 15 19:53:29.035 INFO [stdout] 
Dec 15 19:53:29.035 INFO [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 19:53:29.035 INFO [stdout] 
Dec 15 19:53:29.059 INFO [stderr] su: No module specific data is present
Dec 15 19:53:29.401 INFO running `"docker" "inspect" "c58975c4ed282faaacaab8da937c3bb5720d21924e9c6708e2855eedaf524db5"`
Dec 15 19:53:29.516 INFO running `"docker" "rm" "-f" "c58975c4ed282faaacaab8da937c3bb5720d21924e9c6708e2855eedaf524db5"`
Dec 15 19:53:29.630 INFO [stdout] c58975c4ed282faaacaab8da937c3bb5720d21924e9c6708e2855eedaf524db5