Dec 07 07:15:02.340 INFO testing mio-extras-2.0.5 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 07:15:02.341 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 07 07:15:02.777 INFO [stdout] 3142a36af8ae9c193d25750f6493a110460f76a48331cae6fba6f2f1e0986b65
Dec 07 07:15:02.779 INFO running `"docker" "start" "-a" "3142a36af8ae9c193d25750f6493a110460f76a48331cae6fba6f2f1e0986b65"`
Dec 07 07:15:04.616 INFO [stderr] usermod: no changes
Dec 07 07:15:04.686 INFO [stderr]    Compiling mio-extras v2.0.5 (/source)
Dec 07 07:15:06.161 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.51s
Dec 07 07:15:06.164 INFO [stderr] su: No module specific data is present
Dec 07 07:15:06.751 INFO running `"docker" "inspect" "3142a36af8ae9c193d25750f6493a110460f76a48331cae6fba6f2f1e0986b65"`
Dec 07 07:15:06.963 INFO running `"docker" "rm" "-f" "3142a36af8ae9c193d25750f6493a110460f76a48331cae6fba6f2f1e0986b65"`
Dec 07 07:15:07.234 INFO [stdout] 3142a36af8ae9c193d25750f6493a110460f76a48331cae6fba6f2f1e0986b65
Dec 07 07:15:07.238 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 07 07:15:07.582 INFO [stdout] ab3ef9287a2af0276fec0df44ea6035b8bd37262a3685a891d8557081ae5ea05
Dec 07 07:15:07.586 INFO running `"docker" "start" "-a" "ab3ef9287a2af0276fec0df44ea6035b8bd37262a3685a891d8557081ae5ea05"`
Dec 07 07:15:08.783 INFO [stderr] usermod: no changes
Dec 07 07:15:08.856 INFO [stderr]    Compiling mio-extras v2.0.5 (/source)
Dec 07 07:15:11.679 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.87s
Dec 07 07:15:11.683 INFO [stderr] su: No module specific data is present
Dec 07 07:15:12.022 INFO running `"docker" "inspect" "ab3ef9287a2af0276fec0df44ea6035b8bd37262a3685a891d8557081ae5ea05"`
Dec 07 07:15:12.127 INFO running `"docker" "rm" "-f" "ab3ef9287a2af0276fec0df44ea6035b8bd37262a3685a891d8557081ae5ea05"`
Dec 07 07:15:12.199 INFO [stdout] ab3ef9287a2af0276fec0df44ea6035b8bd37262a3685a891d8557081ae5ea05
Dec 07 07:15:12.200 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 07 07:15:12.377 INFO [stdout] 804de5a5a77dd3487c67c1a945045bf0760647d3db2b4727cc56eed50aa6988f
Dec 07 07:15:12.382 INFO running `"docker" "start" "-a" "804de5a5a77dd3487c67c1a945045bf0760647d3db2b4727cc56eed50aa6988f"`
Dec 07 07:15:12.940 INFO [stderr] usermod: no changes
Dec 07 07:15:12.985 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Dec 07 07:15:12.997 INFO [stderr]      Running /target/debug/deps/mio_extras-20e5f7c1cb9ae067
Dec 07 07:15:12.999 INFO [stdout] 
Dec 07 07:15:13.000 INFO [stdout] running 7 tests
Dec 07 07:15:13.000 INFO [stdout] test timer::test::test_timeout_hash_collision ... ok
Dec 07 07:15:13.000 INFO [stdout] test timer::test::test_timeout_next_tick ... ok
Dec 07 07:15:13.000 INFO [stdout] test timer::test::test_multiple_timeouts_same_tick ... ok
Dec 07 07:15:13.000 INFO [stdout] test timer::test::test_multiple_timeouts_diff_tick ... ok
Dec 07 07:15:13.000 INFO [stdout] test timer::test::test_catching_up ... ok
Dec 07 07:15:13.000 INFO [stdout] test timer::test::test_clearing_timeout_between_triggers ... ok
Dec 07 07:15:13.000 INFO [stdout] test timer::test::test_clearing_timeout ... ok
Dec 07 07:15:13.000 INFO [stdout] 
Dec 07 07:15:13.000 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 07:15:13.000 INFO [stdout] 
Dec 07 07:15:13.001 INFO [stderr]      Running /target/debug/deps/test-b228db4a3adc78b4
Dec 07 07:15:13.002 INFO [stdout] 
Dec 07 07:15:13.002 INFO [stdout] running 16 tests
Dec 07 07:15:13.003 INFO [stdout] test test_poll_channel::test_dropping_receive_before_poll ... ok
Dec 07 07:15:13.205 INFO [stdout] test test_timer::test_basic_timer_with_poll_edge_set_timeout_after_register ... ok
Dec 07 07:15:13.205 INFO [stdout] test test_timer::test_basic_timer_with_poll_edge_set_timeout_before_register ... ok
Dec 07 07:15:13.260 INFO [stdout] test test_poll_channel::test_mixing_channel_with_socket ... ok
Dec 07 07:15:13.308 INFO [stdout] test test_poll_channel::test_poll_channel_level ... ok
Dec 07 07:15:13.460 INFO [stdout] test test_timer::test_basic_timer_without_poll ... ok
Dec 07 07:15:13.651 INFO [stdout] test test_poll_channel::test_poll_channel_writable ... ok
Dec 07 07:15:13.730 INFO [stdout] test test_timer::test_cancel_timeout ... ok
Dec 07 07:15:13.766 INFO [stdout] test test_timer::test_edge_oneshot_triggered ... ok
Dec 07 07:15:13.862 INFO [stdout] test test_timer::test_level_triggered ... ok
Dec 07 07:15:13.913 INFO [stdout] test test_poll_channel::test_poll_channel_edge ... ok
Dec 07 07:15:14.013 INFO [stdout] test test_timer::test_edge_without_polling ... ok
Dec 07 07:15:14.076 INFO [stdout] test test_poll_channel::test_sending_from_other_thread_while_polling ... ok
Dec 07 07:15:14.221 INFO [stdout] test test_timer::test_setting_later_timeout_then_earlier_one ... ok
Dec 07 07:15:14.810 INFO [stdout] test test_poll_channel::test_poll_channel_oneshot ... ok
Dec 07 07:15:15.714 INFO [stdout] test test_timer::test_timer_with_looping_wheel ... ok
Dec 07 07:15:15.714 INFO [stdout] 
Dec 07 07:15:15.714 INFO [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 07:15:15.714 INFO [stdout] 
Dec 07 07:15:15.716 INFO [stderr]    Doc-tests mio-extras
Dec 07 07:15:17.207 INFO [stdout] 
Dec 07 07:15:17.207 INFO [stdout] running 0 tests
Dec 07 07:15:17.207 INFO [stdout] 
Dec 07 07:15:17.207 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 07:15:17.207 INFO [stdout] 
Dec 07 07:15:17.222 INFO [stderr] su: No module specific data is present
Dec 07 07:15:17.503 INFO running `"docker" "inspect" "804de5a5a77dd3487c67c1a945045bf0760647d3db2b4727cc56eed50aa6988f"`
Dec 07 07:15:17.706 INFO running `"docker" "rm" "-f" "804de5a5a77dd3487c67c1a945045bf0760647d3db2b4727cc56eed50aa6988f"`
Dec 07 07:15:17.880 INFO [stdout] 804de5a5a77dd3487c67c1a945045bf0760647d3db2b4727cc56eed50aa6988f