[INFO] fetching crate acid_io 0.1.0...
[INFO] testing acid_io-0.1.0 against 1.60.0 for beta-1.61-1
[INFO] extracting crate acid_io 0.1.0 into /workspace/builds/worker-20/source
[INFO] validating manifest of crates.io crate acid_io 0.1.0 on toolchain 1.60.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.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-20/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.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.60.0" "fetch" "--manifest-path" "Cargo.toml", 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]  Downloading crates ...
[INFO] [stderr]   Downloaded windows_x86_64_gnu v0.29.0
[INFO] [stderr]   Downloaded windows_x86_64_msvc v0.29.0
[INFO] [stderr]   Downloaded windows_aarch64_msvc v0.29.0
[INFO] [stderr]   Downloaded windows_i686_gnu v0.29.0
[INFO] [stderr]   Downloaded windows_i686_msvc v0.29.0
[INFO] [stderr]   Downloaded windows v0.29.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] d4159a74ba3fe9bdcb914948e056e64935f42e9868f069bdbddf698422296251
[INFO] running `Command { std: "docker" "start" "-a" "d4159a74ba3fe9bdcb914948e056e64935f42e9868f069bdbddf698422296251", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d4159a74ba3fe9bdcb914948e056e64935f42e9868f069bdbddf698422296251", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d4159a74ba3fe9bdcb914948e056e64935f42e9868f069bdbddf698422296251", kill_on_drop: false }`
[INFO] [stdout] d4159a74ba3fe9bdcb914948e056e64935f42e9868f069bdbddf698422296251
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 470bed74ae51bb5ad0ed288c108c83f789788e3d43997defe9e4d20f498a973a
[INFO] running `Command { std: "docker" "start" "-a" "470bed74ae51bb5ad0ed288c108c83f789788e3d43997defe9e4d20f498a973a", 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 dev [unoptimized + debuginfo] target(s) in 2.21s
[INFO] running `Command { std: "docker" "inspect" "470bed74ae51bb5ad0ed288c108c83f789788e3d43997defe9e4d20f498a973a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "470bed74ae51bb5ad0ed288c108c83f789788e3d43997defe9e4d20f498a973a", kill_on_drop: false }`
[INFO] [stdout] 470bed74ae51bb5ad0ed288c108c83f789788e3d43997defe9e4d20f498a973a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 0c82399f41082178e0aa7202721e41e8e969b60b34e523b00a2db1179bbc5527
[INFO] running `Command { std: "docker" "start" "-a" "0c82399f41082178e0aa7202721e41e8e969b60b34e523b00a2db1179bbc5527", kill_on_drop: false }`
[INFO] [stderr]    Compiling acid_io v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.41s
[INFO] running `Command { std: "docker" "inspect" "0c82399f41082178e0aa7202721e41e8e969b60b34e523b00a2db1179bbc5527", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0c82399f41082178e0aa7202721e41e8e969b60b34e523b00a2db1179bbc5527", kill_on_drop: false }`
[INFO] [stdout] 0c82399f41082178e0aa7202721e41e8e969b60b34e523b00a2db1179bbc5527
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-20/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 29ee74cb71032c2d1367e7a3874ee80a724adef44392226c8597dd9da5de6485
[INFO] running `Command { std: "docker" "start" "-a" "29ee74cb71032c2d1367e7a3874ee80a724adef44392226c8597dd9da5de6485", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/acid_io-88d90d40677fadad)
[INFO] [stdout] 
[INFO] [stdout] running 25 tests
[INFO] [stderr]      Running tests/with_std.rs (/opt/rustwide/target/debug/deps/with_std-e5b0af438a03719a)
[INFO] [stdout] test tests::cursor::seek_before_0 ... ok
[INFO] [stdout] test tests::chain_empty_size_hint ... ok
[INFO] [stdout] test tests::cursor::seek_past_i64 ... ok
[INFO] [stdout] test tests::cursor::seek_past_end ... ok
[INFO] [stdout] test tests::cursor::test_buf_writer ... ok
[INFO] [stdout] test tests::io_slice_advance_slices_beyond_total_length ... ok
[INFO] [stdout] test tests::cursor::test_buf_writer_error ... ok
[INFO] [stdout] test tests::io_slice_advance_slices_empty_slice ... ok
[INFO] [stdout] test tests::empty_size_hint ... ok
[INFO] [stdout] test tests::io_slice_mut_advance_slices_beyond_total_length ... ok
[INFO] [stdout] test tests::cursor::test_buf_writer_seek ... ok
[INFO] [stdout] test tests::io_slice_mut_advance_slices_empty_slice ... ok
[INFO] [stdout] test tests::take_size_hint ... ok
[INFO] [stdout] test tests::util::empty_seeks ... ok
[INFO] [stdout] test tests::read_exact ... ok
[INFO] [stdout] test tests::util::repeat_repeats ... ok
[INFO] [stdout] test tests::util::sink_sinks ... ok
[INFO] [stdout] test tests::take_eof ... ok
[INFO] [stdout] test tests::util::empty_reads ... ok
[INFO] [stdout] test tests::slice_size_hint ... ok
[INFO] [stdout] test tests::util::copy_copies ... 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_mut_advance_slices ... ok
[INFO] [stdout] test tests::util::take_some_bytes ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests acid_io
[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] [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::Read::take (line 756) ... 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>::remaining_slice (line 1925) ... 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::Cursor<T>::position (line 1877) ... ok
[INFO] [stdout] test src/util.rs - util::copy (line 242) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Read (line 394) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::BufRead (line 882) ... ok
[INFO] [stdout] test src/error.rs - error::ErrorTrait::source (line 43) ... ok
[INFO] [stdout] test src/error.rs - error::Error::from (line 599) ... ok
[INFO] [stdout] test src/prelude.rs - prelude (line 6) ... 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/io_core.rs - io_core::Take<T>::set_limit (line 116) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Write::write (line 1278) ... 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::Write::write_vectored (line 1305) ... 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::Take<T>::limit (line 94) ... 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::Take<T>::get_mut (line 180) ... 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_mut (line 306) ... ok
[INFO] [stdout] test src/util.rs - util::sink (line 158) ... 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::Read::by_ref (line 649) ... 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::Write::write_all (line 1397) ... ok
[INFO] [stdout] test src/io_slice.rs - io_slice::IoSliceMut::advance (line 121) ... 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::Cursor<T>::set_position (line 1899) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Write::flush (line 1358) ... ok
[INFO] [stdout] test src/io_slice.rs - io_slice::IoSlice::advance (line 237) ... 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::Write (line 1229) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Read::read (line 465) ... 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::read_exact (line 622) ... ok
[INFO] [stdout] test src/io_slice.rs - io_slice::IoSlice::advance_slices (line 266) ... 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::Take<T>::get_ref (line 156) ... ok
[INFO] [stdout] test src/io_core.rs - io_core::Write::write_fmt (line 1525) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 44 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.20s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "29ee74cb71032c2d1367e7a3874ee80a724adef44392226c8597dd9da5de6485", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "29ee74cb71032c2d1367e7a3874ee80a724adef44392226c8597dd9da5de6485", kill_on_drop: false }`
[INFO] [stdout] 29ee74cb71032c2d1367e7a3874ee80a724adef44392226c8597dd9da5de6485