Dec 14 16:28:51.952 INFO testing tokio-timer-patched-0.1.3 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 16:28:51.953 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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:52.379 INFO [stdout] a9cf119011a42e4bdcd45d3fdc2689b52659272fbce042d0343652909164a215
Dec 14 16:28:52.383 INFO running `"docker" "start" "-a" "a9cf119011a42e4bdcd45d3fdc2689b52659272fbce042d0343652909164a215"`
Dec 14 16:28:53.783 INFO [stderr] usermod: no changes
Dec 14 16:28:53.870 INFO [stderr]    Compiling tokio-timer-patched v0.1.3 (/source)
Dec 14 16:28:55.280 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.46s
Dec 14 16:28:55.280 INFO [stderr] su: No module specific data is present
Dec 14 16:28:55.837 INFO running `"docker" "inspect" "a9cf119011a42e4bdcd45d3fdc2689b52659272fbce042d0343652909164a215"`
Dec 14 16:28:55.994 INFO running `"docker" "rm" "-f" "a9cf119011a42e4bdcd45d3fdc2689b52659272fbce042d0343652909164a215"`
Dec 14 16:28:56.236 INFO [stdout] a9cf119011a42e4bdcd45d3fdc2689b52659272fbce042d0343652909164a215
Dec 14 16:28:56.245 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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:56.704 INFO [stdout] 80a76b9605a56a1885630aa2970377d02429a3af883d11e63d96acc28ff4e0cf
Dec 14 16:28:56.707 INFO running `"docker" "start" "-a" "80a76b9605a56a1885630aa2970377d02429a3af883d11e63d96acc28ff4e0cf"`
Dec 14 16:28:57.055 INFO [stderr] usermod: no changes
Dec 14 16:28:57.078 INFO [stderr]    Compiling tokio-timer-patched v0.1.3 (/source)
Dec 14 16:28:58.829 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.76s
Dec 14 16:28:58.832 INFO [stderr] su: No module specific data is present
Dec 14 16:28:59.287 INFO running `"docker" "inspect" "80a76b9605a56a1885630aa2970377d02429a3af883d11e63d96acc28ff4e0cf"`
Dec 14 16:28:59.346 INFO running `"docker" "rm" "-f" "80a76b9605a56a1885630aa2970377d02429a3af883d11e63d96acc28ff4e0cf"`
Dec 14 16:28:59.427 INFO [stdout] 80a76b9605a56a1885630aa2970377d02429a3af883d11e63d96acc28ff4e0cf
Dec 14 16:28:59.427 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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.592 INFO [stdout] 07e903dd2748e90217e106fe8b8b93200ab71f4e8317431979e768e7ab26f216
Dec 14 16:28:59.594 INFO running `"docker" "start" "-a" "07e903dd2748e90217e106fe8b8b93200ab71f4e8317431979e768e7ab26f216"`
Dec 14 16:29:00.045 INFO [stderr] usermod: no changes
Dec 14 16:29:00.073 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
Dec 14 16:29:00.074 INFO [stderr]      Running /target/debug/deps/tokio_timer_patched-928d830b7838d06f
Dec 14 16:29:00.076 INFO [stderr]      Running /target/debug/deps/support-06568613670a9017
Dec 14 16:29:00.076 INFO [stdout] 
Dec 14 16:29:00.076 INFO [stdout] running 0 tests
Dec 14 16:29:00.076 INFO [stdout] 
Dec 14 16:29:00.076 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:29:00.076 INFO [stdout] 
Dec 14 16:29:00.077 INFO [stdout] 
Dec 14 16:29:00.077 INFO [stdout] running 0 tests
Dec 14 16:29:00.077 INFO [stdout] 
Dec 14 16:29:00.077 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:29:00.077 INFO [stdout] 
Dec 14 16:29:00.077 INFO [stderr]      Running /target/debug/deps/test_timer-164f66c4776dfdf9
Dec 14 16:29:00.078 INFO [stdout] 
Dec 14 16:29:00.078 INFO [stdout] running 15 tests
Dec 14 16:29:00.082 INFO [stdout] test test_interval_at_past ... ok
Dec 14 16:29:00.082 INFO [stdout] test test_immediate_sleep ... ok
Dec 14 16:29:00.287 INFO [stdout] test test_timeout_stream_with_stream_completes_first ... ok
Dec 14 16:29:00.380 INFO [stdout] test test_interval_once ... ok
Dec 14 16:29:00.481 INFO [stdout] test test_timeout_with_future_completes_first ... ok
Dec 14 16:29:00.580 INFO [stdout] test test_interval_at_once ... ok
Dec 14 16:29:00.582 INFO [stdout] test test_timeout_with_future_errors_first ... ok
Dec 14 16:29:00.582 INFO [stdout] test test_request_sleep_greater_than_max ... ok
Dec 14 16:29:00.583 INFO [stdout] test test_setting_later_sleep_then_earlier_one ... ok
Dec 14 16:29:00.680 INFO [stdout] test test_interval_twice ... ok
Dec 14 16:29:00.789 INFO [stdout] test test_timeout_stream_with_timeout_completes_first ... ok
Dec 14 16:29:00.881 INFO [stdout] test test_timeout_with_timeout_completes_first ... ok
Dec 14 16:29:00.882 INFO [stdout] test test_interval_at_twice ... ok
Dec 14 16:29:01.582 INFO [stdout] test test_timer_with_looping_wheel ... ok
Dec 14 16:29:04.087 INFO [stderr]    Doc-tests tokio-timer-patched
Dec 14 16:29:04.087 INFO [stdout] test test_delayed_sleep ... ok
Dec 14 16:29:04.087 INFO [stdout] 
Dec 14 16:29:04.087 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:29:04.087 INFO [stdout] 
Dec 14 16:29:05.000 INFO [stdout] 
Dec 14 16:29:05.000 INFO [stdout] running 1 test
Dec 14 16:29:07.070 INFO [stdout] test src/lib.rs -  (line 15) ... ok
Dec 14 16:29:07.071 INFO [stdout] 
Dec 14 16:29:07.071 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:29:07.071 INFO [stdout] 
Dec 14 16:29:07.087 INFO [stderr] su: No module specific data is present
Dec 14 16:29:07.777 INFO running `"docker" "inspect" "07e903dd2748e90217e106fe8b8b93200ab71f4e8317431979e768e7ab26f216"`
Dec 14 16:29:08.065 INFO running `"docker" "rm" "-f" "07e903dd2748e90217e106fe8b8b93200ab71f4e8317431979e768e7ab26f216"`
Dec 14 16:29:08.295 INFO [stdout] 07e903dd2748e90217e106fe8b8b93200ab71f4e8317431979e768e7ab26f216