Dec 06 20:07:42.451 INFO testing timebomb-0.1.2 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 20:07:42.451 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 20:07:42.884 INFO [stdout] fb5189735bf4bc6f56f6f2c869dfb5f35a4687dd8ed0a1be83d910fab06383dc
Dec 06 20:07:42.886 INFO running `"docker" "start" "-a" "fb5189735bf4bc6f56f6f2c869dfb5f35a4687dd8ed0a1be83d910fab06383dc"`
Dec 06 20:07:44.732 INFO [stderr] usermod: no changes
Dec 06 20:07:44.840 INFO [stderr]    Compiling pulse v0.5.3
Dec 06 20:07:47.028 INFO [stderr]    Compiling timebomb v0.1.2 (/source)
Dec 06 20:07:47.728 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.93s
Dec 06 20:07:47.736 INFO [stderr] su: No module specific data is present
Dec 06 20:07:48.746 INFO running `"docker" "inspect" "fb5189735bf4bc6f56f6f2c869dfb5f35a4687dd8ed0a1be83d910fab06383dc"`
Dec 06 20:07:49.118 INFO running `"docker" "rm" "-f" "fb5189735bf4bc6f56f6f2c869dfb5f35a4687dd8ed0a1be83d910fab06383dc"`
Dec 06 20:07:49.430 INFO [stdout] fb5189735bf4bc6f56f6f2c869dfb5f35a4687dd8ed0a1be83d910fab06383dc
Dec 06 20:07:49.430 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 20:07:49.921 INFO [stdout] a94d3a078cf90bd51e47cda5cecd66ba5fcba6f0fa2c809454b44b9423b447c8
Dec 06 20:07:49.927 INFO running `"docker" "start" "-a" "a94d3a078cf90bd51e47cda5cecd66ba5fcba6f0fa2c809454b44b9423b447c8"`
Dec 06 20:07:51.064 INFO [stderr] usermod: no changes
Dec 06 20:07:51.153 INFO [stderr]    Compiling timebomb v0.1.2 (/source)
Dec 06 20:07:53.099 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.00s
Dec 06 20:07:53.105 INFO [stderr] su: No module specific data is present
Dec 06 20:07:54.307 INFO running `"docker" "inspect" "a94d3a078cf90bd51e47cda5cecd66ba5fcba6f0fa2c809454b44b9423b447c8"`
Dec 06 20:07:54.683 INFO running `"docker" "rm" "-f" "a94d3a078cf90bd51e47cda5cecd66ba5fcba6f0fa2c809454b44b9423b447c8"`
Dec 06 20:07:55.043 INFO [stdout] a94d3a078cf90bd51e47cda5cecd66ba5fcba6f0fa2c809454b44b9423b447c8
Dec 06 20:07:55.048 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 20:07:55.556 INFO [stdout] 4af30d1c6e9b3e9c400c17ab606941539b70e23b2ea8abe3a62a0410f2abad06
Dec 06 20:07:55.562 INFO running `"docker" "start" "-a" "4af30d1c6e9b3e9c400c17ab606941539b70e23b2ea8abe3a62a0410f2abad06"`
Dec 06 20:07:56.712 INFO [stderr] usermod: no changes
Dec 06 20:07:56.785 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 06 20:07:56.788 INFO [stderr]      Running /target/debug/deps/timebomb-4f1f954651afcd60
Dec 06 20:07:56.788 INFO [stdout] 
Dec 06 20:07:56.788 INFO [stdout] running 3 tests
Dec 06 20:07:56.788 INFO [stdout] test timeout_ms_no_timeout_ms ... ok
Dec 06 20:07:56.809 INFO [stderr] thread '<unnamed>' panicked at 'oh no!', src/lib.rs:63:9
Dec 06 20:07:56.809 INFO [stderr] stack backtrace:
Dec 06 20:07:56.828 INFO [stderr]    0:     0x55e1a6f111e3 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7
Dec 06 20:07:56.908 INFO [stderr]                                at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 06 20:07:56.908 INFO [stderr]    1:     0x55e1a6f0b908 - std::sys_common::backtrace::_print::h95865c77318e98b7
Dec 06 20:07:56.908 INFO [stderr]                                at src/libstd/sys_common/backtrace.rs:71
Dec 06 20:07:56.908 INFO [stderr]    2:     0x55e1a6f10152 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5
Dec 06 20:07:56.908 INFO [stderr]                                at src/libstd/sys_common/backtrace.rs:59
Dec 06 20:07:56.908 INFO [stderr]                                at src/libstd/panicking.rs:211
Dec 06 20:07:56.908 INFO [stderr]    3:     0x55e1a6f0febd - std::panicking::default_hook::h4eae6f26f73244c8
Dec 06 20:07:56.908 INFO [stderr]                                at src/libstd/panicking.rs:227
Dec 06 20:07:56.908 INFO [stderr]    4:     0x55e1a6f10860 - std::panicking::rust_panic_with_hook::h368d37fd53b59464
Dec 06 20:07:56.908 INFO [stderr]                                at src/libstd/panicking.rs:491
Dec 06 20:07:56.908 INFO [stderr]    5:     0x55e1a6eff867 - std::panicking::begin_panic::h94f4189a5eb9b44a
Dec 06 20:07:56.908 INFO [stderr]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:425
Dec 06 20:07:56.908 INFO [stderr]    6:     0x55e1a6eb61ec - timebomb::child_panics::{{closure}}::hf6a919f0a6b0feb4
Dec 06 20:07:56.909 INFO [stderr]                                at src/lib.rs:63
Dec 06 20:07:56.909 INFO [stderr]    7:     0x55e1a6eb6015 - timebomb::timeout_ms::{{closure}}::h81dd847994e13a75
Dec 06 20:07:56.909 INFO [stderr]                                at src/lib.rs:28
Dec 06 20:07:56.909 INFO [stderr]    8:     0x55e1a6eb4f3a - std::sys_common::backtrace::__rust_begin_short_backtrace::h97c083830c66fc53
Dec 06 20:07:56.909 INFO [stderr]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136
Dec 06 20:07:56.909 INFO [stderr]    9:     0x55e1a6eb2d5c - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h637b32342c6ac061
Dec 06 20:07:56.909 INFO [stderr]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477
Dec 06 20:07:56.909 INFO [stderr]   10:     0x55e1a6eb3fdc - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h072da965f368020a
Dec 06 20:07:56.909 INFO [stderr]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319
Dec 06 20:07:56.909 INFO [stderr]   11:     0x55e1a6eb540f - std::panicking::try::do_call::h204862e0779fd934
Dec 06 20:07:56.909 INFO [stderr]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310
Dec 06 20:07:56.909 INFO [stderr]   12:     0x55e1a6f1ef09 - __rust_maybe_catch_panic
Dec 06 20:07:56.909 INFO [stderr]                                at src/libpanic_unwind/lib.rs:102
Dec 06 20:07:56.909 INFO [stderr]   13:     0x55e1a6eb5152 - std::panicking::try::ha3befb18f25f1760
Dec 06 20:07:56.909 INFO [stderr]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289
Dec 06 20:07:56.909 INFO [stderr]   14:     0x55e1a6eb40ec - std::panic::catch_unwind::hb4c14e16f39748f0
Dec 06 20:07:56.909 INFO [stderr]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398
Dec 06 20:07:56.909 INFO [stderr]   15:     0x55e1a6eb2b69 - std::thread::Builder::spawn_unchecked::{{closure}}::h80988b8ee29c8dd9
Dec 06 20:07:56.909 INFO [stderr]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476
Dec 06 20:07:56.909 INFO [stderr]   16:     0x55e1a6eb3016 - <F as alloc::boxed::FnBox<A>>::call_box::h0f30e4561945dd4e
Dec 06 20:07:56.909 INFO [stderr]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673
Dec 06 20:07:56.909 INFO [stderr]   17:     0x55e1a6f12e2d - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd
Dec 06 20:07:56.909 INFO [stderr]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683
Dec 06 20:07:56.909 INFO [stderr]                                at src/libstd/sys_common/thread.rs:24
Dec 06 20:07:56.909 INFO [stderr]                                at src/libstd/sys/unix/thread.rs:90
Dec 06 20:07:56.909 INFO [stderr]   18:     0x7fb031f8a6b9 - start_thread
Dec 06 20:07:56.909 INFO [stderr]   19:     0x7fb031aaa41c - clone
Dec 06 20:07:56.909 INFO [stderr]   20:                0x0 - <unknown>
Dec 06 20:07:56.940 INFO [stdout] test child_panics ... ok
Dec 06 20:07:56.940 INFO [stdout] test timeout_ms_spin ... ok
Dec 06 20:07:56.940 INFO [stdout] 
Dec 06 20:07:56.940 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:07:56.940 INFO [stdout] 
Dec 06 20:07:56.944 INFO [stderr]    Doc-tests timebomb
Dec 06 20:07:58.152 INFO [stdout] 
Dec 06 20:07:58.152 INFO [stdout] running 0 tests
Dec 06 20:07:58.152 INFO [stdout] 
Dec 06 20:07:58.152 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:07:58.152 INFO [stdout] 
Dec 06 20:07:58.169 INFO [stderr] su: No module specific data is present
Dec 06 20:07:59.327 INFO running `"docker" "inspect" "4af30d1c6e9b3e9c400c17ab606941539b70e23b2ea8abe3a62a0410f2abad06"`
Dec 06 20:07:59.630 INFO running `"docker" "rm" "-f" "4af30d1c6e9b3e9c400c17ab606941539b70e23b2ea8abe3a62a0410f2abad06"`
Dec 06 20:08:00.020 INFO [stdout] 4af30d1c6e9b3e9c400c17ab606941539b70e23b2ea8abe3a62a0410f2abad06