Oct 16 13:27:11.899 INFO testing desync-0.2.3 against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling-1
Oct 16 13:27:11.899 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-7/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/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 16 13:27:12.132 INFO blam! 542d6258c9bfdee626758e4e0244663e4cc5ef07e450d0717b2606ff63de45a7
Oct 16 13:27:12.134 INFO running `"docker" "start" "-a" "542d6258c9bfdee626758e4e0244663e4cc5ef07e450d0717b2606ff63de45a7"`
Oct 16 13:27:12.624 INFO kablam! usermod: no changes
Oct 16 13:27:12.662 INFO kablam!    Compiling desync v0.2.3 (/source)
Oct 16 13:27:15.148 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 2.50s
Oct 16 13:27:15.151 INFO kablam! su: No module specific data is present
Oct 16 13:27:15.899 INFO running `"docker" "rm" "-f" "542d6258c9bfdee626758e4e0244663e4cc5ef07e450d0717b2606ff63de45a7"`
Oct 16 13:27:16.131 INFO blam! 542d6258c9bfdee626758e4e0244663e4cc5ef07e450d0717b2606ff63de45a7
Oct 16 13:27:16.136 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-7/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/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 16 13:27:16.549 INFO blam! 7eba1c37f185115b4592a652e05d73042c3ccfa6bd7c4bb6f949732a079b7e6f
Oct 16 13:27:16.549 INFO running `"docker" "start" "-a" "7eba1c37f185115b4592a652e05d73042c3ccfa6bd7c4bb6f949732a079b7e6f"`
Oct 16 13:27:17.603 INFO kablam! usermod: no changes
Oct 16 13:27:17.675 INFO kablam!    Compiling desync v0.2.3 (/source)
Oct 16 13:27:25.871 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 8.24s
Oct 16 13:27:25.875 INFO kablam! su: No module specific data is present
Oct 16 13:27:26.416 INFO running `"docker" "rm" "-f" "7eba1c37f185115b4592a652e05d73042c3ccfa6bd7c4bb6f949732a079b7e6f"`
Oct 16 13:27:26.735 INFO blam! 7eba1c37f185115b4592a652e05d73042c3ccfa6bd7c4bb6f949732a079b7e6f
Oct 16 13:27:26.747 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-7/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/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 16 13:27:27.103 INFO blam! bac9d17466bb39a58d413a44140f9af88f2881372afd2ae6634610736a23c5c7
Oct 16 13:27:27.106 INFO running `"docker" "start" "-a" "bac9d17466bb39a58d413a44140f9af88f2881372afd2ae6634610736a23c5c7"`
Oct 16 13:27:28.107 INFO kablam! usermod: no changes
Oct 16 13:27:28.156 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Oct 16 13:27:28.156 INFO kablam!      Running /target/debug/deps/desync-3fb2a5a70ddf127a
Oct 16 13:27:28.163 INFO kablam!      Running /target/debug/deps/desync-b7dfa4ac13da20d1
Oct 16 13:27:28.163 INFO blam! 
Oct 16 13:27:28.163 INFO blam! running 0 tests
Oct 16 13:27:28.163 INFO blam! 
Oct 16 13:27:28.163 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 13:27:28.163 INFO blam! 
Oct 16 13:27:28.165 INFO blam! 
Oct 16 13:27:28.165 INFO blam! running 27 tests
Oct 16 13:27:28.176 INFO blam! test retrieve_data_synchronously ... ok
Oct 16 13:27:28.177 INFO blam! test retrieve_data_into_local_var ... ok
Oct 16 13:27:28.187 INFO blam! test scheduler::async::schedule_after_queue_released ... ok
Oct 16 13:27:28.199 INFO blam! test scheduler::async::schedule_async ... ok
Oct 16 13:27:28.292 INFO blam! test scheduler::async::will_schedule_separate_queues_in_parallel ... ok
Oct 16 13:27:28.292 INFO blam! test scheduler::async::will_schedule_in_order ... ok
Oct 16 13:27:28.301 INFO blam! test scheduler::suspend::safe_to_drop_suspended_queue ... ok
Oct 16 13:27:28.311 INFO blam! test scheduler::future::wait_for_future ... ok
Oct 16 13:27:28.335 INFO blam! test scheduler::future::schedule_future ... ok
Oct 16 13:27:28.339 INFO blam! test scheduler::sync::reschedule_after_immediate_sync ... ok
Oct 16 13:27:28.339 INFO blam! test scheduler::sync::schedule_sync ... ok
Oct 16 13:27:28.376 INFO blam! test scheduler::future::future_waits_for_us ... ok
Oct 16 13:27:28.380 INFO blam! test dropping_while_running_isnt_obviously_bad ... ok
Oct 16 13:27:28.380 INFO blam! test scheduler::sync::sync_has_synchronous_lifetime ... ok
Oct 16 13:27:28.395 INFO blam! test scheduler::thread_management::will_despawn_extra_threads ... ok
Oct 16 13:27:28.418 INFO blam! test scheduler::suspend::suspend_queue_with_local_drain ... ok
Oct 16 13:27:28.418 INFO kablam! thread 'desync jobs thread' panicked at 'assertion failed: core.state == QueueState::Running', src/scheduler.rs:179:13
Oct 16 13:27:28.418 INFO kablam! stack backtrace:
Oct 16 13:27:28.451 INFO blam! test scheduler::sync::schedule_sync_after_async ... ok
Oct 16 13:27:28.475 INFO kablam!    0:     0x56543d98011e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h7fa1e90165a4b6b7
Oct 16 13:27:28.476 INFO kablam!                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Oct 16 13:27:28.476 INFO kablam!    1:     0x56543d989296 - std::sys_common::backtrace::print::hce31971a380b167f
Oct 16 13:27:28.476 INFO kablam!                                at libstd/sys_common/backtrace.rs:71
Oct 16 13:27:28.477 INFO kablam!                                at libstd/sys_common/backtrace.rs:59
Oct 16 13:27:28.477 INFO kablam!    2:     0x56543d983fed - std::panicking::default_hook::{{closure}}::h9590c1e09d0fb8eb
Oct 16 13:27:28.477 INFO kablam!                                at libstd/panicking.rs:211
Oct 16 13:27:28.477 INFO kablam!    3:     0x56543d983d60 - std::panicking::default_hook::hb1838a6568eb05e3
Oct 16 13:27:28.478 INFO kablam!                                at libstd/panicking.rs:227
Oct 16 13:27:28.478 INFO kablam!    4:     0x56543d98469c - std::panicking::rust_panic_with_hook::h9ad880ee5fc38368
Oct 16 13:27:28.478 INFO kablam!                                at libstd/panicking.rs:476
Oct 16 13:27:28.478 INFO kablam!    5:     0x56543d96d16f - std::panicking::begin_panic::h516e2f215145d3b3
Oct 16 13:27:28.479 INFO kablam!                                at libstd/panicking.rs:410
Oct 16 13:27:28.479 INFO kablam!    6:     0x56543d949f2d - desync::scheduler::JobQueue::dequeue::h9be9f87044fa929a
Oct 16 13:27:28.479 INFO kablam!                                at src/scheduler.rs:179
Oct 16 13:27:28.480 INFO kablam!    7:     0x56543d94a0a9 - desync::scheduler::JobQueue::drain::heab86d1d52291f57
Oct 16 13:27:28.480 INFO kablam!                                at src/scheduler.rs:193
Oct 16 13:27:28.481 INFO kablam!    8:     0x56543d94b956 - desync::scheduler::Scheduler::schedule_thread::{{closure}}::h161f4e46facc8b18
Oct 16 13:27:28.481 INFO kablam!                                at src/scheduler.rs:381
Oct 16 13:27:28.481 INFO kablam!    9:     0x56543d94b481 - desync::scheduler::Scheduler::schedule_dormant::{{closure}}::h5fd580563758759d
Oct 16 13:27:28.481 INFO kablam!                                at src/scheduler.rs:338
Oct 16 13:27:28.482 INFO kablam!   10:     0x56543d943f54 - <desync::job::Job<TFn> as desync::job::ScheduledJob>::run::h70cfd343fac5a7ee
Oct 16 13:27:28.482 INFO kablam!                                at src/job.rs:31
Oct 16 13:27:28.482 INFO kablam!   11:     0x56543d9443fa - desync::scheduler_thread::SchedulerThread::new::{{closure}}::h158118e060303ace
Oct 16 13:27:28.483 INFO kablam!                                at src/scheduler_thread.rs:28
Oct 16 13:27:28.483 INFO kablam!   12:     0x56543d952e4a - std::sys_common::backtrace::__rust_begin_short_backtrace::h1aa3a8f6d3c7ae78
Oct 16 13:27:28.483 INFO kablam!                                at libstd/sys_common/backtrace.rs:136
Oct 16 13:27:28.483 INFO kablam!   13:     0x56543d9405dc - std::thread::Builder::spawn::{{closure}}::{{closure}}::h617dff839fb5645b
Oct 16 13:27:28.484 INFO kablam!                                at libstd/thread/mod.rs:409
Oct 16 13:27:28.484 INFO kablam!   14:     0x56543d9445bc - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h1261fcdc8116dc4e
Oct 16 13:27:28.490 INFO kablam!                                at libstd/panic.rs:313
Oct 16 13:27:28.490 INFO kablam!   15:     0x56543d942a3f - std::panicking::try::do_call::h3566ba89b38d823d
Oct 16 13:27:28.490 INFO kablam!                                at libstd/panicking.rs:310
Oct 16 13:27:28.490 INFO kablam!   16:     0x56543d9947b9 - __rust_maybe_catch_panic
Oct 16 13:27:28.490 INFO kablam!                                at libpanic_unwind/lib.rs:102
Oct 16 13:27:28.490 INFO kablam!   17:     0x56543d942964 - std::panicking::try::h220074245bb4feaf
Oct 16 13:27:28.490 INFO kablam!                                at libstd/panicking.rs:289
Oct 16 13:27:28.490 INFO kablam!   18:     0x56543d944fcc - std::panic::catch_unwind::h8ecb0645e7dbe0ce
Oct 16 13:27:28.490 INFO kablam!                                at libstd/panic.rs:392
Oct 16 13:27:28.490 INFO kablam!   19:     0x56543d9403f0 - std::thread::Builder::spawn::{{closure}}::h4990c306c5081b84
Oct 16 13:27:28.490 INFO kablam!                                at libstd/thread/mod.rs:408
Oct 16 13:27:28.490 INFO kablam!   20:     0x56543d941f56 - <F as alloc::boxed::FnBox<A>>::call_box::hb04233d318277a04
Oct 16 13:27:28.490 INFO kablam!                                at liballoc/boxed.rs:672
Oct 16 13:27:28.490 INFO kablam!   21:     0x56543d98242a - std::sys_common::thread::start_thread::h49b8ca61f624f031
Oct 16 13:27:28.490 INFO kablam!                                at liballoc/boxed.rs:682
Oct 16 13:27:28.490 INFO kablam!                                at libstd/sys_common/thread.rs:24
Oct 16 13:27:28.490 INFO kablam!   22:     0x56543d9775f5 - std::sys::unix::thread::Thread::new::thread_start::hc999bd1fb8f071a1
Oct 16 13:27:28.490 INFO kablam!                                at libstd/sys/unix/thread.rs:90
Oct 16 13:27:28.490 INFO kablam!   23:     0x7fe8439576b9 - start_thread
Oct 16 13:27:28.490 INFO kablam!   24:     0x7fe84347741c - clone
Oct 16 13:27:28.490 INFO kablam!   25:                0x0 - <unknown>
Oct 16 13:27:28.503 INFO blam! test update_data_asynchronously ... ok
Oct 16 13:27:28.509 INFO blam! test scheduler::sync::sync_drains_with_no_threads ... ok
Oct 16 13:27:28.563 INFO blam! test update_data_with_future ... ok
Oct 16 13:27:28.670 INFO blam! test wait_for_future ... ok
Oct 16 13:27:31.887 INFO blam! test update_data_asynchronously_1000_times ... ok
Oct 16 13:27:32.631 INFO blam! test scheduler::async::async_only_runs_once ... ok
Oct 16 13:27:33.523 INFO blam! test scheduler::async::async_runs_in_order_1000_iter ... ok
Oct 16 13:27:33.639 INFO blam! test scheduler::suspend::resume_before_suspend ... ok
Oct 16 13:27:33.710 INFO blam! test update_data_with_future_1000_times ... ok
Oct 16 13:27:37.055 INFO blam! test scheduler::suspend::suspend_queue ... ok
Oct 16 13:27:37.055 INFO blam! 
Oct 16 13:27:37.056 INFO blam! test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 13:27:37.056 INFO blam! 
Oct 16 13:27:37.061 INFO kablam!      Running /target/debug/deps/pipe-3948b3caa81831a4
Oct 16 13:27:37.068 INFO blam! 
Oct 16 13:27:37.068 INFO blam! running 5 tests
Oct 16 13:27:37.070 INFO blam! test pipe_through_stream_closes ... ok
Oct 16 13:27:37.075 INFO blam! test pipe_through ... ok
Oct 16 13:27:37.080 INFO blam! test pipe_in_simple_stream ... ok
Oct 16 13:27:37.081 INFO blam! test pipe_in_mpsc_receiver ... ok
Oct 16 13:27:37.095 INFO blam! test pipe_through_produces_backpressure ... ok
Oct 16 13:27:37.095 INFO blam! 
Oct 16 13:27:37.095 INFO blam! test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 13:27:37.095 INFO blam! 
Oct 16 13:27:37.103 INFO kablam!    Doc-tests desync
Oct 16 13:27:38.314 INFO blam! 
Oct 16 13:27:38.314 INFO blam! running 9 tests
Oct 16 13:27:44.683 INFO blam! test src/scheduler.rs - scheduler (line 19) ... ok
Oct 16 13:27:45.060 INFO blam! test src/scheduler.rs - scheduler (line 33) ... ok
Oct 16 13:27:47.042 INFO blam! test src/lib.rs -  (line 37) ... ok
Oct 16 13:27:48.376 INFO blam! test src/pipe.rs - pipe::pipe (line 164) ... ok
Oct 16 13:27:48.763 INFO blam! test src/lib.rs -  (line 60) ... ok
Oct 16 13:27:48.763 INFO blam! test src/lib.rs -  (line 20) ... ok
Oct 16 13:27:49.166 INFO blam! test src/lib.rs -  (line 11) ... ok
Oct 16 13:27:49.557 INFO blam! test src/pipe.rs - pipe (line 20) ... ok
Oct 16 13:27:50.271 INFO blam! test src/scheduler.rs - scheduler (line 9) ... ok
Oct 16 13:27:50.271 INFO blam! 
Oct 16 13:27:50.271 INFO blam! test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 16 13:27:50.271 INFO blam! 
Oct 16 13:27:50.279 INFO kablam! su: No module specific data is present
Oct 16 13:27:50.911 INFO running `"docker" "rm" "-f" "bac9d17466bb39a58d413a44140f9af88f2881372afd2ae6634610736a23c5c7"`
Oct 16 13:27:51.143 INFO blam! bac9d17466bb39a58d413a44140f9af88f2881372afd2ae6634610736a23c5c7