[INFO] fetching crate acid_io 0.1.0...
[INFO] testing acid_io-0.1.0 against master#c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38 for pr-146098-7
[INFO] extracting crate acid_io 0.1.0 into /workspace/builds/worker-5-tc1/source
[INFO] started tweaking crates.io crate acid_io 0.1.0
[INFO] finished tweaking crates.io crate acid_io 0.1.0
[INFO] tweaked toml for crates.io crate acid_io 0.1.0 written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate acid_io 0.1.0 on toolchain c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]      Locking 9 packages to latest compatible versions
[INFO] [stderr]       Adding windows v0.29.0 (available: v0.62.2)
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded windows_x86_64_gnu v0.29.0
[INFO] [stderr]   Downloaded windows_aarch64_msvc v0.29.0
[INFO] [stderr]   Downloaded windows_i686_msvc v0.29.0
[INFO] [stderr]   Downloaded windows_x86_64_msvc v0.29.0
[INFO] [stderr]   Downloaded windows_i686_gnu v0.29.0
[INFO] [stderr]   Downloaded windows v0.29.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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 669d1222142b37fafa64b3d22f8da8c051852ee8cdb7fe9b92e8bedd8be6dda2
[INFO] running `Command { std: "docker" "start" "-a" "669d1222142b37fafa64b3d22f8da8c051852ee8cdb7fe9b92e8bedd8be6dda2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "669d1222142b37fafa64b3d22f8da8c051852ee8cdb7fe9b92e8bedd8be6dda2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "669d1222142b37fafa64b3d22f8da8c051852ee8cdb7fe9b92e8bedd8be6dda2", kill_on_drop: false }`
[INFO] [stdout] 669d1222142b37fafa64b3d22f8da8c051852ee8cdb7fe9b92e8bedd8be6dda2
[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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6cd92ba8424eca12728894c2f31931df680447b209350214cce9523570a63ac2
[INFO] running `Command { std: "docker" "start" "-a" "6cd92ba8424eca12728894c2f31931df680447b209350214cce9523570a63ac2", kill_on_drop: false }`
[INFO] [stderr]    Compiling acid_io v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.45s
[INFO] running `Command { std: "docker" "inspect" "6cd92ba8424eca12728894c2f31931df680447b209350214cce9523570a63ac2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6cd92ba8424eca12728894c2f31931df680447b209350214cce9523570a63ac2", kill_on_drop: false }`
[INFO] [stdout] 6cd92ba8424eca12728894c2f31931df680447b209350214cce9523570a63ac2
[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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 001097309dd36ad57f9f6f9cecce9190bba018b80b7058e1ec76542b7d2a43b2
[INFO] running `Command { std: "docker" "start" "-a" "001097309dd36ad57f9f6f9cecce9190bba018b80b7058e1ec76542b7d2a43b2", kill_on_drop: false }`
[INFO] [stderr]    Compiling acid_io v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: struct `ExampleSliceReader` is never constructed
[INFO] [stdout]    --> src/tests/mod.rs:373:8
[INFO] [stdout]     |
[INFO] [stdout] 373 | struct ExampleSliceReader<'a> {
[INFO] [stdout]     |        ^^^^^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `ShortReader` is never constructed
[INFO] [stdout]   --> src/tests/util.rs:20:8
[INFO] [stdout]    |
[INFO] [stdout] 20 | struct ShortReader {
[INFO] [stdout]    |        ^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WriteObserver` is never constructed
[INFO] [stdout]   --> src/tests/util.rs:35:8
[INFO] [stdout]    |
[INFO] [stdout] 35 | struct WriteObserver {
[INFO] [stdout]    |        ^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.88s
[INFO] running `Command { std: "docker" "inspect" "001097309dd36ad57f9f6f9cecce9190bba018b80b7058e1ec76542b7d2a43b2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "001097309dd36ad57f9f6f9cecce9190bba018b80b7058e1ec76542b7d2a43b2", kill_on_drop: false }`
[INFO] [stdout] 001097309dd36ad57f9f6f9cecce9190bba018b80b7058e1ec76542b7d2a43b2
[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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] bd1a0daa4a4c7df0717b3ecec6e6d6a8339ae6e68fe1c15eba33014be19fd67e
[INFO] running `Command { std: "docker" "start" "-a" "bd1a0daa4a4c7df0717b3ecec6e6d6a8339ae6e68fe1c15eba33014be19fd67e", kill_on_drop: false }`
[INFO] [stderr] warning: struct `ExampleSliceReader` is never constructed
[INFO] [stderr]    --> src/tests/mod.rs:373:8
[INFO] [stderr]     |
[INFO] [stderr] 373 | struct ExampleSliceReader<'a> {
[INFO] [stderr]     |        ^^^^^^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `ShortReader` is never constructed
[INFO] [stderr]   --> src/tests/util.rs:20:8
[INFO] [stderr]    |
[INFO] [stderr] 20 | struct ShortReader {
[INFO] [stderr]    |        ^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WriteObserver` is never constructed
[INFO] [stderr]   --> src/tests/util.rs:35:8
[INFO] [stderr]    |
[INFO] [stderr] 35 | struct WriteObserver {
[INFO] [stderr]    |        ^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `acid_io` (lib test) generated 3 warnings
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/acid_io-b6340e4e130eb4e5)
[INFO] [stdout] 
[INFO] [stdout] running 25 tests
[INFO] [stdout] test tests::chain_empty_size_hint ... ok
[INFO] [stdout] test tests::cursor::seek_before_0 ... ok
[INFO] [stdout] test tests::cursor::seek_past_end ... ok
[INFO] [stdout] test tests::cursor::seek_past_i64 ... ok
[INFO] [stdout] test tests::cursor::test_buf_writer ... ok
[INFO] [stdout] test tests::cursor::test_buf_writer_error ... ok
[INFO] [stdout] test tests::cursor::test_buf_writer_seek ... ok
[INFO] [stdout] test tests::empty_size_hint ... ok
[INFO] [stdout] test tests::io_slice_advance_slices ... ok
[INFO] [stdout] test tests::io_slice_mut_advance_slices ... ok
[INFO] [stdout] test tests::io_slice_advance_slices_beyond_total_length ... ok
[INFO] [stdout] test tests::io_slice_mut_advance_slices_empty_slice ... ok
[INFO] [stdout] test tests::io_slice_mut_advance_slices_beyond_total_length ... ok
[INFO] [stdout] test tests::io_slice_advance_slices_empty_slice ... ok
[INFO] [stdout] test tests::slice_size_hint ... ok
[INFO] [stdout] test tests::take_eof ... ok
[INFO] [stdout] test tests::take_size_hint ... ok
[INFO] [stdout] test tests::util::empty_reads ... ok
[INFO] [stdout] test tests::util::copy_copies ... ok
[INFO] [stdout] test tests::util::empty_seeks ... ok
[INFO] [stdout] test tests::util::repeat_repeats ... ok
[INFO] [stdout] test tests::read_exact ... ok
[INFO] [stdout] test tests::util::take_some_bytes ... ok
[INFO] [stdout] test tests::util::sink_sinks ... ok
[INFO] [stdout] test tests::cursor::test_buf_writer_vectored ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/with_std.rs (/opt/rustwide/target/debug/deps/with_std-2714f363f5823aa0)
[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]    Doc-tests acid_io
[INFO] [stdout] 
[INFO] [stdout] running 44 tests
[INFO] [stdout] test src/io_core.rs - io_core::Cursor<T>::into_inner (line 1823) ... ok
[INFO] [stdout] test src/error.rs - error::ErrorTrait::source (line 43) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Cursor<T>::is_empty (line 1950) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Cursor (line 1768) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Read (line 394) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Chain<T,U>::get_ref (line 281) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Cursor<T>::set_position (line 1899) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::BufRead (line 882) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Cursor<T>::position (line 1877) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Read::bytes (line 688) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Read::by_ref (line 649) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Cursor<T>::get_mut (line 1860) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Chain<T,U>::get_mut (line 306) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Chain<T,U>::into_inner (line 260) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Read::read_exact (line 622) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Cursor<T>::remaining_slice (line 1925) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Take<T>::get_mut (line 180) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Cursor<T>::get_ref (line 1840) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Cursor<T>::new (line 1808) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Read::chain (line 716) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Read::take (line 756) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Write::flush (line 1358) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Take<T>::limit (line 94) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Write::by_ref (line 1585) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Take<T>::set_limit (line 116) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Take<T>::get_ref (line 156) ... ok
[INFO] [stdout] test src/error.rs - error::Error::from (line 599) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Take<T>::into_inner (line 136) ... ok
[INFO] [stdout] test src/io_slice.rs - io_slice::IoSlice<'a>::advance_slices (line 266) ... ok
[INFO] [stdout] test src/io_slice.rs - io_slice::IoSliceMut<'a>::advance_slices (line 150) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Write (line 1229) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Write::write_vectored (line 1305) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Write::write_all_vectored (line 1459) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Read::read (line 465) ... ok
[INFO] [stdout] test src/util.rs - util::copy (line 242) ... ok
[INFO] [stdout] test src/prelude.rs - prelude (line 6) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Write::write (line 1278) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Write::write_fmt (line 1525) ... ok
[INFO] [stdout] test src/io_slice.rs - io_slice::IoSliceMut<'a>::advance (line 121) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Write::write_all (line 1397) ... ok
[INFO] [stdout] test src/io_slice.rs - io_slice::IoSlice<'a>::advance (line 237) ... ok
[INFO] [stdout] test src/util.rs - util::repeat (line 94) ... ok
[INFO] [stdout] test src/util.rs - util::empty (line 23) ... ok
[INFO] [stdout] test src/util.rs - util::sink (line 158) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 44 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.33s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "bd1a0daa4a4c7df0717b3ecec6e6d6a8339ae6e68fe1c15eba33014be19fd67e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bd1a0daa4a4c7df0717b3ecec6e6d6a8339ae6e68fe1c15eba33014be19fd67e", kill_on_drop: false }`
[INFO] [stdout] bd1a0daa4a4c7df0717b3ecec6e6d6a8339ae6e68fe1c15eba33014be19fd67e