Dec 14 16:55:04.649 INFO testing timebomb-0.1.2 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 16:55:04.649 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 14 16:55:05.308 INFO [stdout] 90ddfc4957cc3e8c48fd6eefd709fb3d9719a95c9364f8234a624eefd2c71320
Dec 14 16:55:05.310 INFO running `"docker" "start" "-a" "90ddfc4957cc3e8c48fd6eefd709fb3d9719a95c9364f8234a624eefd2c71320"`
Dec 14 16:55:07.119 INFO [stderr] usermod: no changes
Dec 14 16:55:07.191 INFO [stderr]    Compiling timebomb v0.1.2 (/source)
Dec 14 16:55:08.031 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.88s
Dec 14 16:55:08.031 INFO [stderr] su: No module specific data is present
Dec 14 16:55:09.447 INFO running `"docker" "inspect" "90ddfc4957cc3e8c48fd6eefd709fb3d9719a95c9364f8234a624eefd2c71320"`
Dec 14 16:55:09.891 INFO running `"docker" "rm" "-f" "90ddfc4957cc3e8c48fd6eefd709fb3d9719a95c9364f8234a624eefd2c71320"`
Dec 14 16:55:10.239 INFO [stdout] 90ddfc4957cc3e8c48fd6eefd709fb3d9719a95c9364f8234a624eefd2c71320
Dec 14 16:55:10.241 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 14 16:55:10.712 INFO [stdout] f871c20ce8c5b0a909365cb102c5c88f0467e6834135cce5940caa91e15bff85
Dec 14 16:55:10.714 INFO running `"docker" "start" "-a" "f871c20ce8c5b0a909365cb102c5c88f0467e6834135cce5940caa91e15bff85"`
Dec 14 16:55:13.338 INFO [stderr] usermod: no changes
Dec 14 16:55:13.407 INFO [stderr]    Compiling timebomb v0.1.2 (/source)
Dec 14 16:55:15.262 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.90s
Dec 14 16:55:15.262 INFO [stderr] su: No module specific data is present
Dec 14 16:55:16.620 INFO running `"docker" "inspect" "f871c20ce8c5b0a909365cb102c5c88f0467e6834135cce5940caa91e15bff85"`
Dec 14 16:55:16.957 INFO running `"docker" "rm" "-f" "f871c20ce8c5b0a909365cb102c5c88f0467e6834135cce5940caa91e15bff85"`
Dec 14 16:55:17.210 INFO [stdout] f871c20ce8c5b0a909365cb102c5c88f0467e6834135cce5940caa91e15bff85
Dec 14 16:55:17.213 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 14 16:55:17.655 INFO [stdout] e970a4227961d56e3904d939c319d1e497d655457002a2bbccbeccd976805861
Dec 14 16:55:17.657 INFO running `"docker" "start" "-a" "e970a4227961d56e3904d939c319d1e497d655457002a2bbccbeccd976805861"`
Dec 14 16:55:19.208 INFO [stderr] usermod: no changes
Dec 14 16:55:19.278 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Dec 14 16:55:19.278 INFO [stderr]      Running /target/debug/deps/timebomb-ff9083ff7d2c60c0
Dec 14 16:55:19.280 INFO [stdout] 
Dec 14 16:55:19.280 INFO [stdout] running 3 tests
Dec 14 16:55:19.303 INFO [stderr] thread '<unnamed>' panicked at 'oh no!', src/lib.rs:63:9
Dec 14 16:55:19.303 INFO [stderr] stack backtrace:
Dec 14 16:55:19.307 INFO [stdout] test timeout_ms_no_timeout_ms ... ok
Dec 14 16:55:19.311 INFO [stderr]    0:     0x5611e2d36393 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h2c40bdfb30f25bdd
Dec 14 16:55:19.371 INFO [stderr]                                at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 14 16:55:19.371 INFO [stderr]    1:     0x5611e2d30b98 - std::sys_common::backtrace::_print::he11ceebc70626ac9
Dec 14 16:55:19.371 INFO [stderr]                                at src/libstd/sys_common/backtrace.rs:71
Dec 14 16:55:19.371 INFO [stderr]    2:     0x5611e2d35302 - std::panicking::default_hook::{{closure}}::h4fde3ffb19c01413
Dec 14 16:55:19.371 INFO [stderr]                                at src/libstd/sys_common/backtrace.rs:59
Dec 14 16:55:19.371 INFO [stderr]                                at src/libstd/panicking.rs:210
Dec 14 16:55:19.371 INFO [stderr]    3:     0x5611e2d35074 - std::panicking::default_hook::hf0c15a583008ed0d
Dec 14 16:55:19.371 INFO [stderr]                                at src/libstd/panicking.rs:224
Dec 14 16:55:19.371 INFO [stderr]    4:     0x5611e2d35a10 - std::panicking::rust_panic_with_hook::hc1663f6bc7813185
Dec 14 16:55:19.371 INFO [stderr]                                at src/libstd/panicking.rs:487
Dec 14 16:55:19.371 INFO [stderr]    5:     0x5611e2d24bf7 - std::panicking::begin_panic::h8d7c533d2445d0cb
Dec 14 16:55:19.371 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:421
Dec 14 16:55:19.371 INFO [stderr]    6:     0x5611e2cdb3fc - timebomb::child_panics::{{closure}}::h55649595b4ca7ba0
Dec 14 16:55:19.371 INFO [stderr]                                at src/lib.rs:63
Dec 14 16:55:19.371 INFO [stderr]    7:     0x5611e2cdb2c5 - timebomb::timeout_ms::{{closure}}::hcce899bef80e3513
Dec 14 16:55:19.371 INFO [stderr]                                at src/lib.rs:28
Dec 14 16:55:19.371 INFO [stderr]    8:     0x5611e2cda14a - std::sys_common::backtrace::__rust_begin_short_backtrace::hc6db8ee73596f12b
Dec 14 16:55:19.371 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/sys_common/backtrace.rs:136
Dec 14 16:55:19.371 INFO [stderr]    9:     0x5611e2cd7f9c - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::hb2ccab8a69b38d42
Dec 14 16:55:19.371 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:479
Dec 14 16:55:19.371 INFO [stderr]   10:     0x5611e2cd924c - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hf125a1ef451a027b
Dec 14 16:55:19.371 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:319
Dec 14 16:55:19.371 INFO [stderr]   11:     0x5611e2cda66f - std::panicking::try::do_call::hd26a3fb7c7c8b206
Dec 14 16:55:19.371 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:306
Dec 14 16:55:19.371 INFO [stderr]   12:     0x5611e2d440b9 - __rust_maybe_catch_panic
Dec 14 16:55:19.371 INFO [stderr]                                at src/libpanic_unwind/lib.rs:102
Dec 14 16:55:19.371 INFO [stderr]   13:     0x5611e2cda542 - std::panicking::try::h7e99291010e4c0f5
Dec 14 16:55:19.371 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285
Dec 14 16:55:19.371 INFO [stderr]   14:     0x5611e2cd927c - std::panic::catch_unwind::h63d098784ed884eb
Dec 14 16:55:19.371 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398
Dec 14 16:55:19.371 INFO [stderr]   15:     0x5611e2cd7a69 - std::thread::Builder::spawn_unchecked::{{closure}}::h348d4f276a35e794
Dec 14 16:55:19.371 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:478
Dec 14 16:55:19.371 INFO [stderr]   16:     0x5611e2cd82e6 - <F as alloc::boxed::FnBox<A>>::call_box::hefc410606a88b661
Dec 14 16:55:19.371 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673
Dec 14 16:55:19.371 INFO [stderr]   17:     0x5611e2d37fdd - std::sys::unix::thread::Thread::new::thread_start::h42c32b292fdd228f
Dec 14 16:55:19.371 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:683
Dec 14 16:55:19.371 INFO [stderr]                                at src/libstd/sys_common/thread.rs:24
Dec 14 16:55:19.371 INFO [stderr]                                at src/libstd/sys/unix/thread.rs:91
Dec 14 16:55:19.371 INFO [stderr]   18:     0x7f2dbfab56b9 - start_thread
Dec 14 16:55:19.371 INFO [stderr]   19:     0x7f2dbf5d541c - clone
Dec 14 16:55:19.371 INFO [stderr]   20:                0x0 - <unknown>
Dec 14 16:55:19.467 INFO [stdout] test timeout_ms_spin ... ok
Dec 14 16:55:19.471 INFO [stdout] test child_panics ... ok
Dec 14 16:55:19.471 INFO [stdout] 
Dec 14 16:55:19.471 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:55:19.471 INFO [stdout] 
Dec 14 16:55:19.487 INFO [stderr]    Doc-tests timebomb
Dec 14 16:55:20.675 INFO [stdout] 
Dec 14 16:55:20.675 INFO [stdout] running 0 tests
Dec 14 16:55:20.675 INFO [stdout] 
Dec 14 16:55:20.675 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:55:20.675 INFO [stdout] 
Dec 14 16:55:20.687 INFO [stderr] su: No module specific data is present
Dec 14 16:55:21.706 INFO running `"docker" "inspect" "e970a4227961d56e3904d939c319d1e497d655457002a2bbccbeccd976805861"`
Dec 14 16:55:22.108 INFO running `"docker" "rm" "-f" "e970a4227961d56e3904d939c319d1e497d655457002a2bbccbeccd976805861"`
Dec 14 16:55:22.435 INFO [stdout] e970a4227961d56e3904d939c319d1e497d655457002a2bbccbeccd976805861