Oct 12 01:40:28.216 INFO testing desync-0.2.3 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling
Oct 12 01:40:28.216 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-0/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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 12 01:40:28.396 INFO blam! 5ce99739022257f665ab0118523033cd238ae828a709eb15243ad761d0b760cc
Oct 12 01:40:28.398 INFO running `"docker" "start" "-a" "5ce99739022257f665ab0118523033cd238ae828a709eb15243ad761d0b760cc"`
Oct 12 01:40:29.098 INFO kablam! usermod: no changes
Oct 12 01:40:29.135 INFO kablam!    Compiling desync v0.2.3 (/source)
Oct 12 01:40:31.025 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 1.90s
Oct 12 01:40:31.033 INFO kablam! su: No module specific data is present
Oct 12 01:40:31.841 INFO running `"docker" "rm" "-f" "5ce99739022257f665ab0118523033cd238ae828a709eb15243ad761d0b760cc"`
Oct 12 01:40:32.152 INFO blam! 5ce99739022257f665ab0118523033cd238ae828a709eb15243ad761d0b760cc
Oct 12 01:40:32.162 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-0/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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 12 01:40:32.609 INFO blam! 393a26d8a549cc8dc4bf7b021e118c96333c3e92337f2fece88ba805aa036781
Oct 12 01:40:32.616 INFO running `"docker" "start" "-a" "393a26d8a549cc8dc4bf7b021e118c96333c3e92337f2fece88ba805aa036781"`
Oct 12 01:40:33.792 INFO kablam! usermod: no changes
Oct 12 01:40:33.858 INFO kablam!    Compiling desync v0.2.3 (/source)
Oct 12 01:40:45.096 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 11.27s
Oct 12 01:40:45.096 INFO kablam! su: No module specific data is present
Oct 12 01:40:45.698 INFO running `"docker" "rm" "-f" "393a26d8a549cc8dc4bf7b021e118c96333c3e92337f2fece88ba805aa036781"`
Oct 12 01:40:46.005 INFO blam! 393a26d8a549cc8dc4bf7b021e118c96333c3e92337f2fece88ba805aa036781
Oct 12 01:40:46.010 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-0/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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 12 01:40:46.559 INFO blam! 43ca5e63c6b260a5a1afe5e6f7e2cde83ae651afa73cc89310a2bd06682a33c5
Oct 12 01:40:46.564 INFO running `"docker" "start" "-a" "43ca5e63c6b260a5a1afe5e6f7e2cde83ae651afa73cc89310a2bd06682a33c5"`
Oct 12 01:40:47.774 INFO kablam! usermod: no changes
Oct 12 01:40:47.824 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
Oct 12 01:40:47.836 INFO kablam!      Running /target/debug/deps/desync-de7d2ed555c23887
Oct 12 01:40:47.839 INFO blam! 
Oct 12 01:40:47.839 INFO blam! running 0 tests
Oct 12 01:40:47.839 INFO blam! 
Oct 12 01:40:47.839 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 01:40:47.839 INFO blam! 
Oct 12 01:40:47.840 INFO kablam!      Running /target/debug/deps/desync-0a0ad4daddccf9a8
Oct 12 01:40:47.848 INFO blam! 
Oct 12 01:40:47.848 INFO blam! running 27 tests
Oct 12 01:40:47.848 INFO blam! test retrieve_data_synchronously ... ok
Oct 12 01:40:47.848 INFO blam! test scheduler::async::schedule_after_queue_released ... ok
Oct 12 01:40:47.848 INFO blam! test scheduler::async::schedule_async ... ok
Oct 12 01:40:47.848 INFO blam! test retrieve_data_into_local_var ... ok
Oct 12 01:40:47.952 INFO blam! test scheduler::async::will_schedule_separate_queues_in_parallel ... ok
Oct 12 01:40:47.952 INFO blam! test scheduler::async::will_schedule_in_order ... ok
Oct 12 01:40:47.952 INFO blam! test scheduler::future::schedule_future ... ok
Oct 12 01:40:47.956 INFO blam! test scheduler::future::future_waits_for_us ... ok
Oct 12 01:40:47.984 INFO blam! test scheduler::future::wait_for_future ... ok
Oct 12 01:40:48.000 INFO blam! test scheduler::sync::reschedule_after_immediate_sync ... ok
Oct 12 01:40:48.000 INFO blam! test scheduler::sync::schedule_sync ... ok
Oct 12 01:40:48.056 INFO blam! test scheduler::suspend::safe_to_drop_suspended_queue ... ok
Oct 12 01:40:48.056 INFO blam! test scheduler::suspend::suspend_queue_with_local_drain ... ok
Oct 12 01:40:48.056 INFO kablam! thread 'desync jobs thread' panicked at 'assertion failed: core.state == QueueState::Running', src/scheduler.rs:179:13
Oct 12 01:40:48.056 INFO kablam! stack backtrace:
Oct 12 01:40:48.060 INFO blam! test dropping_while_running_isnt_obviously_bad ... ok
Oct 12 01:40:48.080 INFO blam! test scheduler::sync::sync_has_synchronous_lifetime ... ok
Oct 12 01:40:48.098 INFO blam! test scheduler::sync::schedule_sync_after_async ... ok
Oct 12 01:40:48.117 INFO kablam!    0:     0x55caeaf0111e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617
Oct 12 01:40:48.118 INFO blam! test scheduler::thread_management::will_despawn_extra_threads ... ok
Oct 12 01:40:48.136 INFO kablam!                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Oct 12 01:40:48.136 INFO kablam!    1:     0x55caeaf09fc6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9
Oct 12 01:40:48.136 INFO kablam!                                at libstd/sys_common/backtrace.rs:71
Oct 12 01:40:48.136 INFO kablam!                                at libstd/sys_common/backtrace.rs:59
Oct 12 01:40:48.136 INFO kablam!    2:     0x55caeaf04d1d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480
Oct 12 01:40:48.136 INFO kablam!                                at libstd/panicking.rs:211
Oct 12 01:40:48.136 INFO kablam!    3:     0x55caeaf04a90 - std::panicking::default_hook::h1ef46fa7cd894809
Oct 12 01:40:48.136 INFO kablam!                                at libstd/panicking.rs:227
Oct 12 01:40:48.136 INFO kablam!    4:     0x55caeaf053cc - std::panicking::rust_panic_with_hook::h05510fde8841c579
Oct 12 01:40:48.136 INFO kablam!                                at libstd/panicking.rs:476
Oct 12 01:40:48.136 INFO kablam!    5:     0x55caeaee649f - std::panicking::begin_panic::h88762817eea915d0
Oct 12 01:40:48.136 INFO kablam!                                at libstd/panicking.rs:410
Oct 12 01:40:48.136 INFO kablam!    6:     0x55caeaeca04d - desync::scheduler::JobQueue::dequeue::hdf1aca19bf79df19
Oct 12 01:40:48.136 INFO kablam!                                at src/scheduler.rs:179
Oct 12 01:40:48.136 INFO kablam!    7:     0x55caeaeca1c9 - desync::scheduler::JobQueue::drain::h789ddcb38e0ef027
Oct 12 01:40:48.136 INFO kablam!                                at src/scheduler.rs:193
Oct 12 01:40:48.137 INFO kablam!    8:     0x55caeaecba76 - desync::scheduler::Scheduler::schedule_thread::{{closure}}::h19671bccc1896e29
Oct 12 01:40:48.137 INFO kablam!                                at src/scheduler.rs:381
Oct 12 01:40:48.137 INFO kablam!    9:     0x55caeaecb5a1 - desync::scheduler::Scheduler::schedule_dormant::{{closure}}::h036a7c6c4f44a85a
Oct 12 01:40:48.137 INFO kablam!                                at src/scheduler.rs:338
Oct 12 01:40:48.137 INFO kablam!   10:     0x55caeaec41a4 - <desync::job::Job<TFn> as desync::job::ScheduledJob>::run::h999652dda0443edc
Oct 12 01:40:48.137 INFO kablam!                                at src/job.rs:31
Oct 12 01:40:48.137 INFO kablam!   11:     0x55caeaec451a - desync::scheduler_thread::SchedulerThread::new::{{closure}}::h34581adc94cb68fa
Oct 12 01:40:48.137 INFO kablam!                                at src/scheduler_thread.rs:28
Oct 12 01:40:48.137 INFO kablam!   12:     0x55caeaed366a - std::sys_common::backtrace::__rust_begin_short_backtrace::h0a40bed13525df8f
Oct 12 01:40:48.137 INFO kablam!                                at libstd/sys_common/backtrace.rs:136
Oct 12 01:40:48.137 INFO kablam!   13:     0x55caeaec06fc - std::thread::Builder::spawn::{{closure}}::{{closure}}::h42e8c5f1e84c3b82
Oct 12 01:40:48.142 INFO kablam!                                at libstd/thread/mod.rs:409
Oct 12 01:40:48.142 INFO kablam!   14:     0x55caeaec46dc - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h000544153782e46c
Oct 12 01:40:48.142 INFO kablam!                                at libstd/panic.rs:313
Oct 12 01:40:48.142 INFO kablam!   15:     0x55caeaec2b5f - std::panicking::try::do_call::hae9e7f21f5b56dd3
Oct 12 01:40:48.142 INFO kablam!                                at libstd/panicking.rs:310
Oct 12 01:40:48.142 INFO kablam!   16:     0x55caeaf15199 - __rust_maybe_catch_panic
Oct 12 01:40:48.142 INFO kablam!                                at libpanic_unwind/lib.rs:102
Oct 12 01:40:48.142 INFO kablam!   17:     0x55caeaec2a84 - std::panicking::try::h314310a045e8a169
Oct 12 01:40:48.142 INFO kablam!                                at libstd/panicking.rs:289
Oct 12 01:40:48.142 INFO kablam!   18:     0x55caeaec50ec - std::panic::catch_unwind::hff907e078ee6fe24
Oct 12 01:40:48.142 INFO kablam!                                at libstd/panic.rs:392
Oct 12 01:40:48.142 INFO kablam!   19:     0x55caeaec0510 - std::thread::Builder::spawn::{{closure}}::h67c08c3415c672aa
Oct 12 01:40:48.142 INFO kablam!                                at libstd/thread/mod.rs:408
Oct 12 01:40:48.142 INFO kablam!   20:     0x55caeaec2076 - <F as alloc::boxed::FnBox<A>>::call_box::hb40419ce4194cb52
Oct 12 01:40:48.142 INFO kablam!                                at liballoc/boxed.rs:672
Oct 12 01:40:48.142 INFO kablam!   21:     0x55caeaf0315a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1
Oct 12 01:40:48.142 INFO kablam!                                at liballoc/boxed.rs:682
Oct 12 01:40:48.142 INFO kablam!                                at libstd/sys_common/thread.rs:24
Oct 12 01:40:48.142 INFO kablam!   22:     0x55caeaef8605 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886
Oct 12 01:40:48.142 INFO kablam!                                at libstd/sys/unix/thread.rs:90
Oct 12 01:40:48.142 INFO kablam!   23:     0x7f91700be6b9 - start_thread
Oct 12 01:40:48.142 INFO kablam!   24:     0x7f916fbde41c - clone
Oct 12 01:40:48.142 INFO kablam!   25:                0x0 - <unknown>
Oct 12 01:40:48.154 INFO blam! test scheduler::sync::sync_drains_with_no_threads ... ok
Oct 12 01:40:48.200 INFO blam! test update_data_asynchronously ... ok
Oct 12 01:40:48.248 INFO blam! test update_data_with_future ... ok
Oct 12 01:40:48.356 INFO blam! test wait_for_future ... ok
Oct 12 01:40:52.449 INFO blam! test update_data_with_future_1000_times ... ok
Oct 12 01:40:52.481 INFO blam! test scheduler::async::async_only_runs_once ... ok
Oct 12 01:40:52.584 INFO blam! test scheduler::suspend::resume_before_suspend ... ok
Oct 12 01:40:52.625 INFO blam! test update_data_asynchronously_1000_times ... ok
Oct 12 01:40:53.580 INFO blam! test scheduler::async::async_runs_in_order_1000_iter ... ok
Oct 12 01:40:55.585 INFO blam! test scheduler::suspend::suspend_queue ... ok
Oct 12 01:40:55.585 INFO blam! 
Oct 12 01:40:55.585 INFO blam! test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 01:40:55.585 INFO blam! 
Oct 12 01:40:55.588 INFO kablam!      Running /target/debug/deps/pipe-03a20effe657c029
Oct 12 01:40:55.590 INFO blam! 
Oct 12 01:40:55.590 INFO blam! running 5 tests
Oct 12 01:40:55.592 INFO blam! test pipe_through_stream_closes ... ok
Oct 12 01:40:55.592 INFO blam! test pipe_through ... ok
Oct 12 01:40:55.601 INFO blam! test pipe_in_simple_stream ... ok
Oct 12 01:40:55.602 INFO blam! test pipe_in_mpsc_receiver ... ok
Oct 12 01:40:55.612 INFO blam! test pipe_through_produces_backpressure ... ok
Oct 12 01:40:55.613 INFO blam! 
Oct 12 01:40:55.613 INFO blam! test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 01:40:55.613 INFO blam! 
Oct 12 01:40:55.614 INFO kablam!    Doc-tests desync
Oct 12 01:40:56.572 INFO blam! 
Oct 12 01:40:56.572 INFO blam! running 9 tests
Oct 12 01:41:00.115 INFO blam! test src/lib.rs -  (line 11) ... ok
Oct 12 01:41:00.964 INFO blam! test src/lib.rs -  (line 20) ... ok
Oct 12 01:41:01.545 INFO blam! test src/pipe.rs - pipe (line 20) ... ok
Oct 12 01:41:02.200 INFO blam! test src/scheduler.rs - scheduler (line 19) ... ok
Oct 12 01:41:02.924 INFO blam! test src/lib.rs -  (line 37) ... ok
Oct 12 01:41:03.036 INFO blam! test src/lib.rs -  (line 60) ... ok
Oct 12 01:41:03.149 INFO blam! test src/pipe.rs - pipe::pipe (line 164) ... ok
Oct 12 01:41:03.192 INFO blam! test src/scheduler.rs - scheduler (line 33) ... ok
Oct 12 01:41:03.955 INFO blam! test src/scheduler.rs - scheduler (line 9) ... ok
Oct 12 01:41:03.955 INFO blam! 
Oct 12 01:41:03.955 INFO blam! test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 01:41:03.955 INFO blam! 
Oct 12 01:41:03.968 INFO kablam! su: No module specific data is present
Oct 12 01:41:04.301 INFO running `"docker" "rm" "-f" "43ca5e63c6b260a5a1afe5e6f7e2cde83ae651afa73cc89310a2bd06682a33c5"`
Oct 12 01:41:04.438 INFO blam! 43ca5e63c6b260a5a1afe5e6f7e2cde83ae651afa73cc89310a2bd06682a33c5