[INFO] fetching crate viaspf-record 0.4.0...
[INFO] testing viaspf-record-0.4.0 against beta-2022-04-10 for beta-1.61-1
[INFO] extracting crate viaspf-record 0.4.0 into /workspace/builds/worker-119/source
[INFO] validating manifest of crates.io crate viaspf-record 0.4.0 on toolchain beta-2022-04-10
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate viaspf-record 0.4.0
[INFO] finished tweaking crates.io crate viaspf-record 0.4.0
[INFO] tweaked toml for crates.io crate viaspf-record 0.4.0 written to /workspace/builds/worker-119/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "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" "+beta-2022-04-10" "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-119/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] da0f4e358d1a0566078d236c037a5735d323537733e23498aa6da85032d03a5c
[INFO] running `Command { std: "docker" "start" "-a" "da0f4e358d1a0566078d236c037a5735d323537733e23498aa6da85032d03a5c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "da0f4e358d1a0566078d236c037a5735d323537733e23498aa6da85032d03a5c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "da0f4e358d1a0566078d236c037a5735d323537733e23498aa6da85032d03a5c", kill_on_drop: false }`
[INFO] [stdout] da0f4e358d1a0566078d236c037a5735d323537733e23498aa6da85032d03a5c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1e9667d5cbb1a2fc412cbb795d3096d6f72f7de889089e7ef769c77f9e53de80
[INFO] running `Command { std: "docker" "start" "-a" "1e9667d5cbb1a2fc412cbb795d3096d6f72f7de889089e7ef769c77f9e53de80", kill_on_drop: false }`
[INFO] [stderr]    Compiling viaspf-record v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.23s
[INFO] running `Command { std: "docker" "inspect" "1e9667d5cbb1a2fc412cbb795d3096d6f72f7de889089e7ef769c77f9e53de80", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1e9667d5cbb1a2fc412cbb795d3096d6f72f7de889089e7ef769c77f9e53de80", kill_on_drop: false }`
[INFO] [stdout] 1e9667d5cbb1a2fc412cbb795d3096d6f72f7de889089e7ef769c77f9e53de80
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 43ed8696fb2fe4711dda23f1ca691aa134b134f3adee606ef231a62f4d7b5cbf
[INFO] running `Command { std: "docker" "start" "-a" "43ed8696fb2fe4711dda23f1ca691aa134b134f3adee606ef231a62f4d7b5cbf", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling viaspf-record v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.94s
[INFO] [stderr]   Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/viaspf_record-b48a825728000eca)
[INFO] [stderr]   Executable tests/basic.rs (/opt/rustwide/target/debug/deps/basic-83600e28b8480c17)
[INFO] running `Command { std: "docker" "inspect" "43ed8696fb2fe4711dda23f1ca691aa134b134f3adee606ef231a62f4d7b5cbf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "43ed8696fb2fe4711dda23f1ca691aa134b134f3adee606ef231a62f4d7b5cbf", kill_on_drop: false }`
[INFO] [stdout] 43ed8696fb2fe4711dda23f1ca691aa134b134f3adee606ef231a62f4d7b5cbf
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-119/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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] e001d4ca99b84e7113f5996c2aa6fe0a1d8b58c402ecdac9f6dc3e9d61152aa9
[INFO] running `Command { std: "docker" "start" "-a" "e001d4ca99b84e7113f5996c2aa6fe0a1d8b58c402ecdac9f6dc3e9d61152aa9", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 6.17s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/viaspf_record-b48a825728000eca)
[INFO] [stdout] 
[INFO] [stdout] running 35 tests
[INFO] [stdout] test parse::tests::directive_ok ... ok
[INFO] [stdout] test parse::tests::domain_end_ok ... ok
[INFO] [stdout] test parse::tests::explain_string_ok ... ok
[INFO] [stdout] test parse::tests::ip4_network_ok ... ok
[INFO] [stdout] test parse::tests::macro_letter_ok ... ok
[INFO] [stdout] test parse::tests::macro_delimiters_ok ... ok
[INFO] [stdout] test parse::tests::ip6_network_ok ... ok
[INFO] [stdout] test parse::tests::ip6_cidr_length_ok ... ok
[INFO] [stdout] test parse::tests::dual_cidr_length_ok ... ok
[INFO] [stdout] test parse::tests::ip4_cidr_length_ok ... ok
[INFO] [stdout] test parse::tests::macro_literal_ok ... ok
[INFO] [stdout] test parse::tests::macro_string_ok ... ok
[INFO] [stdout] test parse::tests::domain_spec_ok ... ok
[INFO] [stdout] test parse::tests::macro_transformer_limit_ok ... ok
[INFO] [stdout] test parse::tests::mechanism_all_ok ... ok
[INFO] [stdout] test parse::tests::mechanism_ok ... ok
[INFO] [stdout] test parse::tests::macro_transformer_reverse_ok ... ok
[INFO] [stdout] test parse::tests::mechanism_ip4_ok ... ok
[INFO] [stdout] test parse::tests::mechanism_mx_ok ... ok
[INFO] [stdout] test parse::tests::mechanism_ip6_ok ... ok
[INFO] [stdout] test parse::tests::modifier_ok ... ok
[INFO] [stdout] test parse::tests::modifier_unknown_ok ... ok
[INFO] [stdout] test parse::tests::term_ok ... ok
[INFO] [stdout] test parse::tests::macro_expand_ok ... ok
[INFO] [stdout] test parse::tests::record_ok ... ok
[INFO] [stdout] test parse::tests::toplabel_ok ... ok
[INFO] [stdout] test tests::ip4_cidr_length_ok ... ok
[INFO] [stdout] test tests::ip6_addr_display_ok ... ok
[INFO] [stdout] test tests::macro_expand_display_ok ... ok
[INFO] [stdout] test parse::tests::qualifier_ok ... ok
[INFO] [stdout] test tests::record_match_destructuring ... ok
[INFO] [stdout] test tests::record_roundtrip ... ok
[INFO] [stdout] test tests::domain_spec_multiple_final_literals ... ok
[INFO] [stdout] test tests::record_display_ok ... ok
[INFO] [stderr]      Running tests/basic.rs (/opt/rustwide/target/debug/deps/basic-83600e28b8480c17)
[INFO] [stdout] test tests::explain_string_display_ok ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 35 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test monster_record ... ok
[INFO] [stderr]    Doc-tests viaspf-record
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test src/lib.rs - Macro (line 1023) ... ok
[INFO] [stdout] test src/lib.rs - ExplainString (line 844) ... ok
[INFO] [stdout] test src/lib.rs - (line 13) ... ok
[INFO] [stdout] test src/lib.rs - (line 53) ... ok
[INFO] [stdout] test src/lib.rs - Record (line 90) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.69s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "e001d4ca99b84e7113f5996c2aa6fe0a1d8b58c402ecdac9f6dc3e9d61152aa9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e001d4ca99b84e7113f5996c2aa6fe0a1d8b58c402ecdac9f6dc3e9d61152aa9", kill_on_drop: false }`
[INFO] [stdout] e001d4ca99b84e7113f5996c2aa6fe0a1d8b58c402ecdac9f6dc3e9d61152aa9