[INFO] fetching crate viaspf 0.4.0-alpha.1... [INFO] testing viaspf-0.4.0-alpha.1 against try#ecabaf78506b7a4668d42dc20268c086b93f0fad for pr-87041 [INFO] extracting crate viaspf 0.4.0-alpha.1 into /workspace/builds/worker-1/source [INFO] validating manifest of crates.io crate viaspf 0.4.0-alpha.1 on toolchain ecabaf78506b7a4668d42dc20268c086b93f0fad [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate viaspf 0.4.0-alpha.1 [INFO] finished tweaking crates.io crate viaspf 0.4.0-alpha.1 [INFO] tweaked toml for crates.io crate viaspf 0.4.0-alpha.1 written to /workspace/builds/worker-1/source/Cargo.toml [INFO] crate crates.io crate viaspf 0.4.0-alpha.1 already has a lockfile, it will not be regenerated [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded trust-dns-proto v0.20.3 [INFO] [stderr] Downloaded trust-dns-resolver v0.20.3 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 40bb740981304957aa63a0104464bc2063299d4205508d45639de4007a642ecb [INFO] running `Command { std: "docker" "start" "-a" "40bb740981304957aa63a0104464bc2063299d4205508d45639de4007a642ecb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "40bb740981304957aa63a0104464bc2063299d4205508d45639de4007a642ecb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "40bb740981304957aa63a0104464bc2063299d4205508d45639de4007a642ecb", kill_on_drop: false }` [INFO] [stdout] 40bb740981304957aa63a0104464bc2063299d4205508d45639de4007a642ecb [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 0b08adc19da77b0be576e823720b758d243e23060434a7d66757be1d97d421bb [INFO] running `Command { std: "docker" "start" "-a" "0b08adc19da77b0be576e823720b758d243e23060434a7d66757be1d97d421bb", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.27 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling syn v1.0.73 [INFO] [stderr] Compiling async-trait v0.1.50 [INFO] [stderr] Compiling quote v1.0.9 [INFO] [stderr] Compiling viaspf v0.4.0-alpha.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 17.93s [INFO] running `Command { std: "docker" "inspect" "0b08adc19da77b0be576e823720b758d243e23060434a7d66757be1d97d421bb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0b08adc19da77b0be576e823720b758d243e23060434a7d66757be1d97d421bb", kill_on_drop: false }` [INFO] [stdout] 0b08adc19da77b0be576e823720b758d243e23060434a7d66757be1d97d421bb [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 1c7ab20b5e1635e24edbac5aa0bfa546e98e085d1c60ffd32404db63bcbfac66 [INFO] running `Command { std: "docker" "start" "-a" "1c7ab20b5e1635e24edbac5aa0bfa546e98e085d1c60ffd32404db63bcbfac66", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.97 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling ppv-lite86 v0.2.10 [INFO] [stderr] Compiling futures-channel v0.3.15 [INFO] [stderr] Compiling smallvec v1.6.1 [INFO] [stderr] Compiling unicode-segmentation v1.7.1 [INFO] [stderr] Compiling match_cfg v0.1.0 [INFO] [stderr] Compiling linked-hash-map v0.5.4 [INFO] [stderr] Compiling lock_api v0.4.4 [INFO] [stderr] Compiling tokio-macros v1.2.0 [INFO] [stderr] Compiling thiserror-impl v1.0.25 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling instant v0.1.9 [INFO] [stderr] Compiling lru-cache v0.1.2 [INFO] [stderr] Compiling heck v0.3.3 [INFO] [stderr] Compiling tokio v1.7.1 [INFO] [stderr] Compiling futures-util v0.3.15 [INFO] [stderr] Compiling enum-as-inner v0.3.3 [INFO] [stderr] Compiling getrandom v0.2.3 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling mio v0.7.13 [INFO] [stderr] Compiling hostname v0.3.1 [INFO] [stderr] Compiling parking_lot_core v0.8.3 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling resolv-conf v0.7.0 [INFO] [stderr] Compiling parking_lot v0.11.1 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling rand v0.8.4 [INFO] [stderr] Compiling thiserror v1.0.25 [INFO] [stderr] Compiling trust-dns-proto v0.20.3 [INFO] [stderr] Compiling trust-dns-resolver v0.20.3 [INFO] [stderr] Compiling viaspf v0.4.0-alpha.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 31.01s [INFO] running `Command { std: "docker" "inspect" "1c7ab20b5e1635e24edbac5aa0bfa546e98e085d1c60ffd32404db63bcbfac66", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "1c7ab20b5e1635e24edbac5aa0bfa546e98e085d1c60ffd32404db63bcbfac66", kill_on_drop: false }` [INFO] [stdout] 1c7ab20b5e1635e24edbac5aa0bfa546e98e085d1c60ffd32404db63bcbfac66 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 45c5162eb3c10ec1c9788bb9bfb61f79b8e45f638abbdfdf4ca259796e1cee88 [INFO] running `Command { std: "docker" "start" "-a" "45c5162eb3c10ec1c9788bb9bfb61f79b8e45f638abbdfdf4ca259796e1cee88", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.05s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/viaspf-2e62506d487b0628) [INFO] [stdout] [INFO] [stdout] running 57 tests [INFO] [stdout] test config::tests::default_void_lookups_ok ... ok [INFO] [stdout] test eval::query::tests::is_local_part_rfc3696_ok ... ok [INFO] [stdout] test eval::query::tests::sender_from_domain ... ok [INFO] [stdout] test eval::record::tests::sanitize_macro_string_ok ... ok [INFO] [stdout] test name::tests::is_subdomain_of_ok ... ok [INFO] [stdout] test record::parse::tests::directive_ok ... ok [INFO] [stdout] test name::tests::name_domain_ok ... ok [INFO] [stdout] test record::parse::tests::domain_end_ok ... ok [INFO] [stdout] test record::parse::tests::dual_cidr_length_ok ... ok [INFO] [stdout] test record::parse::tests::ip4_cidr_length_ok ... ok [INFO] [stdout] test record::parse::tests::macro_expand_ok ... ok [INFO] [stdout] test record::parse::tests::mechanism_ip6_ok ... ok [INFO] [stdout] test record::parse::tests::macro_delimiters_ok ... ok [INFO] [stdout] test record::parse::tests::macro_literal_ok ... ok [INFO] [stdout] test record::parse::tests::mechanism_ok ... ok [INFO] [stdout] test record::parse::tests::domain_spec_ok ... ok [INFO] [stdout] test record::parse::tests::explain_string_ok ... ok [INFO] [stdout] test record::parse::tests::macro_transformer_reverse_ok ... ok [INFO] [stdout] test record::parse::tests::mechanism_ip4_ok ... ok [INFO] [stdout] test record::parse::tests::macro_string_ok ... ok [INFO] [stdout] test record::parse::tests::mechanism_all_ok ... ok [INFO] [stdout] test eval::record::tests::get_sole_redirect_ok ... ok [INFO] [stdout] test eval::macros::tests::split_on_delimiters_ok ... ok [INFO] [stdout] test eval::query::tests::sender_from_email_address ... ok [INFO] [stdout] test record::parse::tests::ip6_cidr_length_ok ... ok [INFO] [stdout] test eval::terms::tests::is_in_network_ok ... ok [INFO] [stdout] test eval::tests::spf_result_fail_display_empty ... ok [INFO] [stdout] test name::tests::name_normalises_case ... ok [INFO] [stdout] test record::parse::tests::ip6_network_ok ... ok [INFO] [stdout] test record::parse::tests::macro_letter_ok ... ok [INFO] [stdout] test eval::query::tests::is_local_part_ok ... ok [INFO] [stdout] test record::parse::tests::macro_transformer_limit_ok ... ok [INFO] [stdout] test eval::tests::spf_result_fail_display_with_explanation ... ok [INFO] [stdout] test config::tests::modify_exp_with_ok ... ok [INFO] [stdout] test record::parse::tests::modifier_ok ... ok [INFO] [stdout] test record::parse::tests::ip4_network_ok ... ok [INFO] [stdout] test eval::macros::tests::url_escape_ok ... ok [INFO] [stdout] test eval::terms::tests::truncate_target_name_string_ok ... ok [INFO] [stdout] test record::parse::tests::mechanism_mx_ok ... ok [INFO] [stdout] test resolve::tests::lookup_call_ok ... ok [INFO] [stdout] test trace::tests::add_event_ok ... ok [INFO] [stdout] test record::parse::tests::record_ok ... ok [INFO] [stdout] test record::tests::domain_spec_multiple_final_literals ... ok [INFO] [stdout] test record::tests::explain_string_display_ok ... ok [INFO] [stdout] test record::tests::ip6_addr_display_ok ... ok [INFO] [stdout] test record::parse::tests::toplabel_ok ... ok [INFO] [stdout] test record::tests::record_display_ok ... ok [INFO] [stdout] test record::tests::record_match_destructuring ... ok [INFO] [stdout] test record::tests::record_roundtrip ... ok [INFO] [stdout] test record::tests::ip4_cidr_length_ok ... ok [INFO] [stdout] test record::tests::macro_expand_display_ok ... ok [INFO] [stdout] test record::parse::tests::term_ok ... ok [INFO] [stdout] test name::tests::name_new_ok ... ok [INFO] [stdout] test eval::macros::tests::timestamp_in_secs_ok ... ok [INFO] [stdout] test record::parse::tests::qualifier_ok ... ok [INFO] [stdout] test record::parse::tests::modifier_unknown_ok ... ok [INFO] [stdout] test eval::macros::tests::expansion_examples ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 57 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s [INFO] [stdout] [INFO] [stderr] Running tests/evaluate.rs (/opt/rustwide/target/debug/deps/evaluate-02b759c311472d53) [INFO] [stdout] [INFO] [stdout] running 8 tests [INFO] [stdout] test spf_record_with_nonmatching_version ... ok [INFO] [stdout] test evaluate_invalid_helo_domain ... ok [INFO] [stdout] test evaluate_sender_with_unicode_domain ... ok [INFO] [stdout] test evaluate_sender_without_local_part ... ok [INFO] [stdout] test evaluate_null_sender ... ok [INFO] [stdout] test evaluate_simple_match ... ok [INFO] [stderr] Running tests/explanation.rs (/opt/rustwide/target/debug/deps/explanation-4f3b33152b635269) [INFO] [stdout] test spf_record_with_invalid_syntax ... ok [INFO] [stdout] test evaluate_invalid_sender ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stderr] Running tests/lookup_limits.rs (/opt/rustwide/target/debug/deps/lookup_limits-46648f4c9e8c8514) [INFO] [stdout] test lookup_count_reset_before_exp_evaluation ... ok [INFO] [stdout] test explanation_from_dns ... ok [INFO] [stdout] test explanation_with_invalid_syntax ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test mx_per_mech_lookup_limit ... ok [INFO] [stderr] Running tests/ptr_validated_domains.rs (/opt/rustwide/target/debug/deps/ptr_validated_domains-3d4d5e1ae5c81ec0) [INFO] [stdout] test custom_void_lookup_limit ... ok [INFO] [stdout] test mx_included_in_global_lookup_count ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test ptr_with_matching_validated_domain ... ok [INFO] [stdout] test ptr_with_foreign_domain_fails ... ok [INFO] [stdout] test ptr_with_validated_domain_in_domain_spec ... ok [INFO] [stdout] test validated_domain_macro ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stderr] Running tests/record.rs (/opt/rustwide/target/debug/deps/record-d162c7dc899c902f) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stderr] Running tests/recursive_evaluation.rs (/opt/rustwide/target/debug/deps/recursive_evaluation-da8e6a87f583969f) [INFO] [stdout] test monster_record ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stderr] Running tests/rfc7208_appendix_a.rs (/opt/rustwide/target/debug/deps/rfc7208_appendix_a-d6d981463cc46fca) [INFO] [stdout] test included_and_redirected_query ... ok [INFO] [stdout] test included_spf_record_missing ... ok [INFO] [stdout] test redirected_included_query_with_explanation ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 12 tests [INFO] [stdout] test multiple_requirements_example ... ok [INFO] [stdout] test simple_examples_5 ... ok [INFO] [stdout] test simple_examples_2 ... ok [INFO] [stdout] test simple_examples_6 ... ok [INFO] [stdout] test simple_examples_7 ... ok [INFO] [stdout] test simple_examples_8 ... ok [INFO] [stdout] test multiple_domain_example ... ok [INFO] [stderr] Running tests/timeout.rs (/opt/rustwide/target/debug/deps/timeout-f019b6251314657c) [INFO] [stdout] test simple_examples_1 ... ok [INFO] [stdout] test simple_examples_9 ... ok [INFO] [stdout] test dns_blacklist_style_example ... ok [INFO] [stdout] test simple_examples_4 ... ok [INFO] [stdout] test simple_examples_3 ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test slow_lookup_times_out ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.21s [INFO] [stdout] [INFO] [stderr] Doc-tests viaspf [INFO] [stdout] [INFO] [stdout] running 12 tests [INFO] [stdout] test src/name.rs - name::Name::new (line 83) ... ok [INFO] [stdout] test src/eval.rs - eval::evaluate_spf (line 410) ... ok [INFO] [stdout] test src/eval.rs - eval::evaluate_spf (line 374) ... ok [INFO] [stdout] test src/name.rs - name::Name (line 42) ... ok [INFO] [stdout] test src/record.rs - record::Macro (line 1005) ... ok [INFO] [stdout] test src/record.rs - record::Record (line 77) ... ok [INFO] [stdout] test src/record.rs - record (line 10) ... ok [INFO] [stdout] test src/name.rs - name::Name (line 51) ... ok [INFO] [stdout] test src/record.rs - record::ExplainString (line 815) ... ok [INFO] [stdout] test src/lib.rs - (line 33) ... ok [INFO] [stdout] test src/name.rs - name::Name::domain (line 110) ... ok [INFO] [stdout] test src/record.rs - record (line 50) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.03s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "45c5162eb3c10ec1c9788bb9bfb61f79b8e45f638abbdfdf4ca259796e1cee88", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "45c5162eb3c10ec1c9788bb9bfb61f79b8e45f638abbdfdf4ca259796e1cee88", kill_on_drop: false }` [INFO] [stdout] 45c5162eb3c10ec1c9788bb9bfb61f79b8e45f638abbdfdf4ca259796e1cee88