[INFO] fetching crate spftrace 0.1.0...
[INFO] testing spftrace-0.1.0 against try#61cd42370816fd135c0f3b9debf2f5dfcf194594 for pr-98839
[INFO] extracting crate spftrace 0.1.0 into /workspace/builds/worker-0/source
[INFO] validating manifest of crates.io crate spftrace 0.1.0 on toolchain 61cd42370816fd135c0f3b9debf2f5dfcf194594
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+61cd42370816fd135c0f3b9debf2f5dfcf194594" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate spftrace 0.1.0
[INFO] finished tweaking crates.io crate spftrace 0.1.0
[INFO] tweaked toml for crates.io crate spftrace 0.1.0 written to /workspace/builds/worker-0/source/Cargo.toml
[INFO] crate crates.io crate spftrace 0.1.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+61cd42370816fd135c0f3b9debf2f5dfcf194594" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+61cd42370816fd135c0f3b9debf2f5dfcf194594" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] aed83aceb5db862cc493f613048fc69070057db7226578b485783eec789f1aeb
[INFO] running `Command { std: "docker" "start" "-a" "aed83aceb5db862cc493f613048fc69070057db7226578b485783eec789f1aeb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "aed83aceb5db862cc493f613048fc69070057db7226578b485783eec789f1aeb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "aed83aceb5db862cc493f613048fc69070057db7226578b485783eec789f1aeb", kill_on_drop: false }`
[INFO] [stdout] aed83aceb5db862cc493f613048fc69070057db7226578b485783eec789f1aeb
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+61cd42370816fd135c0f3b9debf2f5dfcf194594" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a4525e35613a018d8ed93d22d920d6ce9073d20e269da3997dafcbcd12652a65
[INFO] running `Command { std: "docker" "start" "-a" "a4525e35613a018d8ed93d22d920d6ce9073d20e269da3997dafcbcd12652a65", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.126
[INFO] [stderr]    Compiling proc-macro2 v1.0.39
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling unicode-ident v1.0.1
[INFO] [stderr]    Compiling syn v1.0.96
[INFO] [stderr]    Compiling log v0.4.17
[INFO] [stderr]    Compiling futures-core v0.3.21
[INFO] [stderr]    Compiling tinyvec_macros v0.1.0
[INFO] [stderr]    Compiling autocfg v1.1.0
[INFO] [stderr]    Compiling futures-task v0.3.21
[INFO] [stderr]    Compiling matches v0.1.9
[INFO] [stderr]    Compiling memchr v2.5.0
[INFO] [stderr]    Compiling futures-channel v0.3.21
[INFO] [stderr]    Compiling ppv-lite86 v0.2.16
[INFO] [stderr]    Compiling smallvec v1.8.0
[INFO] [stderr]    Compiling pin-project-lite v0.2.9
[INFO] [stderr]    Compiling async-trait v0.1.56
[INFO] [stderr]    Compiling percent-encoding v2.1.0
[INFO] [stderr]    Compiling futures-util v0.3.21
[INFO] [stderr]    Compiling parking_lot_core v0.9.3
[INFO] [stderr]    Compiling unicode-bidi v0.3.8
[INFO] [stderr]    Compiling heck v0.4.0
[INFO] [stderr]    Compiling once_cell v1.12.0
[INFO] [stderr]    Compiling match_cfg v0.1.0
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling pin-utils v0.1.0
[INFO] [stderr]    Compiling bytes v1.1.0
[INFO] [stderr]    Compiling slab v0.4.6
[INFO] [stderr]    Compiling futures-io v0.3.21
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling quick-error v1.2.3
[INFO] [stderr]    Compiling linked-hash-map v0.5.4
[INFO] [stderr]    Compiling data-encoding v2.3.2
[INFO] [stderr]    Compiling ipnet v2.5.0
[INFO] [stderr]    Compiling viaspf-record v0.4.1
[INFO] [stderr]    Compiling ansi_term v0.12.1
[INFO] [stderr]    Compiling tinyvec v1.6.0
[INFO] [stderr]    Compiling form_urlencoded v1.0.1
[INFO] [stderr]    Compiling lock_api v0.4.7
[INFO] [stderr]    Compiling lru-cache v0.1.2
[INFO] [stderr]    Compiling unicode-normalization v0.1.19
[INFO] [stderr]    Compiling quote v1.0.18
[INFO] [stderr]    Compiling getrandom v0.2.7
[INFO] [stderr]    Compiling num_cpus v1.13.1
[INFO] [stderr]    Compiling socket2 v0.4.4
[INFO] [stderr]    Compiling mio v0.8.3
[INFO] [stderr]    Compiling hostname v0.3.1
[INFO] [stderr]    Compiling resolv-conf v0.7.0
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling parking_lot v0.12.1
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling idna v0.2.3
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling url v2.2.2
[INFO] [stderr]    Compiling tokio-macros v1.8.0
[INFO] [stderr]    Compiling thiserror-impl v1.0.31
[INFO] [stderr]    Compiling enum-as-inner v0.4.0
[INFO] [stderr]    Compiling tokio v1.19.2
[INFO] [stderr]    Compiling thiserror v1.0.31
[INFO] [stderr]    Compiling trust-dns-proto v0.21.2
[INFO] [stderr]    Compiling trust-dns-resolver v0.21.2
[INFO] [stderr]    Compiling viaspf v0.4.1
[INFO] [stderr]    Compiling spftrace v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 20.86s
[INFO] running `Command { std: "docker" "inspect" "a4525e35613a018d8ed93d22d920d6ce9073d20e269da3997dafcbcd12652a65", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a4525e35613a018d8ed93d22d920d6ce9073d20e269da3997dafcbcd12652a65", kill_on_drop: false }`
[INFO] [stdout] a4525e35613a018d8ed93d22d920d6ce9073d20e269da3997dafcbcd12652a65
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+61cd42370816fd135c0f3b9debf2f5dfcf194594" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8b587e460346af82fe227574eab0ede89c2f3f6d246eca5f633a567255d53018
[INFO] running `Command { std: "docker" "start" "-a" "8b587e460346af82fe227574eab0ede89c2f3f6d246eca5f633a567255d53018", kill_on_drop: false }`
[INFO] [stderr]    Compiling spftrace v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 7.02s
[INFO] running `Command { std: "docker" "inspect" "8b587e460346af82fe227574eab0ede89c2f3f6d246eca5f633a567255d53018", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8b587e460346af82fe227574eab0ede89c2f3f6d246eca5f633a567255d53018", kill_on_drop: false }`
[INFO] [stdout] 8b587e460346af82fe227574eab0ede89c2f3f6d246eca5f633a567255d53018
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+61cd42370816fd135c0f3b9debf2f5dfcf194594" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 10b25b0af44d5bf59feb4217a8cf4b2281ccd31d29dd9d509954db8e26bf3a3f
[INFO] running `Command { std: "docker" "start" "-a" "10b25b0af44d5bf59feb4217a8cf4b2281ccd31d29dd9d509954db8e26bf3a3f", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/spftrace-baa5a3f3c0add4ab)
[INFO] [stdout] 
[INFO] [stdout] running 17 tests
[INFO] [stdout] test tests::live ... ignored, depends on live DNS records
[INFO] [stdout] test tests::invalid_spf_record_syntax ... ok
[INFO] [stdout] test tests::neutral_default_result ... ok
[INFO] [stdout] test tests::dual_cidr_length ... ok
[INFO] [stdout] test tests::dns_error ... ok
[INFO] [stdout] test tests::multiple_modifiers ... ok
[INFO] [stdout] test tests::exp_modifier ... ok
[INFO] [stdout] test tests::invalid_exp_modifier_syntax ... ok
[INFO] [stdout] test tests::exists_macros ... ok
[INFO] [stdout] test tests::invalid_redirect_target ... ok
[INFO] [stdout] test tests::p_macro_in_domain_spec ... ok
[INFO] [stdout] test tests::multiple_spf_records ... ok
[INFO] [stdout] test tests::ptr_lookup_error ... ok
[INFO] [stdout] test tests::readme_example ... ok
[INFO] [stdout] test tests::target_name_not_found ... ok
[INFO] [stdout] test tests::ptr_mechanism ... ok
[INFO] [stdout] test tests::recursive_record ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "10b25b0af44d5bf59feb4217a8cf4b2281ccd31d29dd9d509954db8e26bf3a3f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "10b25b0af44d5bf59feb4217a8cf4b2281ccd31d29dd9d509954db8e26bf3a3f", kill_on_drop: false }`
[INFO] [stdout] 10b25b0af44d5bf59feb4217a8cf4b2281ccd31d29dd9d509954db8e26bf3a3f