Nov 02 12:14:11.883 INFO testing mio-st-0.1.0 against beta-2018-10-30 for beta-1.31-1
Nov 02 12:14:11.883 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-1/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 02 12:14:12.268 INFO blam! 49e2898e4378d387c6b220f2d5ccd3457625d87fd89f38ec5fe085ad056da99e
Nov 02 12:14:12.279 INFO running `"docker" "start" "-a" "49e2898e4378d387c6b220f2d5ccd3457625d87fd89f38ec5fe085ad056da99e"`
Nov 02 12:14:13.359 INFO kablam! usermod: no changes
Nov 02 12:14:13.444 INFO kablam!    Compiling arrayvec v0.4.7
Nov 02 12:14:14.280 INFO kablam!    Compiling mio-st v0.1.0 (/source)
Nov 02 12:14:14.987 INFO kablam! warning: unused import: `self::id::INVALID_EVENTED_ID`
Nov 02 12:14:14.987 INFO kablam!   --> src/event/mod.rs:13:16
Nov 02 12:14:14.987 INFO kablam!    |
Nov 02 12:14:14.987 INFO kablam! 13 | pub(crate) use self::id::INVALID_EVENTED_ID;
Nov 02 12:14:14.987 INFO kablam!    |                ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 02 12:14:14.987 INFO kablam!    |
Nov 02 12:14:14.987 INFO kablam!    = note: #[warn(unused_imports)] on by default
Nov 02 12:14:14.987 INFO kablam! 
Nov 02 12:14:15.705 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 2.32s
Nov 02 12:14:15.708 INFO kablam! su: No module specific data is present
Nov 02 12:14:15.911 INFO running `"docker" "rm" "-f" "49e2898e4378d387c6b220f2d5ccd3457625d87fd89f38ec5fe085ad056da99e"`
Nov 02 12:14:16.019 INFO blam! 49e2898e4378d387c6b220f2d5ccd3457625d87fd89f38ec5fe085ad056da99e
Nov 02 12:14:16.021 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-1/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 02 12:14:16.216 INFO blam! 92999a087b8498d4636f19009b7b6e4f3caec2afd377df8b0d7a91544f8ab24a
Nov 02 12:14:16.221 INFO running `"docker" "start" "-a" "92999a087b8498d4636f19009b7b6e4f3caec2afd377df8b0d7a91544f8ab24a"`
Nov 02 12:14:16.799 INFO kablam! usermod: no changes
Nov 02 12:14:16.891 INFO kablam!    Compiling mio-st v0.1.0 (/source)
Nov 02 12:14:17.699 INFO kablam! warning: unused import: `self::id::INVALID_EVENTED_ID`
Nov 02 12:14:17.700 INFO kablam!   --> src/event/mod.rs:13:16
Nov 02 12:14:17.700 INFO kablam!    |
Nov 02 12:14:17.700 INFO kablam! 13 | pub(crate) use self::id::INVALID_EVENTED_ID;
Nov 02 12:14:17.700 INFO kablam!    |                ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 02 12:14:17.700 INFO kablam!    |
Nov 02 12:14:17.700 INFO kablam!    = note: #[warn(unused_imports)] on by default
Nov 02 12:14:17.700 INFO kablam! 
Nov 02 12:14:21.264 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 4.45s
Nov 02 12:14:21.271 INFO kablam! su: No module specific data is present
Nov 02 12:14:21.650 INFO running `"docker" "rm" "-f" "92999a087b8498d4636f19009b7b6e4f3caec2afd377df8b0d7a91544f8ab24a"`
Nov 02 12:14:21.947 INFO blam! 92999a087b8498d4636f19009b7b6e4f3caec2afd377df8b0d7a91544f8ab24a
Nov 02 12:14:21.949 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-1/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 02 12:14:22.335 INFO blam! 8014e58e95420e0c66f6573bf1c1b104f70f6fb201639d4d0fbd70b34f2b2aea
Nov 02 12:14:22.343 INFO running `"docker" "start" "-a" "8014e58e95420e0c66f6573bf1c1b104f70f6fb201639d4d0fbd70b34f2b2aea"`
Nov 02 12:14:23.351 INFO kablam! usermod: no changes
Nov 02 12:14:23.462 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Nov 02 12:14:23.475 INFO kablam!      Running /target/debug/deps/mio_st-37fdd4985123844b
Nov 02 12:14:23.491 INFO kablam!      Running /target/debug/deps/test-91a94df5100290bb
Nov 02 12:14:23.491 INFO blam! 
Nov 02 12:14:23.492 INFO blam! running 0 tests
Nov 02 12:14:23.492 INFO blam! 
Nov 02 12:14:23.492 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 02 12:14:23.492 INFO blam! 
Nov 02 12:14:23.493 INFO blam! 
Nov 02 12:14:23.493 INFO blam! running 35 tests
Nov 02 12:14:23.503 INFO blam! test deadline::multiple_timers_same_deadline ... ok
Nov 02 12:14:23.531 INFO blam! test deadline::add_deadline ... ok
Nov 02 12:14:23.531 INFO blam! test deadline::multiple_deadline_same_id ... ok
Nov 02 12:14:23.532 INFO blam! test registering::system::deregistering ... ignored
Nov 02 12:14:23.532 INFO blam! test event::evented_id ... ok
Nov 02 12:14:23.532 INFO blam! test event::event ... ok
Nov 02 12:14:23.543 INFO blam! test poll::polling_deadlines_dont_expand_events ... ok
Nov 02 12:14:23.543 INFO blam! test poll::polling_userspace_dont_expand_events ... ok
Nov 02 12:14:23.543 INFO blam! test registering::system::registering_deregistering_registering ... ok
Nov 02 12:14:23.544 INFO blam! test registering::system::registering_reregistering ... ok
Nov 02 12:14:23.544 INFO blam! test registering::system::registering_twice ... ignored
Nov 02 12:14:23.544 INFO blam! test registering::system::reregistering ... ignored
Nov 02 12:14:23.610 INFO blam! test deadline::poll_should_set_timeout ... ok
Nov 02 12:14:23.623 INFO blam! test tcp::listener ... ok
Nov 02 12:14:23.623 INFO blam! test tcp::listener_and_stream ... ok
Nov 02 12:14:23.623 INFO blam! test tcp::listener_bind_twice ... ok
Nov 02 12:14:23.623 INFO blam! test tcp::listener_poll_opt ... ok
Nov 02 12:14:23.633 INFO blam! test deadline::multiple_timers ... FAILED
Nov 02 12:14:23.639 INFO blam! test tcp::stream_poll_opt ... ok
Nov 02 12:14:23.723 INFO blam! test tcp::stream ... ok
Nov 02 12:14:23.723 INFO blam! test udp::connected_socket_peek_and_receive ... ok
Nov 02 12:14:23.729 INFO blam! test udp::connected_socket_reregister ... ok
Nov 02 12:14:23.734 INFO blam! test udp::connected_socket_send ... ok
Nov 02 12:14:23.839 INFO blam! test udp::connected_socket_deregister ... ok
Nov 02 12:14:23.839 INFO blam! test udp::socket_peek_and_receive_from ... ok
Nov 02 12:14:23.851 INFO blam! test udp::socket_reregister ... ok
Nov 02 12:14:23.853 INFO blam! test udp::socket_send_to ... ok
Nov 02 12:14:23.871 INFO blam! test userspace_registration::notify ... ok
Nov 02 12:14:23.943 INFO blam! test udp::socket_deregister ... ok
Nov 02 12:14:24.511 INFO blam! test deadline::invalid_id ... ok
Nov 02 12:14:24.541 INFO blam! test registering::system::invalid_id ... ok
Nov 02 12:14:24.541 INFO blam! test registering::system::registering_deregistering ... ok
Nov 02 12:14:24.541 INFO blam! test registering::system::empty_interests ... ok
Nov 02 12:14:24.541 INFO blam! test registering::system::registering_reregistering_deregistering ... ok
Nov 02 12:14:24.541 INFO blam! test tcp::deregistered_listener ... ok
Nov 02 12:14:24.541 INFO blam! 
Nov 02 12:14:24.541 INFO blam! failures:
Nov 02 12:14:24.541 INFO blam! 
Nov 02 12:14:24.541 INFO blam! ---- deadline::multiple_timers stdout ----
Nov 02 12:14:24.541 INFO blam! thread 'deadline::multiple_timers' panicked at 'expected poll to return within 30ms, it returned after: 30.491265ms', test/deadline.rs:15:5
Nov 02 12:14:24.541 INFO blam! stack backtrace:
Nov 02 12:14:24.541 INFO blam!    0:     0x55ace4cc985f - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c55afa80a996a32
Nov 02 12:14:24.541 INFO blam!                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Nov 02 12:14:24.541 INFO blam!    1:     0x55ace4cd2b97 - std::sys_common::backtrace::print::hcef907ea7a07cd40
Nov 02 12:14:24.541 INFO blam!                                at libstd/sys_common/backtrace.rs:71
Nov 02 12:14:24.541 INFO blam!                                at libstd/sys_common/backtrace.rs:59
Nov 02 12:14:24.541 INFO blam!    2:     0x55ace4ccd87f - std::panicking::default_hook::{{closure}}::hf541876c65f36ea7
Nov 02 12:14:24.541 INFO blam!                                at libstd/panicking.rs:211
Nov 02 12:14:24.541 INFO blam!    3:     0x55ace4ccd57e - std::panicking::default_hook::h4ecc06b30ae4459d
Nov 02 12:14:24.541 INFO blam!                                at libstd/panicking.rs:221
Nov 02 12:14:24.541 INFO blam!    4:     0x55ace4ccdf5e - std::panicking::rust_panic_with_hook::h0cc6d9cc9f34a947
Nov 02 12:14:24.541 INFO blam!                                at libstd/panicking.rs:476
Nov 02 12:14:24.541 INFO blam!    5:     0x55ace4ccdb01 - std::panicking::continue_panic_fmt::hc71ad5f01496e320
Nov 02 12:14:24.541 INFO blam!                                at libstd/panicking.rs:390
Nov 02 12:14:24.541 INFO blam!    6:     0x55ace4ccda4e - std::panicking::begin_panic_fmt::hdb958223ae20ca60
Nov 02 12:14:24.541 INFO blam!                                at libstd/panicking.rs:345
Nov 02 12:14:24.541 INFO blam!    7:     0x55ace4a8045f - test::deadline::expect_events_elapsed::hd8a480666089cbd9
Nov 02 12:14:24.541 INFO blam!                                at test/deadline.rs:15
Nov 02 12:14:24.541 INFO blam!    8:     0x55ace4a8104e - test::deadline::multiple_timers::he38adffce2a8f311
Nov 02 12:14:24.541 INFO blam!                                at test/deadline.rs:83
Nov 02 12:14:24.541 INFO blam!    9:     0x55ace4a80a19 - test::deadline::multiple_timers::{{closure}}::h84364d906ed881e3
Nov 02 12:14:24.541 INFO blam!                                at test/deadline.rs:45
Nov 02 12:14:24.541 INFO blam!   10:     0x55ace4a74a3d - core::ops::function::FnOnce::call_once::h1c46fec7fc239f52
Nov 02 12:14:24.541 INFO blam!                                at libcore/ops/function.rs:238
Nov 02 12:14:24.541 INFO blam!   11:     0x55ace4a9e80e - <F as alloc::boxed::FnBox<A>>::call_box::hf32558bd83684b60
Nov 02 12:14:24.541 INFO blam!                                at libtest/lib.rs:1468
Nov 02 12:14:24.541 INFO blam!                                at libcore/ops/function.rs:238
Nov 02 12:14:24.541 INFO blam!                                at liballoc/boxed.rs:672
Nov 02 12:14:24.541 INFO blam!   12:     0x55ace4cdddc9 - __rust_maybe_catch_panic
Nov 02 12:14:24.541 INFO blam!                                at libpanic_unwind/lib.rs:102
Nov 02 12:14:24.541 INFO blam!   13:     0x55ace4ac0472 - std::sys_common::backtrace::__rust_begin_short_backtrace::h1bb71a7386fd3269
Nov 02 12:14:24.541 INFO blam!                                at libstd/panicking.rs:289
Nov 02 12:14:24.541 INFO blam!                                at libstd/panic.rs:392
Nov 02 12:14:24.541 INFO blam!                                at libtest/lib.rs:1423
Nov 02 12:14:24.541 INFO blam!                                at libstd/sys_common/backtrace.rs:136
Nov 02 12:14:24.541 INFO blam!   14:     0x55ace4ac0f24 - std::panicking::try::do_call::h9b94719c3074bb5c
Nov 02 12:14:24.541 INFO blam!                                at libstd/thread/mod.rs:409
Nov 02 12:14:24.541 INFO blam!                                at libstd/panic.rs:313
Nov 02 12:14:24.541 INFO blam!                                at libstd/panicking.rs:310
Nov 02 12:14:24.541 INFO blam!   15:     0x55ace4cdddc9 - __rust_maybe_catch_panic
Nov 02 12:14:24.541 INFO blam!                                at libpanic_unwind/lib.rs:102
Nov 02 12:14:24.542 INFO blam!   16:     0x55ace4aae14c - <F as alloc::boxed::FnBox<A>>::call_box::hb3bcd66d16fd3e84
Nov 02 12:14:24.542 INFO blam!                                at libstd/panicking.rs:289
Nov 02 12:14:24.542 INFO blam!                                at libstd/panic.rs:392
Nov 02 12:14:24.542 INFO blam!                                at libstd/thread/mod.rs:408
Nov 02 12:14:24.542 INFO blam!                                at liballoc/boxed.rs:672
Nov 02 12:14:24.542 INFO blam!   17:     0x55ace4ccb77d - std::sys_common::thread::start_thread::had0c80d121669d29
Nov 02 12:14:24.542 INFO blam!                                at liballoc/boxed.rs:682
Nov 02 12:14:24.542 INFO blam!                                at libstd/sys_common/thread.rs:24
Nov 02 12:14:24.542 INFO blam!   18:     0x55ace4cbcd85 - std::sys::unix::thread::Thread::new::thread_start::h4a5b66a70d76f47f
Nov 02 12:14:24.542 INFO blam!                                at libstd/sys/unix/thread.rs:90
Nov 02 12:14:24.542 INFO blam!   19:     0x7fa128cf16b9 - start_thread
Nov 02 12:14:24.542 INFO blam!   20:     0x7fa12881141c - clone
Nov 02 12:14:24.542 INFO blam!   21:                0x0 - <unknown>
Nov 02 12:14:24.542 INFO blam! 
Nov 02 12:14:24.542 INFO blam! 
Nov 02 12:14:24.542 INFO blam! failures:
Nov 02 12:14:24.542 INFO blam!     deadline::multiple_timers
Nov 02 12:14:24.542 INFO blam! 
Nov 02 12:14:24.542 INFO blam! test result: FAILED. 31 passed; 1 failed; 3 ignored; 0 measured; 0 filtered out
Nov 02 12:14:24.542 INFO blam! 
Nov 02 12:14:24.553 INFO kablam! error: test failed, to rerun pass '--test test'
Nov 02 12:14:24.553 INFO kablam! su: No module specific data is present
Nov 02 12:14:25.005 INFO running `"docker" "rm" "-f" "8014e58e95420e0c66f6573bf1c1b104f70f6fb201639d4d0fbd70b34f2b2aea"`
Nov 02 12:14:25.251 INFO blam! 8014e58e95420e0c66f6573bf1c1b104f70f6fb201639d4d0fbd70b34f2b2aea
