Dec 14 16:28:52.856 INFO testing tokio-timer-patched-0.1.3 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 14 16:28:52.856 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 14 16:28:53.595 INFO [stdout] 59434ac311f38a76c85ad03b089563108999240e1f202013ff5cc16605cbf306
Dec 14 16:28:53.597 INFO running `"docker" "start" "-a" "59434ac311f38a76c85ad03b089563108999240e1f202013ff5cc16605cbf306"`
Dec 14 16:28:55.075 INFO [stderr] usermod: no changes
Dec 14 16:28:55.143 INFO [stderr]    Compiling tokio-timer-patched v0.1.3 (/source)
Dec 14 16:28:56.451 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.35s
Dec 14 16:28:56.452 INFO [stderr] su: No module specific data is present
Dec 14 16:28:56.716 INFO running `"docker" "inspect" "59434ac311f38a76c85ad03b089563108999240e1f202013ff5cc16605cbf306"`
Dec 14 16:28:56.790 INFO running `"docker" "rm" "-f" "59434ac311f38a76c85ad03b089563108999240e1f202013ff5cc16605cbf306"`
Dec 14 16:28:56.861 INFO [stdout] 59434ac311f38a76c85ad03b089563108999240e1f202013ff5cc16605cbf306
Dec 14 16:28:56.866 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 14 16:28:57.040 INFO [stdout] cb2d7ecc8e339681ba4c1505205e3c58a65340cd53a0c446df6c293da85fd852
Dec 14 16:28:57.041 INFO running `"docker" "start" "-a" "cb2d7ecc8e339681ba4c1505205e3c58a65340cd53a0c446df6c293da85fd852"`
Dec 14 16:28:57.509 INFO [stderr] usermod: no changes
Dec 14 16:28:57.536 INFO [stderr]    Compiling tokio-timer-patched v0.1.3 (/source)
Dec 14 16:28:59.309 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.78s
Dec 14 16:28:59.311 INFO [stderr] su: No module specific data is present
Dec 14 16:28:59.584 INFO running `"docker" "inspect" "cb2d7ecc8e339681ba4c1505205e3c58a65340cd53a0c446df6c293da85fd852"`
Dec 14 16:28:59.665 INFO running `"docker" "rm" "-f" "cb2d7ecc8e339681ba4c1505205e3c58a65340cd53a0c446df6c293da85fd852"`
Dec 14 16:28:59.741 INFO [stdout] cb2d7ecc8e339681ba4c1505205e3c58a65340cd53a0c446df6c293da85fd852
Dec 14 16:28:59.742 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 14 16:28:59.931 INFO [stdout] c6f569a09301f29633d94164b7ee3b04fd0ed453cb95c6a321c8f03c4e6578d2
Dec 14 16:28:59.933 INFO running `"docker" "start" "-a" "c6f569a09301f29633d94164b7ee3b04fd0ed453cb95c6a321c8f03c4e6578d2"`
Dec 14 16:29:00.280 INFO [stderr] usermod: no changes
Dec 14 16:29:00.311 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
Dec 14 16:29:00.312 INFO [stderr]      Running /target/debug/deps/tokio_timer_patched-5d30f5ef190b4cf9
Dec 14 16:29:00.316 INFO [stdout] 
Dec 14 16:29:00.316 INFO [stdout] running 0 tests
Dec 14 16:29:00.316 INFO [stdout] 
Dec 14 16:29:00.316 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:29:00.316 INFO [stdout] 
Dec 14 16:29:00.316 INFO [stderr]      Running /target/debug/deps/support-768bd33205134a6b
Dec 14 16:29:00.317 INFO [stdout] 
Dec 14 16:29:00.318 INFO [stdout] running 0 tests
Dec 14 16:29:00.318 INFO [stdout] 
Dec 14 16:29:00.318 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:29:00.318 INFO [stdout] 
Dec 14 16:29:00.318 INFO [stderr]      Running /target/debug/deps/test_timer-341ed0619a02471e
Dec 14 16:29:00.319 INFO [stdout] 
Dec 14 16:29:00.319 INFO [stdout] running 15 tests
Dec 14 16:29:00.323 INFO [stdout] test test_interval_at_past ... ok
Dec 14 16:29:00.324 INFO [stdout] test test_immediate_sleep ... ok
Dec 14 16:29:00.527 INFO [stdout] test test_timeout_stream_with_stream_completes_first ... ok
Dec 14 16:29:00.621 INFO [stdout] test test_interval_once ... ok
Dec 14 16:29:00.722 INFO [stdout] test test_timeout_with_future_completes_first ... ok
Dec 14 16:29:00.821 INFO [stdout] test test_request_sleep_greater_than_max ... ok
Dec 14 16:29:00.824 INFO [stdout] test test_interval_at_once ... ok
Dec 14 16:29:00.826 INFO [stdout] test test_setting_later_sleep_then_earlier_one ... ok
Dec 14 16:29:00.827 INFO [stdout] test test_timeout_with_future_errors_first ... ok
Dec 14 16:29:00.920 INFO [stdout] test test_interval_twice ... ok
Dec 14 16:29:01.029 INFO [stdout] test test_timeout_stream_with_timeout_completes_first ... ok
Dec 14 16:29:01.122 INFO [stdout] test test_timeout_with_timeout_completes_first ... ok
Dec 14 16:29:01.122 INFO [stdout] test test_interval_at_twice ... ok
Dec 14 16:29:01.825 INFO [stdout] test test_timer_with_looping_wheel ... ok
Dec 14 16:29:04.327 INFO [stderr]    Doc-tests tokio-timer-patched
Dec 14 16:29:04.327 INFO [stdout] test test_delayed_sleep ... ok
Dec 14 16:29:04.327 INFO [stdout] 
Dec 14 16:29:04.327 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:29:04.327 INFO [stdout] 
Dec 14 16:29:05.125 INFO [stdout] 
Dec 14 16:29:05.125 INFO [stdout] running 1 test
Dec 14 16:29:07.159 INFO [stdout] test src/lib.rs -  (line 15) ... ok
Dec 14 16:29:07.159 INFO [stdout] 
Dec 14 16:29:07.159 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:29:07.159 INFO [stdout] 
Dec 14 16:29:07.167 INFO [stderr] su: No module specific data is present
Dec 14 16:29:07.797 INFO running `"docker" "inspect" "c6f569a09301f29633d94164b7ee3b04fd0ed453cb95c6a321c8f03c4e6578d2"`
Dec 14 16:29:08.037 INFO running `"docker" "rm" "-f" "c6f569a09301f29633d94164b7ee3b04fd0ed453cb95c6a321c8f03c4e6578d2"`
Dec 14 16:29:08.303 INFO [stdout] c6f569a09301f29633d94164b7ee3b04fd0ed453cb95c6a321c8f03c4e6578d2