[INFO] fetching crate http_desync_guardian 0.1.3...
[INFO] testing http_desync_guardian-0.1.3 against beta-2020-10-09 for beta-1.48-1
[INFO] extracting crate http_desync_guardian 0.1.3 into /workspace/builds/worker-5/source
[INFO] validating manifest of crates.io crate http_desync_guardian 0.1.3 on toolchain beta-2020-10-09
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-10-09" "read-manifest" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] started tweaking crates.io crate http_desync_guardian 0.1.3
[INFO] finished tweaking crates.io crate http_desync_guardian 0.1.3
[INFO] tweaked toml for crates.io crate http_desync_guardian 0.1.3 written to /workspace/builds/worker-5/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-10-09" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-10-09" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded snailquote v0.3.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] c8cdf1621646d8266679c61061dc031a2b5a64424a27a1cb9a74570a676b983c
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "c8cdf1621646d8266679c61061dc031a2b5a64424a27a1cb9a74570a676b983c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c8cdf1621646d8266679c61061dc031a2b5a64424a27a1cb9a74570a676b983c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c8cdf1621646d8266679c61061dc031a2b5a64424a27a1cb9a74570a676b983c", kill_on_drop: false }`
[INFO] [stdout] c8cdf1621646d8266679c61061dc031a2b5a64424a27a1cb9a74570a676b983c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7d2237c76a69b8607427cc9157a68d4e4ad76a7120b310d97f95e76c8678c511
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "7d2237c76a69b8607427cc9157a68d4e4ad76a7120b310d97f95e76c8678c511", kill_on_drop: false }`
[INFO] [stderr]    Compiling http_desync_guardian v0.1.3 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling strum v0.18.0
[INFO] [stderr]    Compiling strum_macros v0.18.0
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.52s
[INFO] running `Command { std: "docker" "inspect" "7d2237c76a69b8607427cc9157a68d4e4ad76a7120b310d97f95e76c8678c511", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7d2237c76a69b8607427cc9157a68d4e4ad76a7120b310d97f95e76c8678c511", kill_on_drop: false }`
[INFO] [stdout] 7d2237c76a69b8607427cc9157a68d4e4ad76a7120b310d97f95e76c8678c511
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d25d1b40f571ca9fdce2c2701a02279ff5279a2f4d6fc2019fcfa865ae61fff4
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "d25d1b40f571ca9fdce2c2701a02279ff5279a2f4d6fc2019fcfa865ae61fff4", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode_categories v0.1.1
[INFO] [stderr]    Compiling thiserror-impl v1.0.21
[INFO] [stderr]    Compiling criterion v0.3.3
[INFO] [stderr]    Compiling thiserror v1.0.21
[INFO] [stderr]    Compiling snailquote v0.3.0
[INFO] [stderr]    Compiling http_desync_guardian v0.1.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 14.67s
[INFO] running `Command { std: "docker" "inspect" "d25d1b40f571ca9fdce2c2701a02279ff5279a2f4d6fc2019fcfa865ae61fff4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d25d1b40f571ca9fdce2c2701a02279ff5279a2f4d6fc2019fcfa865ae61fff4", kill_on_drop: false }`
[INFO] [stdout] d25d1b40f571ca9fdce2c2701a02279ff5279a2f4d6fc2019fcfa865ae61fff4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 035ffb3e9bde23ce269b344edd0ad0ccfc4eb25c94e6eceec4e6a35897b85d44
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "035ffb3e9bde23ce269b344edd0ad0ccfc4eb25c94e6eceec4e6a35897b85d44", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.10s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/http_desync_guardian-f070d4a0b3825092
[INFO] [stdout] 
[INFO] [stdout] running 106 tests
[INFO] [stdout] test http_token_utils::tests::test_header_value ... ok
[INFO] [stdout] test http_token_utils::tests::test_to_ascii_large_value ... ok
[INFO] [stdout] test http_token_utils::tests::verify_essential_headers_lowercase ... ok
[INFO] [stdout] test http_token_utils::tests::test_same_char ... ok
[INFO] [stdout] test http_token_utils::tests::test_arbitrary_non_utf8_bytes ... ok
[INFO] [stdout] test http_token_utils::tests::test_valid_te ... ok
[INFO] [stdout] test http_token_utils::tests::test_obfuscate_large_value ... ok
[INFO] [stdout] test http_token_utils::tests::test_parse_num ... ok
[INFO] [stdout] test http_token_utils::tests::test_obfuscate_value ... ok
[INFO] [stdout] test http_token_utils::tests::test_to_ascii ... ok
[INFO] [stdout] test raw_request_parser::tests::test_parse_line_by_line ... ok
[INFO] [stdout] test raw_request_parser::tests::test_parse_empty_uri_bad_delimiters ... ok
[INFO] [stdout] test raw_request_parser::tests::test_parse_missing_uri ... ok
[INFO] [stdout] test raw_request_parser::tests::test_parse_non_compliant_request_line ... ok
[INFO] [stdout] test raw_request_parser::tests::test_parse_non_missing_empty_line ... ok
[INFO] [stdout] test raw_request_parser::tests::test_parse_non_compliant_terminator_request_line ... ok
[INFO] [stdout] test raw_request_parser::tests::test_parse_non_tchar_request_line ... ok
[INFO] [stdout] test http_token_utils::tests::test_utf8_spaces ... ok
[INFO] [stdout] test raw_request_parser::tests::test_parse_partial ... ok
[INFO] [stdout] test http_token_utils::tests::verify_te_options_lowercase ... ok
[INFO] [stdout] test raw_request_parser::tests::test_parse_empty_uri ... ok
[INFO] [stdout] test raw_request_parser::tests::test_parse_request_line ... ok
[INFO] [stdout] test http_token_utils::tests::test_same_letters ... ok
[INFO] [stdout] test raw_request_parser::tests::test_parse_request_line_http_09 ... ok
[INFO] [stdout] test http_token_utils::tests::test_trim ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_allow_multiline_content_type ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_acceptable_multiline_content_type ... ok
[INFO] [stdout] test http_token_utils::tests::test_tchar ... ok
[INFO] [stdout] test http_token_utils::tests::test_utf8_delimiters ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_allow_multiline_content_type_other_acceptable ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_multiline_headers ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_bad_multiline_mimic_header_severe ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_multiline_besides_content_type ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_non_tchar_request_line ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_bad_multiline_first_line_multiline ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_bad_multiline_mimic_header ... ok
[INFO] [stdout] test request_analyzer::tests::test_field_name_tier ... ok
[INFO] [stdout] test request_analyzer::tests::test_field_value_tier ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_lfcr ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_malformed_status_line ... ok
[INFO] [stdout] test request_analyzer::tests::test_h3_not_analyzed ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_no_header_value ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_bad_multiline_content_type ... ok
[INFO] [stdout] test request_analyzer::tests::test_no_headers ... ok
[INFO] [stdout] test request_analyzer::tests::test_parse_bad_request_line ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_bad_uri ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_bad_multiline_headers ... ok
[INFO] [stdout] test request_analyzer::tests::test_header_tier ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_crafted_smuggling ... ok
[INFO] [stdout] test request_analyzer::tests::test_h2_not_analyzed ... ok
[INFO] [stdout] test request_analyzer::tests::test_parse_request_missing_empty_line ... ok
[INFO] [stdout] test request_analyzer::tests::test_parse_request ... ok
[INFO] [stdout] test request_analyzer::tests::test_parse_request_first_multiline ... ok
[INFO] [stdout] test request_analyzer::tests::test_parse_request_multiline ... ok
[INFO] [stdout] test request_analyzer::tests::test_te_with_space ... ok
[INFO] [stdout] test request_analyzer::tests::test_parse_empty_header_name_double_colon ... ok
[INFO] [stdout] test request_analyzer::tests::test_parse_empty_uri ... ok
[INFO] [stdout] test request_analyzer::tests::test_parse_malformed_request_single_line_partial ... ok
[INFO] [stdout] test request_analyzer::tests::test_te_ok ... ok
[INFO] [stdout] test request_analyzer::tests::test_parse_empty_header_name ... ok
[INFO] [stdout] test request_analyzer::tests::test_parse_malformed_request_single_line ... ok
[INFO] [stdout] test request_analyzer::tests::test_parse_spaces_in_uri ... ok
[INFO] [stdout] test request_analyzer::tests::test_parse_missing_uri ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_spaces_in_uri ... ok
[INFO] [stdout] test request_analyzer::tests::test_parse_request_partial_header ... ok
[INFO] [stdout] test request_analyzer::tests::test_very_many_headers ... ok
[INFO] [stdout] test request_analyzer::tests::test_very_many_headers_raw ... ok
[INFO] [stdout] test tests::test_classification_reason_metrics_callback ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_analyze_raw_request ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_analyze_request ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_validate_print_request_insufficient_buffer_length ... ok
[INFO] [stdout] test tests::test_classification_metrics_callback_required ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_validate_print_request_parameters_null_buffer ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_validate_request_analysis_parameters_null_header_name ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_validate_print_request_parameters_null_request ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_validate_request_analysis_parameters_null_method ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_validate_request_analysis_parameters_null_header_value ... ok
[INFO] [stdout] test tests::test_classification_metrics_settings_required ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_validate_request_analysis_parameters_null_request ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_validate_print_request_parameters_invalid_buffer_length ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_validate_request_analysis_parameters_null_uri ... ok
[INFO] [stdout] test tests::test_non_compliant_header_tier ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_validate_request_analysis_parameters_null_version ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_validate_request_raw_request_null_buffer ... ok
[INFO] [stdout] test tests::test_logger_settings_required ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_validate_request_raw_request_zero_buffer_size ... ok
[INFO] [stdout] test ultralight_rate_limiter::tests::test_once_per_minute ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_validate_request_analysis_parameters_null_verdict ... ok
[INFO] [stdout] test ultralight_rate_limiter::tests::test_round_down ... ok
[INFO] [stdout] test ultralight_rate_limiter::tests::test_once_per_second ... ok
[INFO] [stdout] test ultralight_rate_limiter::tests::test_time_stamp_overflow ... ok
[INFO] [stdout] test tests::test_http_desync_guardian_validate_request_raw_request_null_verdict ... ok
[INFO] [stdout] test tests::test_log_callback ... ok
[INFO] [stdout] test tests::test_logger_callback_required ... ok
[INFO] [stdout] test ultralight_rate_limiter::tests::test_try_acquire_value ... ok
[INFO] [stdout] test ultralight_rate_limiter::tests::test_twice_per_minute ... ok
[INFO] [stdout] test ultralight_rate_limiter::tests::test_twice_per_second ... ok
[INFO] [stdout] test tests::test_request_tier_metrics_callback ... ok
[INFO] [stdout] test tests::test_invalid_header_tier ... ok
[INFO] [stdout] test tests::test_tier_metrics_settings_required ... ok
[INFO] [stdout] test tests::test_tier_metrics_callback_required ... ok
[INFO] [stdout] test ultralight_rate_limiter::tests::test_100_per_second ... ok
[INFO] [stdout] test request_analyzer::tests::file_tests ... ok
[INFO] [stdout] test request_analyzer::tests::test_analyze_fuzzing_input ... ok
[INFO] [stdout] test http_token_utils::tests::test_same_char_covers_all_utf8 ... ok
[INFO] [stdout] test request_analyzer::tests::test_walk_through_states ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 106 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests http_desync_guardian
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test src/http_token_utils.rs - http_token_utils::SP (line 34) ... ignored
[INFO] [stdout] test src/http_token_utils.rs - http_token_utils::SP (line 57) ... ignored
[INFO] [stdout] test src/http_token_utils.rs - http_token_utils::TokenSimilarity::SameLetters (line 110) ... ok
[INFO] [stdout] test src/http_token_utils.rs - http_token_utils::TokenSimilarity::Distant (line 119) ... ok
[INFO] [stdout] test src/http_token_utils.rs - http_token_utils::TokenSimilarity::Identical (line 101) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "035ffb3e9bde23ce269b344edd0ad0ccfc4eb25c94e6eceec4e6a35897b85d44", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "035ffb3e9bde23ce269b344edd0ad0ccfc4eb25c94e6eceec4e6a35897b85d44", kill_on_drop: false }`
[INFO] [stdout] 035ffb3e9bde23ce269b344edd0ad0ccfc4eb25c94e6eceec4e6a35897b85d44
