Oct 15 16:30:14.110 INFO testing timekeeper-0.3.0 against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling-1
Oct 15 16:30:14.110 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-0/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 15 16:30:14.535 INFO blam! 2c5d0a54607c97b6516b650ea3a20701c88d824c98cb4569cf13e06fc35d5964
Oct 15 16:30:14.540 INFO running `"docker" "start" "-a" "2c5d0a54607c97b6516b650ea3a20701c88d824c98cb4569cf13e06fc35d5964"`
Oct 15 16:30:15.739 INFO kablam! usermod: no changes
Oct 15 16:30:15.783 INFO kablam!    Compiling timekeeper v0.3.0 (/source)
Oct 15 16:30:16.404 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.64s
Oct 15 16:30:16.407 INFO kablam! su: No module specific data is present
Oct 15 16:30:17.463 INFO running `"docker" "rm" "-f" "2c5d0a54607c97b6516b650ea3a20701c88d824c98cb4569cf13e06fc35d5964"`
Oct 15 16:30:17.718 INFO blam! 2c5d0a54607c97b6516b650ea3a20701c88d824c98cb4569cf13e06fc35d5964
Oct 15 16:30:17.724 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-0/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 15 16:30:18.167 INFO blam! 56fd553c5df482164a5fb50b23d799489557c4e0b892044923ab9750fc73257a
Oct 15 16:30:18.187 INFO running `"docker" "start" "-a" "56fd553c5df482164a5fb50b23d799489557c4e0b892044923ab9750fc73257a"`
Oct 15 16:30:19.723 INFO kablam! usermod: no changes
Oct 15 16:30:19.783 INFO kablam!    Compiling timekeeper v0.3.0 (/source)
Oct 15 16:30:21.030 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 1.27s
Oct 15 16:30:21.033 INFO kablam! su: No module specific data is present
Oct 15 16:30:21.316 INFO running `"docker" "rm" "-f" "56fd553c5df482164a5fb50b23d799489557c4e0b892044923ab9750fc73257a"`
Oct 15 16:30:21.400 INFO blam! 56fd553c5df482164a5fb50b23d799489557c4e0b892044923ab9750fc73257a
Oct 15 16:30:21.405 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-0/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 15 16:30:21.580 INFO blam! 6eee96cc38484f77572a3cd51338f7c8da541756644dfbe23aa70a1be6ebc12c
Oct 15 16:30:21.584 INFO running `"docker" "start" "-a" "6eee96cc38484f77572a3cd51338f7c8da541756644dfbe23aa70a1be6ebc12c"`
Oct 15 16:30:22.103 INFO kablam! usermod: no changes
Oct 15 16:30:22.167 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Oct 15 16:30:22.167 INFO kablam!      Running /target/debug/deps/timekeeper-4f503249d3343444
Oct 15 16:30:22.175 INFO blam! 
Oct 15 16:30:22.175 INFO blam! running 3 tests
Oct 15 16:30:22.177 INFO blam! test timerset::it_works ... ok
Oct 15 16:30:22.195 INFO blam! test simpletracker::it_works ... ok
Oct 15 16:30:22.271 INFO blam! test source::it_works ... FAILED
Oct 15 16:30:22.271 INFO blam! 
Oct 15 16:30:22.271 INFO blam! failures:
Oct 15 16:30:22.271 INFO blam! 
Oct 15 16:30:22.271 INFO blam! ---- source::it_works stdout ----
Oct 15 16:30:22.271 INFO blam! thread 'source::it_works' panicked at 'assertion failed: load > 0.9 && load < 1.1', src/source.rs:88:5
Oct 15 16:30:22.271 INFO blam! stack backtrace:
Oct 15 16:30:22.271 INFO blam!    0:     0x55f13d35e78e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h7fa1e90165a4b6b7
Oct 15 16:30:22.271 INFO blam!                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Oct 15 16:30:22.272 INFO blam!    1:     0x55f13d367906 - std::sys_common::backtrace::print::hce31971a380b167f
Oct 15 16:30:22.272 INFO blam!                                at libstd/sys_common/backtrace.rs:71
Oct 15 16:30:22.272 INFO blam!                                at libstd/sys_common/backtrace.rs:59
Oct 15 16:30:22.272 INFO blam!    2:     0x55f13d36265d - std::panicking::default_hook::{{closure}}::h9590c1e09d0fb8eb
Oct 15 16:30:22.272 INFO blam!                                at libstd/panicking.rs:211
Oct 15 16:30:22.272 INFO blam!    3:     0x55f13d36236b - std::panicking::default_hook::hb1838a6568eb05e3
Oct 15 16:30:22.272 INFO blam!                                at libstd/panicking.rs:221
Oct 15 16:30:22.272 INFO blam!    4:     0x55f13d362d0c - std::panicking::rust_panic_with_hook::h9ad880ee5fc38368
Oct 15 16:30:22.272 INFO blam!                                at libstd/panicking.rs:476
Oct 15 16:30:22.272 INFO blam!    5:     0x55f13d30c60f - std::panicking::begin_panic::h87933432dc8adcae
Oct 15 16:30:22.272 INFO blam!                                at libstd/panicking.rs:410
Oct 15 16:30:22.272 INFO blam!    6:     0x55f13d3127be - timekeeper::source::it_works::h66d354af1ec3c51a
Oct 15 16:30:22.272 INFO blam!                                at src/source.rs:88
Oct 15 16:30:22.272 INFO blam!    7:     0x55f13d312589 - timekeeper::source::it_works::{{closure}}::h02ceade672e73039
Oct 15 16:30:22.272 INFO blam!                                at src/source.rs:62
Oct 15 16:30:22.272 INFO blam!    8:     0x55f13d30c9ed - core::ops::function::FnOnce::call_once::ha7250ef6520cf01f
Oct 15 16:30:22.272 INFO blam!                                at libcore/ops/function.rs:238
Oct 15 16:30:22.272 INFO blam!    9:     0x55f13d315a7e - <F as alloc::boxed::FnBox<A>>::call_box::hae226a42c8d94b19
Oct 15 16:30:22.272 INFO blam!                                at libtest/lib.rs:1468
Oct 15 16:30:22.272 INFO blam!                                at libcore/ops/function.rs:238
Oct 15 16:30:22.272 INFO blam!                                at liballoc/boxed.rs:672
Oct 15 16:30:22.272 INFO blam!   10:     0x55f13d372e29 - __rust_maybe_catch_panic
Oct 15 16:30:22.272 INFO blam!                                at libpanic_unwind/lib.rs:102
Oct 15 16:30:22.272 INFO blam!   11:     0x55f13d3364ad - std::sys_common::backtrace::__rust_begin_short_backtrace::ha5325a24fd096595
Oct 15 16:30:22.272 INFO blam!                                at libstd/panicking.rs:289
Oct 15 16:30:22.272 INFO blam!                                at libstd/panic.rs:392
Oct 15 16:30:22.272 INFO blam!                                at libtest/lib.rs:1423
Oct 15 16:30:22.272 INFO blam!                                at libstd/sys_common/backtrace.rs:136
Oct 15 16:30:22.272 INFO blam!   12:     0x55f13d337054 - std::panicking::try::do_call::h2c632c17829d0621
Oct 15 16:30:22.272 INFO blam!                                at libstd/thread/mod.rs:409
Oct 15 16:30:22.272 INFO blam!                                at libstd/panic.rs:313
Oct 15 16:30:22.272 INFO blam!                                at libstd/panicking.rs:310
Oct 15 16:30:22.272 INFO blam!   13:     0x55f13d372e29 - __rust_maybe_catch_panic
Oct 15 16:30:22.272 INFO blam!                                at libpanic_unwind/lib.rs:102
Oct 15 16:30:22.272 INFO blam!   14:     0x55f13d324696 - <F as alloc::boxed::FnBox<A>>::call_box::h1a0832645645f090
Oct 15 16:30:22.272 INFO blam!                                at libstd/panicking.rs:289
Oct 15 16:30:22.272 INFO blam!                                at libstd/panic.rs:392
Oct 15 16:30:22.272 INFO blam!                                at libstd/thread/mod.rs:408
Oct 15 16:30:22.272 INFO blam!                                at liballoc/boxed.rs:672
Oct 15 16:30:22.272 INFO blam!   15:     0x55f13d360a9a - std::sys_common::thread::start_thread::h49b8ca61f624f031
Oct 15 16:30:22.272 INFO blam!                                at liballoc/boxed.rs:682
Oct 15 16:30:22.272 INFO blam!                                at libstd/sys_common/thread.rs:24
Oct 15 16:30:22.272 INFO blam!   16:     0x55f13d355eb5 - std::sys::unix::thread::Thread::new::thread_start::hc999bd1fb8f071a1
Oct 15 16:30:22.272 INFO blam!                                at libstd/sys/unix/thread.rs:90
Oct 15 16:30:22.272 INFO blam!   17:     0x7fd752d126b9 - start_thread
Oct 15 16:30:22.272 INFO blam!   18:     0x7fd75283241c - clone
Oct 15 16:30:22.272 INFO blam!   19:                0x0 - <unknown>
Oct 15 16:30:22.272 INFO blam! 
Oct 15 16:30:22.272 INFO blam! 
Oct 15 16:30:22.272 INFO blam! failures:
Oct 15 16:30:22.272 INFO blam!     source::it_works
Oct 15 16:30:22.272 INFO blam! 
Oct 15 16:30:22.272 INFO blam! test result: FAILED. 2 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Oct 15 16:30:22.272 INFO blam! 
Oct 15 16:30:22.283 INFO kablam! error: test failed, to rerun pass '--lib'
Oct 15 16:30:22.283 INFO kablam! su: No module specific data is present
Oct 15 16:30:23.307 INFO running `"docker" "rm" "-f" "6eee96cc38484f77572a3cd51338f7c8da541756644dfbe23aa70a1be6ebc12c"`
Oct 15 16:30:23.591 INFO blam! 6eee96cc38484f77572a3cd51338f7c8da541756644dfbe23aa70a1be6ebc12c