[INFO] fetching crate bitbuffer 0.10.5...
[INFO] testing bitbuffer-0.10.5 against master#61469b682c2b0bf9cebc4622f1859e2bb3b7ebca for pr-91743
[INFO] extracting crate bitbuffer 0.10.5 into /workspace/builds/worker-4/source
[INFO] validating manifest of crates.io crate bitbuffer 0.10.5 on toolchain 61469b682c2b0bf9cebc4622f1859e2bb3b7ebca
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+61469b682c2b0bf9cebc4622f1859e2bb3b7ebca" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate bitbuffer 0.10.5
[INFO] finished tweaking crates.io crate bitbuffer 0.10.5
[INFO] tweaked toml for crates.io crate bitbuffer 0.10.5 written to /workspace/builds/worker-4/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+61469b682c2b0bf9cebc4622f1859e2bb3b7ebca" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+61469b682c2b0bf9cebc4622f1859e2bb3b7ebca" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded iai v0.1.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+61469b682c2b0bf9cebc4622f1859e2bb3b7ebca" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 1d2f069bb5674ae3507eb32c34d6e73cd943b134d789bcde18569594ca70da3a
[INFO] running `Command { std: "docker" "start" "-a" "1d2f069bb5674ae3507eb32c34d6e73cd943b134d789bcde18569594ca70da3a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1d2f069bb5674ae3507eb32c34d6e73cd943b134d789bcde18569594ca70da3a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1d2f069bb5674ae3507eb32c34d6e73cd943b134d789bcde18569594ca70da3a", kill_on_drop: false }`
[INFO] [stdout] 1d2f069bb5674ae3507eb32c34d6e73cd943b134d789bcde18569594ca70da3a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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" "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:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+61469b682c2b0bf9cebc4622f1859e2bb3b7ebca" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f77802af5fca9c0e10bb1bc4b4dda7b2c9b82bc9fe90a247753191456108f270
[INFO] running `Command { std: "docker" "start" "-a" "f77802af5fca9c0e10bb1bc4b4dda7b2c9b82bc9fe90a247753191456108f270", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling proc-macro2 v1.0.37
[INFO] [stderr]    Compiling unicode-xid v0.2.2
[INFO] [stderr]    Compiling version_check v0.9.4
[INFO] [stderr]    Compiling syn v1.0.92
[INFO] [stderr]    Compiling rustversion v1.0.6
[INFO] [stderr]    Compiling autocfg v1.1.0
[INFO] [stderr]    Compiling memchr v2.5.0
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling quote v1.0.18
[INFO] [stderr]    Compiling err-derive v0.3.1
[INFO] [stderr]    Compiling synstructure v0.12.6
[INFO] [stderr]    Compiling syn_util v0.4.2
[INFO] [stderr]    Compiling bitbuffer_derive v0.10.0
[INFO] [stderr]    Compiling bitbuffer v0.10.5 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.58s
[INFO] running `Command { std: "docker" "inspect" "f77802af5fca9c0e10bb1bc4b4dda7b2c9b82bc9fe90a247753191456108f270", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f77802af5fca9c0e10bb1bc4b4dda7b2c9b82bc9fe90a247753191456108f270", kill_on_drop: false }`
[INFO] [stdout] f77802af5fca9c0e10bb1bc4b4dda7b2c9b82bc9fe90a247753191456108f270
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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" "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:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+61469b682c2b0bf9cebc4622f1859e2bb3b7ebca" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 59875ecfdae6141870218424dd57840a688a8501a372995a7bba3486cd0aca0d
[INFO] running `Command { std: "docker" "start" "-a" "59875ecfdae6141870218424dd57840a688a8501a372995a7bba3486cd0aca0d", 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 serde v1.0.137
[INFO] [stderr]    Compiling serde_json v1.0.80
[INFO] [stderr]    Compiling ryu v1.0.9
[INFO] [stderr]    Compiling itoa v1.0.1
[INFO] [stderr]    Compiling maplit v1.0.2
[INFO] [stderr]    Compiling iai v0.1.1
[INFO] [stderr]    Compiling bitbuffer v0.10.5 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 5.64s
[INFO] [stderr]   Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/bitbuffer-4e4c9fe0b226eae8)
[INFO] [stderr]   Executable tests/read_tests.rs (/opt/rustwide/target/debug/deps/read_tests-9c11ebc6105de3f8)
[INFO] [stderr]   Executable tests/roundtrip.rs (/opt/rustwide/target/debug/deps/roundtrip-f44cb075510ca8f2)
[INFO] [stderr]   Executable tests/write_tests.rs (/opt/rustwide/target/debug/deps/write_tests-363bd72c96561934)
[INFO] running `Command { std: "docker" "inspect" "59875ecfdae6141870218424dd57840a688a8501a372995a7bba3486cd0aca0d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "59875ecfdae6141870218424dd57840a688a8501a372995a7bba3486cd0aca0d", kill_on_drop: false }`
[INFO] [stdout] 59875ecfdae6141870218424dd57840a688a8501a372995a7bba3486cd0aca0d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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" "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:d190cb871061d98bc6d0581d85cb2ecb09a0f8a142ba5463de30be9999fc3251" "/opt/rustwide/cargo-home/bin/cargo" "+61469b682c2b0bf9cebc4622f1859e2bb3b7ebca" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 268ecd0230fef2a2973853be17fdca468bc1eaf0deb406a1137ab2f79f5d8677
[INFO] running `Command { std: "docker" "start" "-a" "268ecd0230fef2a2973853be17fdca468bc1eaf0deb406a1137ab2f79f5d8677", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bitbuffer-4e4c9fe0b226eae8)
[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/read_tests.rs (/opt/rustwide/target/debug/deps/read_tests-9c11ebc6105de3f8)
[INFO] [stdout] 
[INFO] [stdout] running 32 tests
[INFO] [stdout] test read_f32_le ... ok
[INFO] [stdout] test read_f64_le ... ok
[INFO] [stdout] test read_i16_be ... ok
[INFO] [stdout] test read_i16_le ... ok
[INFO] [stdout] test read_i8_be ... ok
[INFO] [stdout] test read_i8_le ... ok
[INFO] [stdout] test read_i64_be ... ok
[INFO] [stdout] test read_i32_le ... ok
[INFO] [stdout] test read_i64_le ... ok
[INFO] [stdout] test read_u64_be ... ok
[INFO] [stdout] test read_u32_be ... ok
[INFO] [stdout] test read_trait ... ok
[INFO] [stdout] test read_sized_trait_unchecked ... ok
[INFO] [stdout] test read_u8_be ... ok
[INFO] [stdout] test read_u32_le ... ok
[INFO] [stdout] test read_u16_le ... ok
[INFO] [stdout] test read_u64_le ... ok
[INFO] [stdout] test read_sized_trait ... ok
[INFO] [stdout] test read_u16_be ... ok
[INFO] [stdout] test read_i32_be ... ok
[INFO] [stdout] test test_read_str_le ... ok
[INFO] [stdout] test test_from ... ok
[INFO] [stdout] test test_read_struct ... ok
[INFO] [stdout] test read_trait_unchecked ... ok
[INFO] [stdout] test test_read_str_be ... ok
[INFO] [stdout] test test_invalid_utf8 ... ok
[INFO] [stdout] test read_read_signed ... ok
[INFO] [stdout] test test_to_owned_stream ... ok
[INFO] [stdout] test read_u8_le ... ok
[INFO] [stdout] test test_read_nonzero ... ok
[INFO] [stdout] test test_read_str_no_null_termination_le ... ok
[INFO] [stdout] test test_read_str_no_null_termination_be ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 32 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/roundtrip.rs (/opt/rustwide/target/debug/deps/roundtrip-f44cb075510ca8f2)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test test_tuple ... ok
[INFO] [stdout] test test_bare_enum ... ok
[INFO] [stdout] test test_field_enum ... ok
[INFO] [stdout] test test_array ... ok
[INFO] [stdout] test test_basic_struct ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/write_tests.rs (/opt/rustwide/target/debug/deps/write_tests-363bd72c96561934)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test test_write_float_le ... ok
[INFO] [stdout] test test_write_float_be ... ok
[INFO] [stdout] test test_write_bool_number_be ... ok
[INFO] [stdout] test test_write_string_le_unaligned ... ok
[INFO] [stdout] test test_write_string_le ... ok
[INFO] [stdout] test test_write_bool_be ... ok
[INFO] [stdout] test test_write_bool_le ... ok
[INFO] [stdout] test test_write_container ... ok
[INFO] [stdout] test test_write_signed ... ok
[INFO] [stdout] test test_write_bool_number_le ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests bitbuffer
[INFO] [stdout] 
[INFO] [stdout] running 43 tests
[INFO] [stdout] test src/read.rs - read::BitReadSized (line 415) ... ok
[INFO] [stdout] test src/write.rs - write::BitWriteSized (line 245) ... ok
[INFO] [stdout] test src/read.rs - read::BitRead (line 76) ... ok
[INFO] [stdout] test src/writestream.rs - writestream::BitWriteStream::write_bool (line 95) ... ok
[INFO] [stdout] test src/readbuffer.rs - readbuffer::BitReadBuffer::read_bool (line 272) ... ok
[INFO] [stdout] test src/readbuffer.rs - readbuffer::BitReadBuffer::new_owned (line 167) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::new (line 48) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::pos (line 486) ... ok
[INFO] [stdout] test src/readbuffer.rs - readbuffer::BitReadBuffer::read_int (line 330) ... ok
[INFO] [stdout] test src/readbuffer.rs - readbuffer::BitReadBuffer::read_bytes (line 468) ... ok
[INFO] [stdout] test src/readbuffer.rs - readbuffer::BitReadBuffer::new (line 117) ... ok
[INFO] [stdout] test src/read.rs - read::BitRead (line 64) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::read_bool (line 76) ... ok
[INFO] [stdout] test src/read.rs - read::BitReadSized (line 441) ... ok
[INFO] [stdout] test src/write.rs - write::BitWrite (line 23) ... ok
[INFO] [stdout] test src/writestream.rs - writestream::BitWriteStream (line 19) ... ok
[INFO] [stdout] test src/writestream.rs - writestream::BitWriteStream::write_string (line 250) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::bit_len (line 463) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::bits_left (line 511) ... ok
[INFO] [stdout] test src/write.rs - write::BitWriteSized (line 271) ... ok
[INFO] [stdout] test src/readbuffer.rs - readbuffer::BitReadBuffer::read_float (line 689) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::read_bits (line 349) ... ok
[INFO] [stdout] test src/read.rs - read::BitRead (line 31) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::read (line 536) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::read_float (line 172) ... ok
[INFO] [stdout] test src/writestream.rs - writestream::BitWriteStream::new (line 49) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream (line 18) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::read (line 555) ... ok
[INFO] [stdout] test src/writestream.rs - writestream::BitWriteStream::write_bytes (line 196) ... ok
[INFO] [stdout] test src/write.rs - write::BitWrite (line 54) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::set_pos (line 429) ... ok
[INFO] [stdout] test src/write.rs - write::BitWrite (line 66) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::read_bytes (line 223) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::read_int (line 121) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::read_sized (line 601) ... ok
[INFO] [stdout] test src/readbuffer.rs - readbuffer::BitReadBuffer::read_string (line 563) ... ok
[INFO] [stdout] test src/lib.rs - (line 26) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::read_sized (line 618) ... ok
[INFO] [stdout] test src/readbuffer.rs - readbuffer::BitReadBuffer (line 84) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::skip_bits (line 390) ... ok
[INFO] [stdout] test src/writestream.rs - writestream::BitWriteStream::write_float (line 164) ... ok
[INFO] [stdout] test src/readstream.rs - readstream::BitReadStream::read_string (line 272) ... ok
[INFO] [stdout] test src/writestream.rs - writestream::BitWriteStream::write_int (line 118) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 43 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.52s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "268ecd0230fef2a2973853be17fdca468bc1eaf0deb406a1137ab2f79f5d8677", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "268ecd0230fef2a2973853be17fdca468bc1eaf0deb406a1137ab2f79f5d8677", kill_on_drop: false }`
[INFO] [stdout] 268ecd0230fef2a2973853be17fdca468bc1eaf0deb406a1137ab2f79f5d8677