[INFO] fetching crate ippusb 0.5.0...
[INFO] testing ippusb-0.5.0 against 1.90.0 for beta-1.91-3
[INFO] extracting crate ippusb 0.5.0 into /workspace/builds/worker-1-tc1/source
[INFO] started tweaking crates.io crate ippusb 0.5.0
[INFO] finished tweaking crates.io crate ippusb 0.5.0
[INFO] tweaked toml for crates.io crate ippusb 0.5.0 written to /workspace/builds/worker-1-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate ippusb 0.5.0 on toolchain 1.90.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.90.0" "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" "+1.90.0" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]      Locking 66 packages to latest compatible versions
[INFO] [stderr]       Adding hyper v0.14.32 (available: v1.7.0)
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.90.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded chunked_transfer v1.5.0
[INFO] [stderr]   Downloaded testing_logger v0.1.1
[INFO] [stderr]   Downloaded rusb v0.9.4
[INFO] [stderr]   Downloaded libusb1-sys v0.7.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+1.90.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 161eac32a0104ab1467e928ae0340cd37011cc9264fb6a479e55c4c2ad1d0ac4
[INFO] running `Command { std: "docker" "start" "-a" "161eac32a0104ab1467e928ae0340cd37011cc9264fb6a479e55c4c2ad1d0ac4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "161eac32a0104ab1467e928ae0340cd37011cc9264fb6a479e55c4c2ad1d0ac4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "161eac32a0104ab1467e928ae0340cd37011cc9264fb6a479e55c4c2ad1d0ac4", kill_on_drop: false }`
[INFO] [stdout] 161eac32a0104ab1467e928ae0340cd37011cc9264fb6a479e55c4c2ad1d0ac4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+1.90.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 14941e04abd53b0fbfc5d95bd2114a2826073d424e79069db4702dcee30a958f
[INFO] running `Command { std: "docker" "start" "-a" "14941e04abd53b0fbfc5d95bd2114a2826073d424e79069db4702dcee30a958f", kill_on_drop: false }`
[INFO] [stderr]    Compiling libusb1-sys v0.7.0
[INFO] [stderr]    Compiling syn v2.0.106
[INFO] [stderr]    Compiling rusb v0.9.4
[INFO] [stderr]    Compiling futures-task v0.3.31
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling log v0.4.28
[INFO] [stderr]    Compiling chunked_transfer v1.5.0
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling tokio-macros v2.5.0
[INFO] [stderr]    Compiling tokio v1.47.1
[INFO] [stderr]    Compiling hyper v0.14.32
[INFO] [stderr]    Compiling ippusb v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 15.53s
[INFO] running `Command { std: "docker" "inspect" "14941e04abd53b0fbfc5d95bd2114a2826073d424e79069db4702dcee30a958f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "14941e04abd53b0fbfc5d95bd2114a2826073d424e79069db4702dcee30a958f", kill_on_drop: false }`
[INFO] [stdout] 14941e04abd53b0fbfc5d95bd2114a2826073d424e79069db4702dcee30a958f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+1.90.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] bf0fbeeae583230eaeb66d08300fe0299c2c0e601f81bdb154fda36767a5b792
[INFO] running `Command { std: "docker" "start" "-a" "bf0fbeeae583230eaeb66d08300fe0299c2c0e601f81bdb154fda36767a5b792", kill_on_drop: false }`
[INFO] [stderr]    Compiling testing_logger v0.1.1
[INFO] [stderr]    Compiling ippusb v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.86s
[INFO] running `Command { std: "docker" "inspect" "bf0fbeeae583230eaeb66d08300fe0299c2c0e601f81bdb154fda36767a5b792", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bf0fbeeae583230eaeb66d08300fe0299c2c0e601f81bdb154fda36767a5b792", kill_on_drop: false }`
[INFO] [stdout] bf0fbeeae583230eaeb66d08300fe0299c2c0e601f81bdb154fda36767a5b792
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+1.90.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 60d09cca85b773e4b0dc4a622cd3b2d8c0bfb475a9c81f5f424c4330dc994319
[INFO] running `Command { std: "docker" "start" "-a" "60d09cca85b773e4b0dc4a622cd3b2d8c0bfb475a9c81f5f424c4330dc994319", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ippusb-b2fcbcd4a64eb4b5)
[INFO] [stdout] 
[INFO] [stdout] running 31 tests
[INFO] [stdout] test device_info::tests::compare_lowest_alternate_first ... ok
[INFO] [stdout] test http::tests::body_length_nonascii_header ... ok
[INFO] [stdout] test http::tests::body_length_nonzero_header ... ok
[INFO] [stdout] test http::tests::body_length_no_header ... ok
[INFO] [stdout] test http::tests::body_length_invalid_number ... ok
[INFO] [stdout] test http::tests::body_length_zero_header ... ok
[INFO] [stdout] test http::tests::body_support ... ok
[INFO] [stdout] test http::tests::copy_request_header ... ok
[INFO] [stdout] test http::tests::extract_content_type ... ok
[INFO] [stdout] test device_info::tests::compare_lowest_interface_first ... ok
[INFO] [stdout] test http::tests::e2e_header ... ok
[INFO] [stdout] test http::tests::response_reader_chunked_response ... ok
[INFO] [stdout] test http::tests::response_reader_missing_header_end ... ok
[INFO] [stdout] test http::tests::rewrite_request_chunked_body ... ok
[INFO] [stdout] test http::tests::response_reader_invalid_http_version ... ok
[INFO] [stdout] test http::tests::response_reader_empty_response ... ok
[INFO] [stdout] test io_adapters::tests::logging_writer_single ... ok
[INFO] [stdout] test http::tests::response_reader_invalid_status_line ... ok
[INFO] [stdout] test http::tests::copy_response_static ... ok
[INFO] [stdout] test http::tests::copy_response_empty ... ok
[INFO] [stdout] test http::tests::rewrite_request_small_body ... ok
[INFO] [stdout] test http::tests::response_reader_static_response ... ok
[INFO] [stdout] test http::tests::rewrite_request_large_body ... ok
[INFO] [stdout] test io_adapters::tests::chunked_writer ... ok
[INFO] [stdout] test io_adapters::tests::complete_reader ... ok
[INFO] [stdout] test io_adapters::tests::logging_writer_multiple ... ok
[INFO] [stdout] test http::tests::rewrite_request_no_body ... ok
[INFO] [stdout] test io_adapters::tests::logging_reader ... ok
[INFO] [stdout] test io_adapters::tests::logging_writer_empty ... ok
[INFO] [stdout] test http::tests::test_read_until_delimiter ... ok
[INFO] [stdout] test http::tests::copy_response_chunked ... ok
[INFO] [stderr]    Doc-tests ippusb
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/lib.rs - (line 35) - compile ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.18s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "60d09cca85b773e4b0dc4a622cd3b2d8c0bfb475a9c81f5f424c4330dc994319", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "60d09cca85b773e4b0dc4a622cd3b2d8c0bfb475a9c81f5f424c4330dc994319", kill_on_drop: false }`
[INFO] [stdout] 60d09cca85b773e4b0dc4a622cd3b2d8c0bfb475a9c81f5f424c4330dc994319