[INFO] fetching crate async-io 1.13.0...
[INFO] testing async-io-1.13.0 against 1.69.0 for beta-1.70-1
[INFO] extracting crate async-io 1.13.0 into /workspace/builds/worker-5-tc1/source
[INFO] validating manifest of crates.io crate async-io 1.13.0 on toolchain 1.69.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.69.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate async-io 1.13.0
[INFO] finished tweaking crates.io crate async-io 1.13.0
[INFO] tweaked toml for crates.io crate async-io 1.13.0 written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] crate crates.io crate async-io 1.13.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.69.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded async-channel v1.8.0
[INFO] [stderr]   Downloaded futures-io v0.3.26
[INFO] [stderr]   Downloaded atomic-waker v1.1.0
[INFO] [stderr]   Downloaded futures-core v0.3.26
[INFO] [stderr]   Downloaded async-net v1.7.0
[INFO] [stderr]   Downloaded async-task v4.3.0
[INFO] [stderr]   Downloaded async-io v1.12.0
[INFO] [stderr]   Downloaded async-lock v2.6.0
[INFO] [stderr]   Downloaded concurrent-queue v2.1.0
[INFO] [stderr]   Downloaded polling v2.6.0
[INFO] [stderr]   Downloaded blocking v1.3.0
[INFO] [stderr]   Downloaded inotify v0.10.0
[INFO] [stderr]   Downloaded signal-hook v0.3.14
[INFO] [stderr]   Downloaded uds_windows v1.0.2
[INFO] [stderr]   Downloaded rustix v0.37.1
[INFO] [stderr]   Downloaded rustix v0.36.7
[INFO] [stderr]   Downloaded timerfd v1.4.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 55408409d3d3532bcdab5694490e781a6aca241ffc8cce25e83ef94a2f397695
[INFO] running `Command { std: "docker" "start" "-a" "55408409d3d3532bcdab5694490e781a6aca241ffc8cce25e83ef94a2f397695", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "55408409d3d3532bcdab5694490e781a6aca241ffc8cce25e83ef94a2f397695", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "55408409d3d3532bcdab5694490e781a6aca241ffc8cce25e83ef94a2f397695", kill_on_drop: false }`
[INFO] [stdout] 55408409d3d3532bcdab5694490e781a6aca241ffc8cce25e83ef94a2f397695
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1a34390a97d125404c9eeb9c8918c39cc6b0e05a488f34372c798b6917f4fc64
[INFO] running `Command { std: "docker" "start" "-a" "1a34390a97d125404c9eeb9c8918c39cc6b0e05a488f34372c798b6917f4fc64", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.139
[INFO] [stderr]    Compiling futures-core v0.3.26
[INFO] [stderr]    Compiling crossbeam-utils v0.8.14
[INFO] [stderr]    Compiling io-lifetimes v1.0.5
[INFO] [stderr]    Compiling polling v2.6.0
[INFO] [stderr]    Compiling slab v0.4.7
[INFO] [stderr]    Compiling fastrand v1.8.0
[INFO] [stderr]    Compiling futures-io v0.3.26
[INFO] [stderr]    Compiling rustix v0.37.1
[INFO] [stderr]    Compiling async-io v1.13.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling linux-raw-sys v0.3.0
[INFO] [stderr]    Compiling event-listener v2.5.3
[INFO] [stderr]    Compiling futures-lite v1.12.0
[INFO] [stderr]    Compiling concurrent-queue v2.1.0
[INFO] [stderr]    Compiling async-lock v2.6.0
[INFO] [stderr]    Compiling socket2 v0.4.7
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.95s
[INFO] running `Command { std: "docker" "inspect" "1a34390a97d125404c9eeb9c8918c39cc6b0e05a488f34372c798b6917f4fc64", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1a34390a97d125404c9eeb9c8918c39cc6b0e05a488f34372c798b6917f4fc64", kill_on_drop: false }`
[INFO] [stdout] 1a34390a97d125404c9eeb9c8918c39cc6b0e05a488f34372c798b6917f4fc64
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6d6702b85b1fecef319a8d0e4e1fe5c94cdd217d09b8007d3be7b0e995fed598
[INFO] running `Command { std: "docker" "start" "-a" "6d6702b85b1fecef319a8d0e4e1fe5c94cdd217d09b8007d3be7b0e995fed598", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling proc-macro2 v1.0.50
[INFO] [stderr]    Compiling unicode-ident v1.0.6
[INFO] [stderr]    Compiling quote v1.0.23
[INFO] [stderr]    Compiling syn v1.0.107
[INFO] [stderr]    Compiling serde_derive v1.0.152
[INFO] [stderr]    Compiling serde v1.0.152
[INFO] [stderr]    Compiling indexmap v1.9.2
[INFO] [stderr]    Compiling serde_json v1.0.91
[INFO] [stderr]    Compiling async-io v1.12.0
[INFO] [stderr]    Compiling num-traits v0.2.15
[INFO] [stderr]    Compiling ryu v1.0.12
[INFO] [stderr]    Compiling itoa v1.0.5
[INFO] [stderr]    Compiling rustix v0.36.7
[INFO] [stderr]    Compiling os_str_bytes v6.4.1
[INFO] [stderr]    Compiling async-channel v1.8.0
[INFO] [stderr]    Compiling async-net v1.7.0
[INFO] [stderr]    Compiling signal-hook v0.3.14
[INFO] [stderr]    Compiling atomic-waker v1.1.0
[INFO] [stderr]    Compiling linux-raw-sys v0.1.4
[INFO] [stderr]    Compiling clap_lex v0.2.4
[INFO] [stderr]    Compiling regex-syntax v0.6.28
[INFO] [stderr]    Compiling async-task v4.3.0
[INFO] [stderr]    Compiling criterion-plot v0.5.0
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling inotify-sys v0.1.5
[INFO] [stderr]    Compiling signal-hook-registry v1.4.0
[INFO] [stderr]    Compiling tempfile v3.3.0
[INFO] [stderr]    Compiling getrandom v0.2.8
[INFO] [stderr]    Compiling blocking v1.3.0
[INFO] [stderr]    Compiling inotify v0.10.0
[INFO] [stderr]    Compiling clap v3.2.23
[INFO] [stderr]    Compiling regex v1.7.1
[INFO] [stderr]    Compiling timerfd v1.4.0
[INFO] [stderr]    Compiling ciborium v0.2.0
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling criterion v0.4.0
[INFO] [stderr]    Compiling async-io v1.13.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 15.82s
[INFO] running `Command { std: "docker" "inspect" "6d6702b85b1fecef319a8d0e4e1fe5c94cdd217d09b8007d3be7b0e995fed598", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6d6702b85b1fecef319a8d0e4e1fe5c94cdd217d09b8007d3be7b0e995fed598", kill_on_drop: false }`
[INFO] [stdout] 6d6702b85b1fecef319a8d0e4e1fe5c94cdd217d09b8007d3be7b0e995fed598
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] ae1c8cc03b160425d3d7b47fc7d46748b4b8cc66cf9bf9a42f3c185b6b3a2b39
[INFO] running `Command { std: "docker" "start" "-a" "ae1c8cc03b160425d3d7b47fc7d46748b4b8cc66cf9bf9a42f3c185b6b3a2b39", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/async_io-45f58cb8aa14e94f)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/async.rs (/opt/rustwide/target/debug/deps/async-9341a5ad77ae9f42)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test udp_send_recv ... ok
[INFO] [stdout] test uds_send_recv ... ok
[INFO] [stdout] test shutdown ... ok
[INFO] [stdout] test udp_connect ... ok
[INFO] [stdout] test uds_send_to_recv_from ... ok
[INFO] [stdout] test tcp_peek_read ... ok
[INFO] [stdout] test tcp_connect ... ok
[INFO] [stdout] test uds_connect ... ok
[INFO] [stdout] test tcp_duplex ... ok
[INFO] [stdout] test tcp_reader_hangup ... ok
[INFO] [stdout] test uds_writer_hangup ... ok
[INFO] [stdout] test uds_reader_hangup ... ok
[INFO] [stdout] test tcp_writer_hangup ... ok
[INFO] [stderr]      Running tests/timer.rs (/opt/rustwide/target/debug/deps/timer-55787477712d1023)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test smoke ... ok
[INFO] [stdout] test poll_across_tasks ... ok
[INFO] [stdout] test interval ... ok
[INFO] [stdout] test set ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests async-io
[INFO] [stdout] 
[INFO] [stdout] running 52 tests
[INFO] [stdout] test src/lib.rs - Async<T>::write_with (line 1031) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async (line 581) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async (line 563) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<T>::poll_readable (line 903) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<T>::readable (line 837) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<T>::read_with (line 962) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<T>::read_with_mut (line 995) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<T>::write_with_mut (line 1065) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<TcpListener>::accept (line 1298) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UdpSocket>::peek (line 1551) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UdpSocket>::peek_from (line 1472) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<TcpListener>::incoming (line 1319) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UdpSocket>::recv_from (line 1448) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UdpSocket>::send_to (line 1493) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UdpSocket>::recv (line 1522) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UnixDatagram>::bind (line 1743) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UdpSocket>::send (line 1576) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UnixDatagram>::pair (line 1776) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UnixDatagram>::recv (line 1841) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UnixDatagram>::send (line 1866) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UnixDatagram>::recv_from (line 1795) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UnixDatagram>::send_to (line 1816) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UnixDatagram>::unbound (line 1760) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UnixListener>::bind (line 1607) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UnixListener>::accept (line 1628) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UnixListener>::incoming (line 1649) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UnixStream>::connect (line 1688) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<UnixStream>::pair (line 1714) - compile ... ok
[INFO] [stdout] test src/lib.rs - Async<T>::get_ref (line 777) ... ok
[INFO] [stdout] test src/lib.rs - Async<TcpListener>::bind (line 1277) ... ok
[INFO] [stdout] test src/lib.rs - Async<T>::writable (line 865) ... ok
[INFO] [stdout] test src/lib.rs - Async<T>::into_inner (line 813) ... ok
[INFO] [stdout] test src/lib.rs - Async<T>::poll_writable (line 934) ... ok
[INFO] [stdout] test src/lib.rs - Async<T>::get_mut (line 794) ... ok
[INFO] [stdout] test src/lib.rs - Async<UdpSocket>::bind (line 1425) ... ok
[INFO] [stdout] test src/lib.rs - Async<T>::new (line 621) ... ok
[INFO] [stdout] test src/lib.rs - Async<TcpStream>::peek (line 1388) ... ok
[INFO] [stdout] test src/lib.rs - (line 38) ... ok
[INFO] [stdout] test src/lib.rs - Async<TcpStream>::connect (line 1356) ... ok
[INFO] [stdout] test src/driver.rs - driver::block_on (line 97) ... ok
[INFO] [stdout] test src/lib.rs - Timer::never (line 166) ... ok
[INFO] [stdout] test src/lib.rs - Timer::interval_at (line 261) ... ok
[INFO] [stdout] test src/lib.rs - Timer::will_fire (line 287) ... ok
[INFO] [stdout] test src/lib.rs - Timer::set_interval (line 371) ... ok
[INFO] [stdout] test src/lib.rs - Timer::set_after (line 311) ... ok
[INFO] [stdout] test src/lib.rs - Timer::set_at (line 339) ... ok
[INFO] [stdout] test src/lib.rs - Timer::set_interval_at (line 402) ... ok
[INFO] [stdout] test src/lib.rs - Timer (line 127) ... ok
[INFO] [stdout] test src/lib.rs - Timer::at (line 222) ... ok
[INFO] [stdout] test src/lib.rs - Timer (line 116) ... ok
[INFO] [stdout] test src/lib.rs - Timer::after (line 204) ... ok
[INFO] [stdout] test src/lib.rs - Timer::interval (line 241) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.06s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "ae1c8cc03b160425d3d7b47fc7d46748b4b8cc66cf9bf9a42f3c185b6b3a2b39", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ae1c8cc03b160425d3d7b47fc7d46748b4b8cc66cf9bf9a42f3c185b6b3a2b39", kill_on_drop: false }`
[INFO] [stdout] ae1c8cc03b160425d3d7b47fc7d46748b4b8cc66cf9bf9a42f3c185b6b3a2b39
