Dec 06 20:06:52.923 INFO testing timeout_io-0.3.0 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 20:06:52.923 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 06 20:06:53.544 INFO [stdout] 7cfa854dc6799edcfd96de937f15904227de6a75c65052d333942872dc2f3241
Dec 06 20:06:53.546 INFO running `"docker" "start" "-a" "7cfa854dc6799edcfd96de937f15904227de6a75c65052d333942872dc2f3241"`
Dec 06 20:06:54.597 INFO [stderr] usermod: no changes
Dec 06 20:06:54.675 INFO [stderr]    Compiling etrace v1.1.1
Dec 06 20:06:54.675 INFO [stderr]    Compiling timeout_io v0.3.0 (/source)
Dec 06 20:06:56.836 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.21s
Dec 06 20:06:56.841 INFO [stderr] su: No module specific data is present
Dec 06 20:06:57.469 INFO running `"docker" "inspect" "7cfa854dc6799edcfd96de937f15904227de6a75c65052d333942872dc2f3241"`
Dec 06 20:06:57.800 INFO running `"docker" "rm" "-f" "7cfa854dc6799edcfd96de937f15904227de6a75c65052d333942872dc2f3241"`
Dec 06 20:06:58.124 INFO [stdout] 7cfa854dc6799edcfd96de937f15904227de6a75c65052d333942872dc2f3241
Dec 06 20:06:58.128 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 06 20:06:58.538 INFO [stdout] 62857e9c8add25885ec3e1242691c343e4cb50327ee897127490c3535eb80ed9
Dec 06 20:06:58.540 INFO running `"docker" "start" "-a" "62857e9c8add25885ec3e1242691c343e4cb50327ee897127490c3535eb80ed9"`
Dec 06 20:06:59.222 INFO [stderr] usermod: no changes
Dec 06 20:06:59.272 INFO [stderr]    Compiling timeout_io v0.3.0 (/source)
Dec 06 20:07:02.164 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.92s
Dec 06 20:07:02.164 INFO [stderr] su: No module specific data is present
Dec 06 20:07:02.418 INFO running `"docker" "inspect" "62857e9c8add25885ec3e1242691c343e4cb50327ee897127490c3535eb80ed9"`
Dec 06 20:07:02.496 INFO running `"docker" "rm" "-f" "62857e9c8add25885ec3e1242691c343e4cb50327ee897127490c3535eb80ed9"`
Dec 06 20:07:02.550 INFO [stdout] 62857e9c8add25885ec3e1242691c343e4cb50327ee897127490c3535eb80ed9
Dec 06 20:07:02.552 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 06 20:07:02.682 INFO [stdout] 3fc5f8111723658141116943f3f9ef8a88b80d9e89fe4468c4b5b6dffbd061a6
Dec 06 20:07:02.685 INFO running `"docker" "start" "-a" "3fc5f8111723658141116943f3f9ef8a88b80d9e89fe4468c4b5b6dffbd061a6"`
Dec 06 20:07:03.080 INFO [stderr] usermod: no changes
Dec 06 20:07:03.132 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Dec 06 20:07:03.135 INFO [stderr]      Running /target/debug/deps/timeout_io-5f97f261e6478a11
Dec 06 20:07:03.137 INFO [stdout] 
Dec 06 20:07:03.137 INFO [stdout] running 0 tests
Dec 06 20:07:03.137 INFO [stdout] 
Dec 06 20:07:03.137 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:07:03.137 INFO [stdout] 
Dec 06 20:07:03.137 INFO [stderr]      Running /target/debug/deps/acceptor-9f21dc442ab9030d
Dec 06 20:07:03.139 INFO [stdout] 
Dec 06 20:07:03.139 INFO [stdout] running 2 tests
Dec 06 20:07:07.144 INFO [stderr]      Running /target/debug/deps/reader-339607eb76c92490
Dec 06 20:07:07.144 INFO [stdout] test test_accept_ok ... ok
Dec 06 20:07:07.144 INFO [stdout] test test_accept_timeout ... ok
Dec 06 20:07:07.144 INFO [stdout] 
Dec 06 20:07:07.144 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:07:07.144 INFO [stdout] 
Dec 06 20:07:07.149 INFO [stdout] 
Dec 06 20:07:07.149 INFO [stdout] running 10 tests
Dec 06 20:07:07.194 INFO [stdout] test test_read_oneshot_err ... ok
Dec 06 20:07:11.180 INFO [stdout] test test_read_oneshot_ok ... ok
Dec 06 20:07:11.180 INFO [stdout] test test_read_exact_ok ... ok
Dec 06 20:07:11.180 INFO [stdout] test test_read_until_err ... ok
Dec 06 20:07:11.180 INFO [stdout] test test_read_oneshot_timeout ... ok
Dec 06 20:07:11.180 INFO [stdout] test test_read_exact_err ... ok
Dec 06 20:07:11.196 INFO [stdout] test test_read_until_not_found ... ok
Dec 06 20:07:12.192 INFO [stdout] test test_read_until_ok ... ok
Dec 06 20:07:14.181 INFO [stdout] test test_read_exact_timeout ... ok
Dec 06 20:07:18.180 INFO [stdout] test test_read_until_timeout ... ok
Dec 06 20:07:18.180 INFO [stdout] 
Dec 06 20:07:18.180 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:07:18.180 INFO [stdout] 
Dec 06 20:07:18.188 INFO [stderr]      Running /target/debug/deps/resolver-1822c219e8976cb1
Dec 06 20:07:18.188 INFO [stdout] 
Dec 06 20:07:18.188 INFO [stdout] running 5 tests
Dec 06 20:07:18.188 INFO [stdout] test test_dns_resolve_timeout ... ignored
Dec 06 20:07:18.188 INFO [stdout] test test_parse_ip_err ... ok
Dec 06 20:07:18.188 INFO [stdout] test test_parse_ip_ok ... ok
Dec 06 20:07:18.200 INFO [stderr]      Running /target/debug/deps/writer-f42595f656a779a6
Dec 06 20:07:18.200 INFO [stdout] test test_dns_resolve_invalid ... ok
Dec 06 20:07:18.200 INFO [stdout] test test_dns_resolve_ok ... ok
Dec 06 20:07:18.200 INFO [stdout] 
Dec 06 20:07:18.200 INFO [stdout] test result: ok. 4 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 06 20:07:18.200 INFO [stdout] 
Dec 06 20:07:18.208 INFO [stdout] 
Dec 06 20:07:18.208 INFO [stdout] running 7 tests
Dec 06 20:07:18.208 INFO [stdout] test test_write_exact_timeout ... ignored
Dec 06 20:07:18.208 INFO [stdout] test test_write_oneshot_err_broken_pipe ... ignored
Dec 06 20:07:18.276 INFO [stdout] test test_write_oneshot_err ... ok
Dec 06 20:07:18.352 INFO [stdout] test test_write_oneshot_ok ... ok
Dec 06 20:07:18.524 INFO [stdout] test test_write_exact_err ... ok
Dec 06 20:07:18.627 INFO [stdout] test test_write_exact_ok ... ok
Dec 06 20:07:20.633 INFO [stdout] test test_write_oneshot_timeout ... ok
Dec 06 20:07:20.633 INFO [stderr]    Doc-tests timeout_io
Dec 06 20:07:20.633 INFO [stdout] 
Dec 06 20:07:20.633 INFO [stdout] test result: ok. 5 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out
Dec 06 20:07:20.633 INFO [stdout] 
Dec 06 20:07:21.415 INFO [stdout] 
Dec 06 20:07:21.415 INFO [stdout] running 0 tests
Dec 06 20:07:21.415 INFO [stdout] 
Dec 06 20:07:21.415 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:07:21.415 INFO [stdout] 
Dec 06 20:07:21.422 INFO [stderr] su: No module specific data is present
Dec 06 20:07:21.983 INFO running `"docker" "inspect" "3fc5f8111723658141116943f3f9ef8a88b80d9e89fe4468c4b5b6dffbd061a6"`
Dec 06 20:07:22.158 INFO running `"docker" "rm" "-f" "3fc5f8111723658141116943f3f9ef8a88b80d9e89fe4468c4b5b6dffbd061a6"`
Dec 06 20:07:22.361 INFO [stdout] 3fc5f8111723658141116943f3f9ef8a88b80d9e89fe4468c4b5b6dffbd061a6