[INFO] fetching crate websocket-extensions 0.2.0...
[INFO] testing websocket-extensions-0.2.0 against 1.99.0-beta.8 for beta-1.100-2
[INFO] extracting crate websocket-extensions 0.2.0 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate websocket-extensions 0.2.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate websocket-extensions 0.2.0
[INFO] tweaked toml for crates.io crate websocket-extensions 0.2.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate websocket-extensions 0.2.0 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate websocket-extensions 0.2.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 3016684e264154ac39559171b7f97fcf21bab223f816d928ab1242c24f893fe2
[INFO] running `Command { std: "docker" "start" "3016684e264154ac39559171b7f97fcf21bab223f816d928ab1242c24f893fe2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3016684e264154ac39559171b7f97fcf21bab223f816d928ab1242c24f893fe2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3016684e264154ac39559171b7f97fcf21bab223f816d928ab1242c24f893fe2" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3016684e264154ac39559171b7f97fcf21bab223f816d928ab1242c24f893fe2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3016684e264154ac39559171b7f97fcf21bab223f816d928ab1242c24f893fe2" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling websocket-extensions v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.78s
[INFO] running `Command { std: "docker" "inspect" "3016684e264154ac39559171b7f97fcf21bab223f816d928ab1242c24f893fe2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3016684e264154ac39559171b7f97fcf21bab223f816d928ab1242c24f893fe2" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling websocket-extensions v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.19s
[INFO] running `Command { std: "docker" "inspect" "3016684e264154ac39559171b7f97fcf21bab223f816d928ab1242c24f893fe2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3016684e264154ac39559171b7f97fcf21bab223f816d928ab1242c24f893fe2" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/websocket_extensions-5b78b895daecb117)
[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/client_sessions.rs (/opt/rustwide/target/debug/deps/client_sessions-b03bc765c08ebe89)
[INFO] [stdout] 
[INFO] [stdout] running 21 tests
[INFO] [stdout] test asks_the_session_to_generate_an_offer ... ok
[INFO] [stdout] test activates_one_session_with_a_string_param ... ok
[INFO] [stdout] test does_not_activate_sessions_not_named_in_the_header ... ok
[INFO] [stdout] test a_rejected_response_can_be_retried_without_a_spurious_conflict ... ok
[INFO] [stdout] test does_not_throw_for_one_potentially_conflicting_extension ... ok
[INFO] [stdout] test does_not_throw_for_two_non_conflicting_extensions ... ok
[INFO] [stdout] test does_not_throw_if_given_registered_extensions ... ok
[INFO] [stdout] test asks_the_extension_to_create_a_client_session ... ok
[INFO] [stdout] test returns_the_serialized_offer_from_the_session ... ok
[INFO] [stdout] test returns_multiple_serialized_offers_from_the_session ... ok
[INFO] [stderr]      Running tests/extensions_add.rs (/opt/rustwide/target/debug/deps/extensions_add-cea9fcf2ac7dafe9)
[INFO] [stdout] test returns_a_null_offer_from_the_session ... ok
[INFO] [stdout] test activates_one_session_with_a_boolean_param ... ok
[INFO] [stdout] test duplicate_plain_response_is_rejected ... ok
[INFO] [stdout] test generates_offers_for_potentially_conflicting_extensions ... ok
[INFO] [stdout] test activates_one_session_with_no_params ... ok
[INFO] [stdout] test returns_serialized_offers_from_multiple_sessions ... ok
[INFO] [stdout] test activates_multiple_sessions ... ok
[INFO] [stdout] test does_not_ask_for_an_offer_if_no_session_is_built ... ok
[INFO] [stdout] test throws_if_activate_does_not_return_true ... ok
[INFO] [stdout] test throws_if_given_unregistered_extensions ... ok
[INFO] [stdout] test throws_if_two_extensions_conflict_on_rsv_bits ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test rejects_a_duplicate_name ... ok
[INFO] [stderr]      Running tests/parser.rs (/opt/rustwide/target/debug/deps/parser-07b859a37a557389)
[INFO] [stdout] test does_not_throw_on_valid_extensions ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 42 tests
[INFO] [stdout] test offers_iterate_by_reference_and_index_like_a_slice ... ok
[INFO] [stdout] test number_serializes_without_decimal_point ... ok
[INFO] [stdout] test iter_visits_every_offer_in_wire_order ... ok
[INFO] [stdout] test by_name_groups_offers_and_returns_empty_for_unknown ... ok
[INFO] [stdout] test parses_a_missing_header ... ok
[INFO] [stdout] test empty_value_after_equals_is_rejected ... ok
[INFO] [stdout] test escaped_control_char_in_a_quoted_value_is_rejected ... ok
[INFO] [stdout] test parses_an_empty_header ... ok
[INFO] [stdout] test parses_a_duplicate_offer_name ... ok
[INFO] [stdout] test non_ascii_bytes_survive_in_a_quoted_value ... ok
[INFO] [stdout] test parses_an_unquoted_param ... ok
[INFO] [stdout] test parses_an_extension_param_that_shadows_an_object_property ... ok
[INFO] [stdout] test parses_duplicate_params ... ok
[INFO] [stdout] test parses_an_extension_name_that_shadows_an_object_property ... ok
[INFO] [stdout] test numeric_value_past_f64_range_stays_a_string_and_round_trips ... ok
[INFO] [stdout] test parses_one_offer_with_no_params ... ok
[INFO] [stdout] test number_grammar_edge_cases ... ok
[INFO] [stdout] test parses_tab_after_extension_comma ... ok
[INFO] [stdout] test parses_two_offers_with_no_params ... ok
[INFO] [stdout] test quoted_numeric_value_is_coerced ... ok
[INFO] [stdout] test serializes_a_fractional_number ... ok
[INFO] [stdout] test quoted_value_keeps_escaped_bytes ... ok
[INFO] [stdout] test quotes_each_value_that_needs_quoting_independently ... ok
[INFO] [stdout] test parses_a_flag ... ok
[INFO] [stdout] test serializes_a_large_integer_without_scientific_notation ... ok
[INFO] [stdout] test serializes_a_quoted_param ... ok
[INFO] [stdout] test parses_multiple_complex_offers ... ok
[INFO] [stdout] test parses_multiple_params ... ok
[INFO] [stdout] test serializes_a_value_with_an_inner_backslash ... ok
[INFO] [stdout] test serializes_an_unquoted_param ... ok
[INFO] [stdout] test serializes_multiple_params ... ok
[INFO] [stdout] test serializes_empty_params ... ok
[INFO] [stdout] test serializes_special_number_values ... ok
[INFO] [stdout] test rejects_a_string_missing_its_closing_quote ... ok
[INFO] [stdout] test throws_on_invalid_input ... ok
[INFO] [stdout] test parses_a_quoted_param ... ok
[INFO] [stdout] test serializes_a_flag ... ok
[INFO] [stdout] test tab_is_allowed_unescaped_in_a_quoted_value ... ok
[INFO] [stdout] test rejects_space_inside_token_area ... ok
[INFO] [stdout] test raw_control_char_in_a_quoted_value_is_rejected ... ok
[INFO] [stdout] test serializes_duplicate_params ... ok
[INFO] [stdout] test serializes_a_value_with_an_inner_quote ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 42 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/pipeline_async.rs (/opt/rustwide/target/debug/deps/pipeline_async-d1c8f5979043afcb)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test defers_closing_until_the_extension_finishes ... ok
[INFO] [stdout] test processes_messages_in_order_despite_out_of_order_completion ... ok
[INFO] [stdout] test closes_each_session_as_soon_as_it_finishes ... ok
[INFO] [stdout] test notifies_of_closure_immediately_if_already_closed ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/pipeline_errors.rs (/opt/rustwide/target/debug/deps/pipeline_errors-b7d4d3748757bf25)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test handles_an_async_error ... ok
[INFO] [stdout] test handles_a_sync_error ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/process_messages.rs (/opt/rustwide/target/debug/deps/process_messages-2ca29104b735eb07)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test outgoing_does_not_call_sessions_after_an_error ... ok
[INFO] [stdout] test carries_a_leading_id_through_processing ... ok
[INFO] [stdout] test outgoing_uses_the_servers_order_not_the_clients ... ok
[INFO] [stdout] test close_with_no_pipeline_calls_back_immediately ... ok
[INFO] [stdout] test outgoing_yields_an_error_with_the_name_prefix ... ok
[INFO] [stdout] test outgoing_runs_in_the_servers_response_order ... ok
[INFO] [stdout] test incoming_does_not_call_sessions_after_an_error ... ok
[INFO] [stdout] test closing_from_a_sync_completion_does_not_panic ... ok
[INFO] [stdout] test incoming_runs_in_reverse_order_of_the_response ... ok
[INFO] [stdout] test incoming_yields_an_error_with_the_name_prefix ... ok
[INFO] [stdout] test incoming_uses_the_servers_order_not_the_clients ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/server_sessions.rs (/opt/rustwide/target/debug/deps/server_sessions-97e9c560df298234)
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test asks_for_a_server_session_with_multiple_offers ... ok
[INFO] [stdout] test does_not_build_a_session_for_unoffered_extensions ... ok
[INFO] [stdout] test does_not_return_responses_for_conflicting_extensions ... ok
[INFO] [stdout] test asks_for_a_server_session_with_the_offer ... ok
[INFO] [stdout] test asks_the_session_to_generate_a_response ... ok
[INFO] [stdout] test asks_multiple_sessions_to_generate_a_response ... ok
[INFO] [stdout] test does_not_return_responses_for_unoffered_extensions ... ok
[INFO] [stdout] test does_not_build_a_session_for_conflicting_extensions ... ok
[INFO] [stdout] test repeat_generate_response_recomputes_rsv_reservations ... ok
[INFO] [stdout] test throws_if_the_header_is_invalid ... ok
[INFO] [stdout] test returns_the_serialized_response_from_the_session ... ok
[INFO] [stdout] test returns_responses_in_registration_order ... ok
[INFO] [stdout] test returns_a_response_for_conflicting_extension_if_predecessor_builds_no_session ... ok
[INFO] [stdout] test returns_serialized_responses_from_multiple_sessions ... ok
[INFO] [stdout] test no_response_if_the_extension_builds_no_session ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/valid_frame_rsv.rs (/opt/rustwide/target/debug/deps/valid_frame_rsv-bdb45801132322ac)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test empty_client_offer_does_not_reserve_rsv_bits ... ok
[INFO] [stdout] test fresh_container_disallows_every_rsv_bit ... ok
[INFO] [stdout] test message_frame_allows_a_reserved_rsv_bit ... ok
[INFO] [stdout] test frame_with_no_rsv_bits_is_always_valid ... ok
[INFO] [stdout] test no_sessions_means_no_rsv_bits_allowed ... ok
[INFO] [stdout] test message_frame_rejects_an_unreserved_rsv_bit ... ok
[INFO] [stdout] test generate_offer_reflects_offered_extensions_in_the_active_set ... ok
[INFO] [stdout] test message_opcodes_constant ... ok
[INFO] [stdout] test control_frame_rejects_any_rsv_bit ... ok
[INFO] [stdout] test a_second_generate_offer_overwrites_the_active_set ... ok
[INFO] [stdout] test server_side_reservations_gate_rsv_bits ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests websocket_extensions
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test src/parser.rs - parser::parse_header (line 456) ... ok
[INFO] [stdout] test src/parser.rs - parser::serialize_params (line 542) ... ok
[INFO] [stdout] test src/lib.rs - (line 36) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.39s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "3016684e264154ac39559171b7f97fcf21bab223f816d928ab1242c24f893fe2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3016684e264154ac39559171b7f97fcf21bab223f816d928ab1242c24f893fe2", kill_on_drop: false }`
[INFO] [stdout] 3016684e264154ac39559171b7f97fcf21bab223f816d928ab1242c24f893fe2
