Dec 15 08:22:31.404 INFO testing hyper-timeout-0.1.1 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550 Dec 15 08:22:31.404 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 08:22:32.000 INFO [stdout] df6df5dbbc343d1b2fe7b77f3a52a292e462f90b40cb7e9c00d316177a446378 Dec 15 08:22:32.002 INFO running `"docker" "start" "-a" "df6df5dbbc343d1b2fe7b77f3a52a292e462f90b40cb7e9c00d316177a446378"` Dec 15 08:22:33.727 INFO [stderr] usermod: no changes Dec 15 08:22:34.035 INFO [stderr] Compiling tokio-io-timeout v0.1.3 Dec 15 08:22:38.164 INFO [stderr] Compiling hyper-timeout v0.1.1 (/source) Dec 15 08:22:43.215 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 9.44s Dec 15 08:22:43.237 INFO [stderr] su: No module specific data is present Dec 15 08:22:44.623 INFO running `"docker" "inspect" "df6df5dbbc343d1b2fe7b77f3a52a292e462f90b40cb7e9c00d316177a446378"` Dec 15 08:22:44.901 INFO running `"docker" "rm" "-f" "df6df5dbbc343d1b2fe7b77f3a52a292e462f90b40cb7e9c00d316177a446378"` Dec 15 08:22:45.256 INFO [stdout] df6df5dbbc343d1b2fe7b77f3a52a292e462f90b40cb7e9c00d316177a446378 Dec 15 08:22:45.260 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 08:22:45.699 INFO [stdout] f25b95573122318be218e903d0e0feeb5c8701107ced5e290950c6a81818a71e Dec 15 08:22:45.707 INFO running `"docker" "start" "-a" "f25b95573122318be218e903d0e0feeb5c8701107ced5e290950c6a81818a71e"` Dec 15 08:22:47.178 INFO [stderr] usermod: no changes Dec 15 08:22:47.431 INFO [stderr] Compiling hyper-timeout v0.1.1 (/source) Dec 15 08:23:02.492 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 15.28s Dec 15 08:23:02.504 INFO [stderr] su: No module specific data is present Dec 15 08:23:04.087 INFO running `"docker" "inspect" "f25b95573122318be218e903d0e0feeb5c8701107ced5e290950c6a81818a71e"` Dec 15 08:23:04.386 INFO running `"docker" "rm" "-f" "f25b95573122318be218e903d0e0feeb5c8701107ced5e290950c6a81818a71e"` Dec 15 08:23:04.727 INFO [stdout] f25b95573122318be218e903d0e0feeb5c8701107ced5e290950c6a81818a71e Dec 15 08:23:04.735 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 08:23:05.283 INFO [stdout] 792cd1dcf55af001b2d5756ee7f8aeeb5c5c95793155910cc852128fa5c5ecad Dec 15 08:23:05.289 INFO running `"docker" "start" "-a" "792cd1dcf55af001b2d5756ee7f8aeeb5c5c95793155910cc852128fa5c5ecad"` Dec 15 08:23:06.278 INFO [stderr] usermod: no changes Dec 15 08:23:06.526 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.21s Dec 15 08:23:06.547 INFO [stdout] Dec 15 08:23:06.547 INFO [stdout] running 1 test Dec 15 08:23:06.547 INFO [stderr] Running /target/debug/deps/hyper_timeout-17a9513c3d267013 Dec 15 08:23:06.666 INFO [stdout] test tests::test_timeout_connector ... FAILED Dec 15 08:23:06.666 INFO [stdout] Dec 15 08:23:06.666 INFO [stdout] failures: Dec 15 08:23:06.666 INFO [stdout] Dec 15 08:23:06.666 INFO [stdout] ---- tests::test_timeout_connector stdout ---- Dec 15 08:23:06.666 INFO [stdout] thread 'tests::test_timeout_connector' panicked at 'assertion failed: `(left == right)` Dec 15 08:23:06.666 INFO [stdout] left: `Other`, Dec 15 08:23:06.666 INFO [stdout] right: `TimedOut`', src/lib.rs:139:17 Dec 15 08:23:06.666 INFO [stdout] stack backtrace: Dec 15 08:23:06.666 INFO [stdout] 0: 0x561938955823 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h2c40bdfb30f25bdd Dec 15 08:23:06.666 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 15 08:23:06.666 INFO [stdout] 1: 0x56193894f708 - std::sys_common::backtrace::_print::he11ceebc70626ac9 Dec 15 08:23:06.666 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 15 08:23:06.666 INFO [stdout] 2: 0x561938953ef2 - std::panicking::default_hook::{{closure}}::h4fde3ffb19c01413 Dec 15 08:23:06.666 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 15 08:23:06.666 INFO [stdout] at src/libstd/panicking.rs:210 Dec 15 08:23:06.666 INFO [stdout] 3: 0x561938953be7 - std::panicking::default_hook::hf0c15a583008ed0d Dec 15 08:23:06.666 INFO [stdout] at src/libstd/panicking.rs:218 Dec 15 08:23:06.666 INFO [stdout] 4: 0x561938954600 - std::panicking::rust_panic_with_hook::hc1663f6bc7813185 Dec 15 08:23:06.666 INFO [stdout] at src/libstd/panicking.rs:487 Dec 15 08:23:06.666 INFO [stdout] 5: 0x561938954181 - std::panicking::continue_panic_fmt::h42bc2d03ddf03b3e Dec 15 08:23:06.666 INFO [stdout] at src/libstd/panicking.rs:394 Dec 15 08:23:06.666 INFO [stdout] 6: 0x5619389540ce - std::panicking::begin_panic_fmt::h2207969583fb9324 Dec 15 08:23:06.666 INFO [stdout] at src/libstd/panicking.rs:349 Dec 15 08:23:06.666 INFO [stdout] 7: 0x56193877591c - hyper_timeout::tests::test_timeout_connector::h024fde3c66c5d684 Dec 15 08:23:06.666 INFO [stdout] at src/lib.rs:139 Dec 15 08:23:06.666 INFO [stdout] 8: 0x561938775449 - hyper_timeout::tests::test_timeout_connector::{{closure}}::h9e047c83ee198b89 Dec 15 08:23:06.666 INFO [stdout] at src/lib.rs:129 Dec 15 08:23:06.666 INFO [stdout] 9: 0x56193876bd2d - core::ops::function::FnOnce::call_once::h9ce2734ed0ffefdc Dec 15 08:23:06.666 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238 Dec 15 08:23:06.666 INFO [stdout] 10: 0x561938780f1e - >::call_box::hac337ba1af72dc2b Dec 15 08:23:06.666 INFO [stdout] at src/libtest/lib.rs:1483 Dec 15 08:23:06.666 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238 Dec 15 08:23:06.666 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673 Dec 15 08:23:06.666 INFO [stdout] 11: 0x561938963629 - __rust_maybe_catch_panic Dec 15 08:23:06.666 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 15 08:23:06.666 INFO [stdout] 12: 0x56193879e727 - test::run_test::run_test_inner::{{closure}}::hfbfe4a58c0ebb01b Dec 15 08:23:06.666 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285 Dec 15 08:23:06.666 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398 Dec 15 08:23:06.666 INFO [stdout] at src/libtest/lib.rs:1438 Dec 15 08:23:06.666 INFO [stdout] 13: 0x561938779634 - std::sys_common::backtrace::__rust_begin_short_backtrace::hd1f0cf202092f8d7 Dec 15 08:23:06.666 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/sys_common/backtrace.rs:136 Dec 15 08:23:06.666 INFO [stdout] 14: 0x561938779c24 - std::panicking::try::do_call::h5e99f92fbf448cf6 Dec 15 08:23:06.666 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:479 Dec 15 08:23:06.666 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:319 Dec 15 08:23:06.666 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:306 Dec 15 08:23:06.666 INFO [stdout] 15: 0x561938963629 - __rust_maybe_catch_panic Dec 15 08:23:06.666 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 15 08:23:06.666 INFO [stdout] 16: 0x561938780dfc - >::call_box::h8ae063aff93ccdb6 Dec 15 08:23:06.666 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285 Dec 15 08:23:06.666 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398 Dec 15 08:23:06.666 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:478 Dec 15 08:23:06.666 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673 Dec 15 08:23:06.666 INFO [stdout] 17: 0x5619389575ed - std::sys::unix::thread::Thread::new::thread_start::h42c32b292fdd228f Dec 15 08:23:06.666 INFO [stdout] at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:683 Dec 15 08:23:06.666 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 15 08:23:06.666 INFO [stdout] at src/libstd/sys/unix/thread.rs:91 Dec 15 08:23:06.666 INFO [stdout] 18: 0x7fbc5fe2f6b9 - start_thread Dec 15 08:23:06.666 INFO [stdout] 19: 0x7fbc5f94f41c - clone Dec 15 08:23:06.666 INFO [stdout] 20: 0x0 - Dec 15 08:23:06.666 INFO [stdout] Dec 15 08:23:06.666 INFO [stdout] Dec 15 08:23:06.666 INFO [stdout] failures: Dec 15 08:23:06.666 INFO [stdout] tests::test_timeout_connector Dec 15 08:23:06.666 INFO [stdout] Dec 15 08:23:06.666 INFO [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 08:23:06.666 INFO [stdout] Dec 15 08:23:06.676 INFO [stderr] error: test failed, to rerun pass '--lib' Dec 15 08:23:06.683 INFO [stderr] su: No module specific data is present Dec 15 08:23:07.557 INFO running `"docker" "inspect" "792cd1dcf55af001b2d5756ee7f8aeeb5c5c95793155910cc852128fa5c5ecad"` Dec 15 08:23:07.983 INFO running `"docker" "rm" "-f" "792cd1dcf55af001b2d5756ee7f8aeeb5c5c95793155910cc852128fa5c5ecad"` Dec 15 08:23:08.339 INFO [stdout] 792cd1dcf55af001b2d5756ee7f8aeeb5c5c95793155910cc852128fa5c5ecad