[INFO] fetching crate acid_io 0.1.0...
[INFO] testing acid_io-0.1.0 against 1.59.0 for beta-1.60-1
[INFO] extracting crate acid_io 0.1.0 into /workspace/builds/worker-27/source
[INFO] validating manifest of crates.io crate acid_io 0.1.0 on toolchain 1.59.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[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-27/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 037e4e9b09d0bf310a2fddd4fd157f4cc08d219d01854f2bfc5ac26db2e52831
[INFO] running `Command { std: "docker" "start" "-a" "037e4e9b09d0bf310a2fddd4fd157f4cc08d219d01854f2bfc5ac26db2e52831", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "037e4e9b09d0bf310a2fddd4fd157f4cc08d219d01854f2bfc5ac26db2e52831", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "037e4e9b09d0bf310a2fddd4fd157f4cc08d219d01854f2bfc5ac26db2e52831", kill_on_drop: false }`
[INFO] [stdout] 037e4e9b09d0bf310a2fddd4fd157f4cc08d219d01854f2bfc5ac26db2e52831
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/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" "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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7af6dacf7d36a2cdfea0da71ec422e11e877b5d9c14ac76c852f359e88a1516a
[INFO] running `Command { std: "docker" "start" "-a" "7af6dacf7d36a2cdfea0da71ec422e11e877b5d9c14ac76c852f359e88a1516a", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.119
[INFO] [stderr]    Compiling acid_io v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.26s
[INFO] running `Command { std: "docker" "inspect" "7af6dacf7d36a2cdfea0da71ec422e11e877b5d9c14ac76c852f359e88a1516a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7af6dacf7d36a2cdfea0da71ec422e11e877b5d9c14ac76c852f359e88a1516a", kill_on_drop: false }`
[INFO] [stdout] 7af6dacf7d36a2cdfea0da71ec422e11e877b5d9c14ac76c852f359e88a1516a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/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" "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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 75b775c9f2f6b2512bf66f4eea5080ca0c9f5ff751470eb3d6c130f09cccd326
[INFO] running `Command { std: "docker" "start" "-a" "75b775c9f2f6b2512bf66f4eea5080ca0c9f5ff751470eb3d6c130f09cccd326", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling acid_io v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.55s
[INFO] running `Command { std: "docker" "inspect" "75b775c9f2f6b2512bf66f4eea5080ca0c9f5ff751470eb3d6c130f09cccd326", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "75b775c9f2f6b2512bf66f4eea5080ca0c9f5ff751470eb3d6c130f09cccd326", kill_on_drop: false }`
[INFO] [stdout] 75b775c9f2f6b2512bf66f4eea5080ca0c9f5ff751470eb3d6c130f09cccd326
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-27/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" "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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 621df3f5e5013149a3d26eaba9202db67848b3d981b43b53df0556eac384e88b
[INFO] running `Command { std: "docker" "start" "-a" "621df3f5e5013149a3d26eaba9202db67848b3d981b43b53df0556eac384e88b", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/acid_io-59e56f37a7f2522d)
[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_beyond_total_length ... ok
[INFO] [stdout] test tests::io_slice_advance_slices ... ok
[INFO] [stdout] test tests::cursor::test_buf_writer_vectored ... ok
[INFO] [stdout] test tests::io_slice_advance_slices_empty_slice ... ok
[INFO] [stdout] test tests::io_slice_mut_advance_slices ... 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::read_exact ... 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::empty_seeks ... ok
[INFO] [stdout] test tests::util::sink_sinks ... ok
[INFO] [stdout] test tests::util::repeat_repeats ... ok
[INFO] [stdout] test tests::util::take_some_bytes ... ok
[INFO] [stdout] test tests::util::copy_copies ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/with_std.rs (/opt/rustwide/target/debug/deps/with_std-04b10f88369e72fc)
[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::Chain<T,U>::into_inner (line 260) ... 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::BufRead (line 882) ... 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 (line 1768) ... 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::Write::write_all_vectored (line 1459) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Take<T>::get_ref (line 156) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Read::read_exact (line 622) ... ok
[INFO] [stdout] test src/error.rs - error::ErrorTrait::source (line 43) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Read::chain (line 716) ... 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>::is_empty (line 1950) ... 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::Cursor<T>::remaining_slice (line 1925) ... 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::Take<T>::limit (line 94) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Take<T>::into_inner (line 136) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Read (line 394) ... 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::by_ref (line 1585) ... ok
[INFO] [stdout] test src/error.rs - error::Error::from (line 599) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Cursor<T>::into_inner (line 1823) ... 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::Cursor<T>::position (line 1877) ... ok
[INFO] [stdout] test src/prelude.rs - prelude (line 6) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Write::flush (line 1358) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Read::bytes (line 688) ... 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::by_ref (line 649) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Read::read (line 465) ... ok
[INFO] [stdout] test src/util.rs - util::empty (line 23) ... ok
[INFO] [stdout] test src/util.rs - util::repeat (line 94) ... ok
[INFO] [stdout] test src/util.rs - util::sink (line 158) ... 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::advance (line 237) ... ok
[INFO] [stdout] test src/io_slice.rs - io_slice::IoSliceMut::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_slice.rs - io_slice::IoSliceMut::advance (line 121) ... 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::IoSlice::advance_slices (line 266) ... ok
[INFO] [stdout] test src/util.rs - util::copy (line 242) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Write::write (line 1278) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 44 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.98s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "621df3f5e5013149a3d26eaba9202db67848b3d981b43b53df0556eac384e88b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "621df3f5e5013149a3d26eaba9202db67848b3d981b43b53df0556eac384e88b", kill_on_drop: false }`
[INFO] [stdout] 621df3f5e5013149a3d26eaba9202db67848b3d981b43b53df0556eac384e88b