Dec 14 16:54:14.755 INFO testing timeout_io-0.3.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 16:54:14.755 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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:54:15.041 INFO [stdout] c864ec1e05844c805e1be53cf6286261216b03e7be7c648e4d50192f7e0f9050
Dec 14 16:54:15.044 INFO running `"docker" "start" "-a" "c864ec1e05844c805e1be53cf6286261216b03e7be7c648e4d50192f7e0f9050"`
Dec 14 16:54:15.604 INFO [stderr] usermod: no changes
Dec 14 16:54:15.642 INFO [stderr]    Compiling etrace v1.1.1
Dec 14 16:54:15.642 INFO [stderr]    Compiling timeout_io v0.3.0 (/source)
Dec 14 16:54:17.299 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.68s
Dec 14 16:54:17.302 INFO [stderr] su: No module specific data is present
Dec 14 16:54:17.996 INFO running `"docker" "inspect" "c864ec1e05844c805e1be53cf6286261216b03e7be7c648e4d50192f7e0f9050"`
Dec 14 16:54:18.313 INFO running `"docker" "rm" "-f" "c864ec1e05844c805e1be53cf6286261216b03e7be7c648e4d50192f7e0f9050"`
Dec 14 16:54:18.779 INFO [stdout] c864ec1e05844c805e1be53cf6286261216b03e7be7c648e4d50192f7e0f9050
Dec 14 16:54:18.785 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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:54:19.188 INFO [stdout] b3e33b36d1d9640a32f49bd78a30fdeaa9207cb707c41140d2c0682aed3b32ec
Dec 14 16:54:19.195 INFO running `"docker" "start" "-a" "b3e33b36d1d9640a32f49bd78a30fdeaa9207cb707c41140d2c0682aed3b32ec"`
Dec 14 16:54:20.226 INFO [stderr] usermod: no changes
Dec 14 16:54:20.287 INFO [stderr]    Compiling timeout_io v0.3.0 (/source)
Dec 14 16:54:25.587 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.33s
Dec 14 16:54:25.594 INFO [stderr] su: No module specific data is present
Dec 14 16:54:26.143 INFO running `"docker" "inspect" "b3e33b36d1d9640a32f49bd78a30fdeaa9207cb707c41140d2c0682aed3b32ec"`
Dec 14 16:54:26.367 INFO running `"docker" "rm" "-f" "b3e33b36d1d9640a32f49bd78a30fdeaa9207cb707c41140d2c0682aed3b32ec"`
Dec 14 16:54:26.499 INFO [stdout] b3e33b36d1d9640a32f49bd78a30fdeaa9207cb707c41140d2c0682aed3b32ec
Dec 14 16:54:26.507 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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:54:26.998 INFO [stdout] 6900535b47214978a7fbfb99883c6643acb0aca37cfe4b5b692259f89b680333
Dec 14 16:54:27.095 INFO running `"docker" "start" "-a" "6900535b47214978a7fbfb99883c6643acb0aca37cfe4b5b692259f89b680333"`
Dec 14 16:54:28.211 INFO [stderr] usermod: no changes
Dec 14 16:54:28.316 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 14 16:54:28.331 INFO [stdout] 
Dec 14 16:54:28.331 INFO [stderr]      Running /target/debug/deps/timeout_io-9b871f092bac3378
Dec 14 16:54:28.331 INFO [stdout] running 0 tests
Dec 14 16:54:28.331 INFO [stderr]      Running /target/debug/deps/acceptor-5b35954faea8bc36
Dec 14 16:54:28.331 INFO [stdout] 
Dec 14 16:54:28.331 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:54:28.331 INFO [stdout] 
Dec 14 16:54:28.335 INFO [stdout] 
Dec 14 16:54:28.335 INFO [stdout] running 2 tests
Dec 14 16:54:32.335 INFO [stdout] test test_accept_timeout ... ok
Dec 14 16:54:32.347 INFO [stdout] test test_accept_ok ... ok
Dec 14 16:54:32.347 INFO [stdout] 
Dec 14 16:54:32.347 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:54:32.347 INFO [stdout] 
Dec 14 16:54:32.347 INFO [stderr]      Running /target/debug/deps/reader-862a323d7c30b9ad
Dec 14 16:54:32.349 INFO [stdout] 
Dec 14 16:54:32.349 INFO [stdout] running 10 tests
Dec 14 16:54:32.350 INFO [stdout] test test_read_oneshot_err ... ok
Dec 14 16:54:36.355 INFO [stdout] test test_read_until_err ... ok
Dec 14 16:54:36.355 INFO [stdout] test test_read_exact_ok ... ok
Dec 14 16:54:36.355 INFO [stdout] test test_read_until_not_found ... ok
Dec 14 16:54:36.355 INFO [stdout] test test_read_exact_err ... ok
Dec 14 16:54:36.355 INFO [stdout] test test_read_oneshot_ok ... ok
Dec 14 16:54:36.356 INFO [stdout] test test_read_oneshot_timeout ... ok
Dec 14 16:54:37.355 INFO [stdout] test test_read_until_ok ... ok
Dec 14 16:54:39.351 INFO [stdout] test test_read_exact_timeout ... ok
Dec 14 16:54:43.355 INFO [stdout] test test_read_until_timeout ... ok
Dec 14 16:54:43.355 INFO [stderr]      Running /target/debug/deps/resolver-3e80778b71be52d9
Dec 14 16:54:43.355 INFO [stdout] 
Dec 14 16:54:43.355 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:54:43.355 INFO [stdout] 
Dec 14 16:54:43.358 INFO [stdout] 
Dec 14 16:54:43.358 INFO [stdout] running 5 tests
Dec 14 16:54:43.366 INFO [stdout] test test_dns_resolve_timeout ... ignored
Dec 14 16:54:43.367 INFO [stderr]      Running /target/debug/deps/writer-c0b148645edca1ca
Dec 14 16:54:43.367 INFO [stdout] test test_parse_ip_ok ... ok
Dec 14 16:54:43.367 INFO [stdout] test test_parse_ip_err ... ok
Dec 14 16:54:43.367 INFO [stdout] test test_dns_resolve_invalid ... ok
Dec 14 16:54:43.367 INFO [stdout] test test_dns_resolve_ok ... ok
Dec 14 16:54:43.367 INFO [stdout] 
Dec 14 16:54:43.367 INFO [stdout] test result: ok. 4 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 14 16:54:43.367 INFO [stdout] 
Dec 14 16:54:43.368 INFO [stdout] 
Dec 14 16:54:43.368 INFO [stdout] running 7 tests
Dec 14 16:54:43.368 INFO [stdout] test test_write_exact_timeout ... ignored
Dec 14 16:54:43.368 INFO [stdout] test test_write_oneshot_err_broken_pipe ... ignored
Dec 14 16:54:43.445 INFO [stdout] test test_write_oneshot_err ... ok
Dec 14 16:54:43.471 INFO [stdout] test test_write_oneshot_ok ... ok
Dec 14 16:54:43.655 INFO [stdout] test test_write_exact_err ... ok
Dec 14 16:54:43.834 INFO [stdout] test test_write_exact_ok ... ok
Dec 14 16:54:45.851 INFO [stdout] test test_write_oneshot_timeout ... ok
Dec 14 16:54:45.851 INFO [stderr]    Doc-tests timeout_io
Dec 14 16:54:45.851 INFO [stdout] 
Dec 14 16:54:45.851 INFO [stdout] test result: ok. 5 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out
Dec 14 16:54:45.851 INFO [stdout] 
Dec 14 16:54:46.659 INFO [stdout] 
Dec 14 16:54:46.659 INFO [stdout] running 0 tests
Dec 14 16:54:46.659 INFO [stdout] 
Dec 14 16:54:46.659 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:54:46.659 INFO [stdout] 
Dec 14 16:54:46.667 INFO [stderr] su: No module specific data is present
Dec 14 16:54:47.475 INFO running `"docker" "inspect" "6900535b47214978a7fbfb99883c6643acb0aca37cfe4b5b692259f89b680333"`
Dec 14 16:54:47.663 INFO running `"docker" "rm" "-f" "6900535b47214978a7fbfb99883c6643acb0aca37cfe4b5b692259f89b680333"`
Dec 14 16:54:47.871 INFO [stdout] 6900535b47214978a7fbfb99883c6643acb0aca37cfe4b5b692259f89b680333