[INFO] fetching crate rhymuweb 1.2.1...
[INFO] testing rhymuweb-1.2.1 against master#a77da2d454e6caa227a85b16410b95f93495e7e0 for pr-91031
[INFO] extracting crate rhymuweb 1.2.1 into /workspace/builds/worker-84/source
[INFO] validating manifest of crates.io crate rhymuweb 1.2.1 on toolchain a77da2d454e6caa227a85b16410b95f93495e7e0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate rhymuweb 1.2.1
[INFO] finished tweaking crates.io crate rhymuweb 1.2.1
[INFO] tweaked toml for crates.io crate rhymuweb 1.2.1 written to /workspace/builds/worker-84/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "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" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 3807b036b922be9a96df35f91ac23dbc97d10c08d080943d6502d027a0497ce2
[INFO] running `Command { std: "docker" "start" "-a" "3807b036b922be9a96df35f91ac23dbc97d10c08d080943d6502d027a0497ce2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3807b036b922be9a96df35f91ac23dbc97d10c08d080943d6502d027a0497ce2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3807b036b922be9a96df35f91ac23dbc97d10c08d080943d6502d027a0497ce2", kill_on_drop: false }`
[INFO] [stdout] 3807b036b922be9a96df35f91ac23dbc97d10c08d080943d6502d027a0497ce2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] fcc5ccdded6fd8291917755f9d8d7cba2911e4b5c08f28d3858bdd60b4d27838
[INFO] running `Command { std: "docker" "start" "-a" "fcc5ccdded6fd8291917755f9d8d7cba2911e4b5c08f28d3858bdd60b4d27838", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v0.15.44
[INFO] [stderr]    Compiling crc32fast v1.2.1
[INFO] [stderr]    Compiling encoding_rs v0.8.29
[INFO] [stderr]    Compiling miniz_oxide v0.4.4
[INFO] [stderr]    Compiling thiserror-impl v1.0.30
[INFO] [stderr]    Compiling flate2 v1.0.22
[INFO] [stderr]    Compiling thiserror v1.0.30
[INFO] [stderr]    Compiling named_tuple v0.1.3
[INFO] [stderr]    Compiling rhymessage v1.3.1
[INFO] [stderr]    Compiling rhymuri v1.3.1
[INFO] [stderr]    Compiling rhymuweb v1.2.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 15.49s
[INFO] running `Command { std: "docker" "inspect" "fcc5ccdded6fd8291917755f9d8d7cba2911e4b5c08f28d3858bdd60b4d27838", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fcc5ccdded6fd8291917755f9d8d7cba2911e4b5c08f28d3858bdd60b4d27838", kill_on_drop: false }`
[INFO] [stdout] fcc5ccdded6fd8291917755f9d8d7cba2911e4b5c08f28d3858bdd60b4d27838
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c4cdff2b60b43a196a91db7954cdc168b533629151bbb3dd249af7fced54de11
[INFO] running `Command { std: "docker" "start" "-a" "c4cdff2b60b43a196a91db7954cdc168b533629151bbb3dd249af7fced54de11", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling rhymuweb v1.2.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.47s
[INFO] running `Command { std: "docker" "inspect" "c4cdff2b60b43a196a91db7954cdc168b533629151bbb3dd249af7fced54de11", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c4cdff2b60b43a196a91db7954cdc168b533629151bbb3dd249af7fced54de11", kill_on_drop: false }`
[INFO] [stdout] c4cdff2b60b43a196a91db7954cdc168b533629151bbb3dd249af7fced54de11
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 8618116cbd54c7e99132d2ea13583b90d4d6f85c8d3a11bacd6c33539c5ed58d
[INFO] running `Command { std: "docker" "start" "-a" "8618116cbd54c7e99132d2ea13583b90d4d6f85c8d3a11bacd6c33539c5ed58d", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.79s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/rhymuweb-61ba7d148375df7e)
[INFO] [stdout] 
[INFO] [stdout] running 75 tests
[INFO] [stdout] test chunked_body::tests::decode_bad_chunk_size_line_chunk_size_overflow ... ok
[INFO] [stdout] test chunked_body::tests::decode_bad_chunk_size_line_not_hexdig_in_chunk_size ... ok
[INFO] [stdout] test chunked_body::tests::decode_bad_trailer ... ok
[INFO] [stdout] test chunked_body::tests::decode_bad_junk_after_chunk ... ok
[INFO] [stdout] test chunked_body::tests::decode_empty_body_multiple_zeroes ... ok
[INFO] [stdout] test chunked_body::tests::decode_empty_body_with_chunk_extension_no_value ... ok
[INFO] [stdout] test chunked_body::tests::decode_empty_body_with_chunk_extension_with_quoted_value ... ok
[INFO] [stdout] test chunked_body::tests::decode_empty_body_with_chunk_extension_with_unquoted_value ... ok
[INFO] [stdout] test chunked_body::tests::decode_empty_body_with_multiple_chunk_extensions ... ok
[INFO] [stdout] test chunked_body::tests::decode_simple_empty_body_one_character_at_a_time ... ok
[INFO] [stdout] test chunked_body::tests::decode_simple_empty_body_one_piece ... ok
[INFO] [stdout] test chunked_body::tests::decode_simple_empty_body_one_piece_with_extra_stuff_after ... ok
[INFO] [stdout] test chunked_body::tests::decode_simple_empty_body_two_pieces ... ok
[INFO] [stdout] test chunked_body::tests::decode_simple_non_empty_body_one_character_at_a_time ... ok
[INFO] [stdout] test chunked_body::tests::decode_simple_non_empty_body_one_piece ... ok
[INFO] [stdout] test chunked_body::tests::decode_trailers_one_piece ... ok
[INFO] [stdout] test chunked_body::tests::decode_trailers_one_character_at_a_time ... ok
[INFO] [stdout] test chunked_body::tests::decode_two_chunk_body_one_piece ... ok
[INFO] [stdout] test chunked_body::tests::decode_two_chunk_body_one_character_at_a_time ... ok
[INFO] [stdout] test coding::tests::body_to_string_default_encoding_iso_8859_1 ... ok
[INFO] [stdout] test coding::tests::body_to_string_invalid_encoding_utf8 ... ok
[INFO] [stdout] test coding::tests::body_to_string_valid_encoding_iso_8859_1 ... ok
[INFO] [stdout] test coding::tests::body_to_string_valid_encoding_utf_8 ... ok
[INFO] [stdout] test coding::tests::decode_body_not_encoded ... ok
[INFO] [stdout] test coding::tests::gzip_decode_empty_input ... ok
[INFO] [stdout] test coding::tests::deflate_decode_empty_input ... ok
[INFO] [stdout] test coding::tests::decode_body_deflated_then_gzipped ... ok
[INFO] [stdout] test coding::tests::gzip_decode_empty_output ... ok
[INFO] [stdout] test coding::tests::decode_body_unknown_coding_then_gzipped ... ok
[INFO] [stdout] test coding::tests::deflate_decode_empty_output ... ok
[INFO] [stdout] test coding::tests::deflate_decode_junk ... ok
[INFO] [stdout] test coding::tests::decode_body_gzipped ... ok
[INFO] [stdout] test request::tests::generate_get_request ... ok
[INFO] [stdout] test request::tests::generate_put_request ... ok
[INFO] [stdout] test request::tests::max_message_size_checked_for_total ... ok
[INFO] [stdout] test coding::tests::gzip_decode_junk ... ok
[INFO] [stdout] test request::tests::parse_get_request_ascii_target_uri ... ok
[INFO] [stdout] test request::tests::max_message_size_checked_for_headers ... ok
[INFO] [stdout] test coding::tests::deflate_decode_non_empty_input ... ok
[INFO] [stdout] test request::tests::parse_get_request_non_ascii_target_uri ... ok
[INFO] [stdout] test request::tests::parse_incomplete_body_request ... ok
[INFO] [stdout] test coding::tests::gzip_decode_non_empty_input ... ok
[INFO] [stdout] test request::tests::parse_incomplete_headers_between_lines_request ... ok
[INFO] [stdout] test request::tests::parse_incomplete_no_headers_request ... ok
[INFO] [stdout] test request::tests::parse_incomplete_headers_mid_line_request ... ok
[INFO] [stdout] test request::tests::parse_incomplete_request_line ... ok
[INFO] [stdout] test request::tests::parse_invalid_body_insanely_too_large ... ok
[INFO] [stdout] test request::tests::parse_invalid_damaged_header ... ok
[INFO] [stdout] test request::tests::parse_invalid_header_line_too_long ... ok
[INFO] [stdout] test request::tests::parse_invalid_request_empty_protocol ... ok
[INFO] [stdout] test request::tests::parse_invalid_request_no_method_delimiter ... ok
[INFO] [stdout] test request::tests::parse_invalid_request_no_protocol ... ok
[INFO] [stdout] test request::tests::parse_invalid_request_empty_method ... ok
[INFO] [stdout] test request::tests::parse_invalid_request_bad_protocol ... ok
[INFO] [stdout] test request::tests::parse_invalid_request_line_too_long ... ok
[INFO] [stdout] test request::tests::parse_invalid_body_slightly_too_large ... ok
[INFO] [stdout] test request::tests::parse_invalid_request_no_target ... ok
[INFO] [stdout] test request::tests::parse_post_request ... ok
[INFO] [stdout] test response::tests::generate_get_response ... ok
[INFO] [stdout] test request::tests::request_with_no_content_length_or_chunked_transfer_encoding_has_no_body ... ok
[INFO] [stdout] test response::tests::parse_get_response_with_body_and_content_length ... ok
[INFO] [stdout] test request::tests::parse_valid_header_line_longer_than_default ... ok
[INFO] [stdout] test response::tests::parse_get_response_with_chunked_body_with_other_transfer_coding ... ok
[INFO] [stdout] test response::tests::parse_incomplete_headers_between_lines_response ... ok
[INFO] [stdout] test response::tests::parse_incomplete_body_response ... ok
[INFO] [stdout] test response::tests::parse_get_response_with_chunked_body_no_other_transfer_coding ... ok
[INFO] [stdout] test response::tests::parse_incomplete_headers_mid_line_response ... ok
[INFO] [stdout] test response::tests::parse_incomplete_status_line ... ok
[INFO] [stdout] test response::tests::parse_invalid_damaged_header ... ok
[INFO] [stdout] test response::tests::parse_invalid_response_no_protocol ... ok
[INFO] [stdout] test response::tests::parse_invalid_response_no_reason_phrase ... ok
[INFO] [stdout] test response::tests::parse_invalid_response_no_status_code ... ok
[INFO] [stdout] test response::tests::parse_no_headers_response ... ok
[INFO] [stdout] test response::tests::parse_response_trailer ... ok
[INFO] [stdout] test response::tests::response_with_no_content_length_or_chunked_transfer_encoding_has_no_body ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 75 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests rhymuweb
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test src/request.rs - request::Request::generate (line 152) ... ok
[INFO] [stdout] test src/response.rs - response::Response::parse (line 227) ... ok
[INFO] [stdout] test src/request.rs - request::Request::parse (line 224) ... ok
[INFO] [stdout] test src/response.rs - response::Response::generate (line 134) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.17s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "8618116cbd54c7e99132d2ea13583b90d4d6f85c8d3a11bacd6c33539c5ed58d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8618116cbd54c7e99132d2ea13583b90d4d6f85c8d3a11bacd6c33539c5ed58d", kill_on_drop: false }`
[INFO] [stdout] 8618116cbd54c7e99132d2ea13583b90d4d6f85c8d3a11bacd6c33539c5ed58d