Dec 07 17:51:07.262 INFO testing elba-0.2.0 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 07 17:51:07.262 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 07 17:51:07.722 INFO [stdout] 65666b5304ab92a1050939fed054e5300c3631e403d7f0d1893212295952f4be
Dec 07 17:51:07.726 INFO running `"docker" "start" "-a" "65666b5304ab92a1050939fed054e5300c3631e403d7f0d1893212295952f4be"`
Dec 07 17:51:08.808 INFO [stderr] usermod: no changes
Dec 07 17:51:09.690 INFO [stderr]    Compiling slog v2.4.1
Dec 07 17:51:09.706 INFO [stderr]    Compiling crossbeam-channel v0.2.6
Dec 07 17:51:09.712 INFO [stderr]    Compiling console v0.6.2
Dec 07 17:51:09.712 INFO [stderr]    Compiling tokio-core v0.1.17
Dec 07 17:51:12.632 INFO [stderr]    Compiling slog-term v2.4.0
Dec 07 17:51:12.632 INFO [stderr]    Compiling slog-async v2.3.0
Dec 07 17:51:17.284 INFO [stderr]    Compiling crossbeam v0.4.1
Dec 07 17:51:25.019 INFO [stderr]    Compiling hyper v0.11.27
Dec 07 17:51:25.019 INFO [stderr]    Compiling tokio-tls v0.1.4
Dec 07 17:51:40.974 INFO [stderr]    Compiling hyper-tls v0.1.4
Dec 07 17:51:47.124 INFO [stderr]    Compiling reqwest v0.8.8
Dec 07 17:52:02.271 INFO [stderr]    Compiling elba v0.2.0 (/source)
Dec 07 17:53:05.609 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 56s
Dec 07 17:53:05.637 INFO [stderr] su: No module specific data is present
Dec 07 17:53:07.272 INFO running `"docker" "inspect" "65666b5304ab92a1050939fed054e5300c3631e403d7f0d1893212295952f4be"`
Dec 07 17:53:07.562 INFO running `"docker" "rm" "-f" "65666b5304ab92a1050939fed054e5300c3631e403d7f0d1893212295952f4be"`
Dec 07 17:53:07.844 INFO [stdout] 65666b5304ab92a1050939fed054e5300c3631e403d7f0d1893212295952f4be
Dec 07 17:53:07.850 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 07 17:53:08.349 INFO [stdout] bd393d9cf390c4956cce68fd3f28e0a4ee7cd72e98c3a10a1ea3e4d351e2d834
Dec 07 17:53:08.352 INFO running `"docker" "start" "-a" "bd393d9cf390c4956cce68fd3f28e0a4ee7cd72e98c3a10a1ea3e4d351e2d834"`
Dec 07 17:53:10.166 INFO [stderr] usermod: no changes
Dec 07 17:53:10.636 INFO [stderr]    Compiling elba v0.2.0 (/source)
Dec 07 17:54:10.016 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 59.82s
Dec 07 17:54:10.061 INFO [stderr] su: No module specific data is present
Dec 07 17:54:11.586 INFO running `"docker" "inspect" "bd393d9cf390c4956cce68fd3f28e0a4ee7cd72e98c3a10a1ea3e4d351e2d834"`
Dec 07 17:54:11.964 INFO running `"docker" "rm" "-f" "bd393d9cf390c4956cce68fd3f28e0a4ee7cd72e98c3a10a1ea3e4d351e2d834"`
Dec 07 17:54:12.340 INFO [stdout] bd393d9cf390c4956cce68fd3f28e0a4ee7cd72e98c3a10a1ea3e4d351e2d834
Dec 07 17:54:12.344 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 07 17:54:12.925 INFO [stdout] 9e12a00df1bfbf60956cd7ac4b46c81e01b22dbad4eefa26c3cc31b1eb846edb
Dec 07 17:54:12.927 INFO running `"docker" "start" "-a" "9e12a00df1bfbf60956cd7ac4b46c81e01b22dbad4eefa26c3cc31b1eb846edb"`
Dec 07 17:54:14.810 INFO [stderr] usermod: no changes
Dec 07 17:54:15.388 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.55s
Dec 07 17:54:15.428 INFO [stderr]      Running /target/debug/deps/elba-93ef8348e3424bfa
Dec 07 17:54:15.464 INFO [stdout] 
Dec 07 17:54:15.464 INFO [stdout] running 24 tests
Dec 07 17:54:15.468 INFO [stdout] test package::lockfile::tests::valid_lockfile ... ok
Dec 07 17:54:15.476 INFO [stdout] test package::manifest::tests::manifest_no_targets ... ok
Dec 07 17:54:15.476 INFO [stdout] test package::manifest::tests::manifest_invalid_target_path ... ok
Dec 07 17:54:15.476 INFO [stdout] test package::version::tests::constraint_complement ... ok
Dec 07 17:54:15.476 INFO [stdout] test package::version::tests::constraint_complement_symmetry ... ok
Dec 07 17:54:15.476 INFO [stdout] test package::version::tests::constraint_relation_opposite ... ok
Dec 07 17:54:15.476 INFO [stdout] test package::version::tests::constraint_difference_any ... ok
Dec 07 17:54:15.476 INFO [stdout] test package::version::tests::constraint_relation ... ok
Dec 07 17:54:15.476 INFO [stdout] test package::version::tests::constraint_difference_any_union ... ok
Dec 07 17:54:15.484 INFO [stdout] test package::version::tests::constraint_complement_correct ... ok
Dec 07 17:54:15.484 INFO [stdout] test package::version::tests::constraint_complement_single ... ok
Dec 07 17:54:15.484 INFO [stdout] test package::manifest::tests::manifest_valid ... ok
Dec 07 17:54:15.484 INFO [stdout] test package::version::tests::constraint_subset ... ok
Dec 07 17:54:15.484 INFO [stdout] test package::version::tests::constraint_relation_single ... ok
Dec 07 17:54:15.484 INFO [stdout] test package::version::tests::range_parse_manual ... ok
Dec 07 17:54:15.484 INFO [stdout] test package::version::tests::version_parse ... ok
Dec 07 17:54:15.484 INFO [stdout] test package::version::tests::version_single ... ok
Dec 07 17:54:15.484 INFO [stdout] test package::version::tests::range_parse_tilde ... ok
Dec 07 17:54:15.484 INFO [stdout] test package::version::tests::range_parse_caret ... ok
Dec 07 17:54:15.484 INFO [stdout] test util::lock::test::dirlock_existing_err ... ok
Dec 07 17:54:15.484 INFO [stdout] test package::version::tests::range_pre_ok ... ok
Dec 07 17:54:15.484 INFO [stdout] test package::version::tests::constraint_difference ... ok
Dec 07 17:54:15.484 INFO [stdout] test util::lock::test::dirlock_simple ... ok
Dec 07 17:54:15.490 INFO [stdout] test util::lock::test::dirlock_wrong_order ... ok
Dec 07 17:54:15.490 INFO [stdout] 
Dec 07 17:54:15.490 INFO [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 17:54:15.490 INFO [stdout] 
Dec 07 17:54:15.496 INFO [stderr]      Running /target/debug/deps/elba-e7a9c90bef5210d9
Dec 07 17:54:15.498 INFO [stdout] 
Dec 07 17:54:15.498 INFO [stdout] running 0 tests
Dec 07 17:54:15.498 INFO [stdout] 
Dec 07 17:54:15.499 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 17:54:15.499 INFO [stdout] 
Dec 07 17:54:15.500 INFO [stderr]      Running /target/debug/deps/testsuite-1c7bad7806fbb1fb
Dec 07 17:54:15.552 INFO [stdout] 
Dec 07 17:54:15.552 INFO [stdout] running 7 tests
Dec 07 17:54:15.568 INFO [stdout] test index::index_success ... ok
Dec 07 17:54:15.616 INFO [stdout] test resolver::resolve_conflict_res_simple ... ok
Dec 07 17:54:15.616 INFO [stdout] test resolver::resolve_avoid_conflict ... ok
Dec 07 17:54:15.616 INFO [stdout] test resolver::resolve_conflict_simple_report ... ok
Dec 07 17:54:15.616 INFO [stdout] test resolver::resolve_no_conflict ... ok
Dec 07 17:54:15.788 INFO [stdout] test resolver::resolve_conflict_complex_report ... ok
Dec 07 17:54:15.806 INFO [stdout] test resolver::resolve_conflict_res_partial ... FAILED
Dec 07 17:54:15.806 INFO [stdout] 
Dec 07 17:54:15.806 INFO [stdout] failures:
Dec 07 17:54:15.806 INFO [stdout] 
Dec 07 17:54:15.806 INFO [stdout] ---- resolver::resolve_conflict_res_partial stdout ----
Dec 07 17:54:15.806 INFO [stdout]       [warn] Couldn't add package conflict_res_partial/target@index+dir+/tmp/elba.XxGYEbfDhHrG >=2.0.0 <3.0.0: package doesn't exist in index
Dec 07 17:54:15.806 INFO [stdout] thread 'resolver::resolve_conflict_res_partial' panicked at 'assertion failed: resolver.solve().is_ok()', tests/testsuite/resolver.rs:93:5
Dec 07 17:54:15.806 INFO [stdout] stack backtrace:
Dec 07 17:54:15.806 INFO [stdout]    0:     0x55caaf244cc3 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h82c998a0e635a5c4
Dec 07 17:54:15.806 INFO [stdout]                                at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 07 17:54:15.806 INFO [stdout]    1:     0x55caaf23edf8 - std::sys_common::backtrace::_print::h5fbc0bc3cf12d9bf
Dec 07 17:54:15.806 INFO [stdout]                                at src/libstd/sys_common/backtrace.rs:71
Dec 07 17:54:15.806 INFO [stdout]    2:     0x55caaf2436c2 - std::panicking::default_hook::{{closure}}::h42b81c3dd1a50e32
Dec 07 17:54:15.806 INFO [stdout]                                at src/libstd/sys_common/backtrace.rs:59
Dec 07 17:54:15.806 INFO [stdout]                                at src/libstd/panicking.rs:211
Dec 07 17:54:15.806 INFO [stdout]    3:     0x55caaf2433ac - std::panicking::default_hook::h6c8d8e1c12a669e5
Dec 07 17:54:15.806 INFO [stdout]                                at src/libstd/panicking.rs:221
Dec 07 17:54:15.806 INFO [stdout]    4:     0x55caaf243dd0 - std::panicking::rust_panic_with_hook::hce93a56e38c2b0aa
Dec 07 17:54:15.806 INFO [stdout]                                at src/libstd/panicking.rs:491
Dec 07 17:54:15.806 INFO [stdout]    5:     0x55caae9471c7 - std::panicking::begin_panic::h41ed9a01dd32866e
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panicking.rs:425
Dec 07 17:54:15.806 INFO [stdout]    6:     0x55caae900270 - testsuite::resolver::resolve_conflict_res_partial::h01e6c885554e5b68
Dec 07 17:54:15.806 INFO [stdout]                                at tests/testsuite/resolver.rs:93
Dec 07 17:54:15.806 INFO [stdout]    7:     0x55caae8ffe59 - testsuite::resolver::resolve_conflict_res_partial::{{closure}}::hb8f9d64930897989
Dec 07 17:54:15.806 INFO [stdout]                                at tests/testsuite/resolver.rs:90
Dec 07 17:54:15.806 INFO [stdout]    8:     0x55caae90176d - core::ops::function::FnOnce::call_once::h2a4ce902d686cdee
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libcore/ops/function.rs:238
Dec 07 17:54:15.806 INFO [stdout]    9:     0x55caae9104be - <F as alloc::boxed::FnBox<A>>::call_box::h9ed1658cdce7f33f
Dec 07 17:54:15.806 INFO [stdout]                                at src/libtest/lib.rs:1471
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libcore/ops/function.rs:238
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/liballoc/boxed.rs:673
Dec 07 17:54:15.806 INFO [stdout]   10:     0x55caaf259029 - __rust_maybe_catch_panic
Dec 07 17:54:15.806 INFO [stdout]                                at src/libpanic_unwind/lib.rs:102
Dec 07 17:54:15.806 INFO [stdout]   11:     0x55caae908393 - std::sys_common::backtrace::__rust_begin_short_backtrace::h018d03d6681412f5
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panicking.rs:289
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panic.rs:398
Dec 07 17:54:15.806 INFO [stdout]                                at src/libtest/lib.rs:1426
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/sys_common/backtrace.rs:136
Dec 07 17:54:15.806 INFO [stdout]   12:     0x55caae909324 - std::panicking::try::do_call::hf8ab3f21dcfaa7a6
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/thread/mod.rs:477
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panic.rs:319
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panicking.rs:310
Dec 07 17:54:15.806 INFO [stdout]   13:     0x55caaf259029 - __rust_maybe_catch_panic
Dec 07 17:54:15.806 INFO [stdout]                                at src/libpanic_unwind/lib.rs:102
Dec 07 17:54:15.806 INFO [stdout]   14:     0x55caae91039c - <F as alloc::boxed::FnBox<A>>::call_box::h6465cc998309e287
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panicking.rs:289
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panic.rs:398
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/thread/mod.rs:476
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/liballoc/boxed.rs:673
Dec 07 17:54:15.806 INFO [stdout]   15:     0x55caaf24cc4d - std::sys::unix::thread::Thread::new::thread_start::h0fe9c527147fd5f5
Dec 07 17:54:15.806 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/liballoc/boxed.rs:683
Dec 07 17:54:15.806 INFO [stdout]                                at src/libstd/sys_common/thread.rs:24
Dec 07 17:54:15.806 INFO [stdout]                                at src/libstd/sys/unix/thread.rs:90
Dec 07 17:54:15.806 INFO [stdout]   16:     0x7fb61c24c6b9 - start_thread
Dec 07 17:54:15.806 INFO [stdout]   17:     0x7fb61c76d41c - clone
Dec 07 17:54:15.806 INFO [stdout]   18:                0x0 - <unknown>
Dec 07 17:54:15.806 INFO [stdout] 
Dec 07 17:54:15.806 INFO [stdout] 
Dec 07 17:54:15.806 INFO [stdout] failures:
Dec 07 17:54:15.806 INFO [stdout]     resolver::resolve_conflict_res_partial
Dec 07 17:54:15.806 INFO [stdout] 
Dec 07 17:54:15.806 INFO [stdout] test result: FAILED. 6 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 17:54:15.806 INFO [stdout] 
Dec 07 17:54:15.828 INFO [stderr] error: test failed, to rerun pass '--test testsuite'
Dec 07 17:54:15.833 INFO [stderr] su: No module specific data is present
Dec 07 17:54:16.916 INFO running `"docker" "inspect" "9e12a00df1bfbf60956cd7ac4b46c81e01b22dbad4eefa26c3cc31b1eb846edb"`
Dec 07 17:54:17.280 INFO running `"docker" "rm" "-f" "9e12a00df1bfbf60956cd7ac4b46c81e01b22dbad4eefa26c3cc31b1eb846edb"`
Dec 07 17:54:17.577 INFO [stdout] 9e12a00df1bfbf60956cd7ac4b46c81e01b22dbad4eefa26c3cc31b1eb846edb