[INFO] fetching crate viadkim 0.1.0...
[INFO] testing viadkim-0.1.0 against master#ff2c56344c764af598ad33027e9c7a48881808ef for pr-118825
[INFO] extracting crate viadkim 0.1.0 into /workspace/builds/worker-2-tc1/source
[INFO] validating manifest of crates.io crate viadkim 0.1.0 on toolchain ff2c56344c764af598ad33027e9c7a48881808ef
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ff2c56344c764af598ad33027e9c7a48881808ef" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate viadkim 0.1.0
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate viadkim 0.1.0
[INFO] tweaked toml for crates.io crate viadkim 0.1.0 written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] crate crates.io crate viadkim 0.1.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" "+ff2c56344c764af598ad33027e9c7a48881808ef" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded platforms v3.1.2
[INFO] [stderr]   Downloaded rsa v0.9.3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+ff2c56344c764af598ad33027e9c7a48881808ef" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 5cdc02b7fca0b6309445665773b461114d858abcffc5dbb0c724a92b9864b12f
[INFO] running `Command { std: "docker" "start" "-a" "5cdc02b7fca0b6309445665773b461114d858abcffc5dbb0c724a92b9864b12f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5cdc02b7fca0b6309445665773b461114d858abcffc5dbb0c724a92b9864b12f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5cdc02b7fca0b6309445665773b461114d858abcffc5dbb0c724a92b9864b12f", kill_on_drop: false }`
[INFO] [stdout] 5cdc02b7fca0b6309445665773b461114d858abcffc5dbb0c724a92b9864b12f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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" "RUSTDOCFLAGS=--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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+ff2c56344c764af598ad33027e9c7a48881808ef" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c2fbbfdd0cf92b0c0ac2a05e2a5eb8e79eeb0a76746615a85dcd6334dcabf380
[INFO] running `Command { std: "docker" "start" "-a" "c2fbbfdd0cf92b0c0ac2a05e2a5eb8e79eeb0a76746615a85dcd6334dcabf380", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.149
[INFO] [stderr]    Compiling proc-macro2 v1.0.69
[INFO] [stderr]    Compiling const-oid v0.9.5
[INFO] [stderr]    Compiling zeroize v1.6.0
[INFO] [stderr]    Compiling base64ct v1.6.0
[INFO] [stderr]    Compiling libm v0.2.8
[INFO] [stderr]    Compiling semver v1.0.20
[INFO] [stderr]    Compiling platforms v3.1.2
[INFO] [stderr]    Compiling ppv-lite86 v0.2.17
[INFO] [stderr]    Compiling num-bigint-dig v0.8.4
[INFO] [stderr]    Compiling cpufeatures v0.2.9
[INFO] [stderr]    Compiling num-traits v0.2.17
[INFO] [stderr]    Compiling num-integer v0.1.45
[INFO] [stderr]    Compiling num-iter v0.1.43
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling smallvec v1.11.1
[INFO] [stderr]    Compiling tracing-core v0.1.32
[INFO] [stderr]    Compiling unicode-bidi v0.3.13
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling pem-rfc7468 v0.7.0
[INFO] [stderr]    Compiling sha2 v0.10.8
[INFO] [stderr]    Compiling idna v0.4.0
[INFO] [stderr]    Compiling der v0.7.8
[INFO] [stderr]    Compiling rustc_version v0.4.0
[INFO] [stderr]    Compiling curve25519-dalek v4.1.1
[INFO] [stderr]    Compiling quote v1.0.33
[INFO] [stderr]    Compiling syn v2.0.38
[INFO] [stderr]    Compiling getrandom v0.2.10
[INFO] [stderr]    Compiling num_cpus v1.16.0
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling signature v2.1.0
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling spki v0.7.2
[INFO] [stderr]    Compiling pkcs8 v0.10.2
[INFO] [stderr]    Compiling ed25519 v2.2.3
[INFO] [stderr]    Compiling pkcs1 v0.7.5
[INFO] [stderr]    Compiling rsa v0.9.3
[INFO] [stderr]    Compiling curve25519-dalek-derive v0.1.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.27
[INFO] [stderr]    Compiling tokio-macros v2.1.0
[INFO] [stderr]    Compiling tokio v1.33.0
[INFO] [stderr]    Compiling tracing v0.1.40
[INFO] [stderr]    Compiling ed25519-dalek v2.0.0
[INFO] [stderr]    Compiling viadkim v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.32s
[INFO] running `Command { std: "docker" "inspect" "c2fbbfdd0cf92b0c0ac2a05e2a5eb8e79eeb0a76746615a85dcd6334dcabf380", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c2fbbfdd0cf92b0c0ac2a05e2a5eb8e79eeb0a76746615a85dcd6334dcabf380", kill_on_drop: false }`
[INFO] [stdout] c2fbbfdd0cf92b0c0ac2a05e2a5eb8e79eeb0a76746615a85dcd6334dcabf380
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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" "RUSTDOCFLAGS=--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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+ff2c56344c764af598ad33027e9c7a48881808ef" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 290f5c751fa632277310c6c6b3526ced785683a6b81aa7fc22a9c67e6df08d97
[INFO] running `Command { std: "docker" "start" "-a" "290f5c751fa632277310c6c6b3526ced785683a6b81aa7fc22a9c67e6df08d97", kill_on_drop: false }`
[INFO] [stderr]    Compiling tracing-core v0.1.32
[INFO] [stderr]    Compiling overload v0.1.1
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling thread_local v1.1.7
[INFO] [stderr]    Compiling tokio v1.33.0
[INFO] [stderr]    Compiling nu-ansi-term v0.46.0
[INFO] [stderr]    Compiling tracing v0.1.40
[INFO] [stderr]    Compiling tracing-log v0.1.3
[INFO] [stderr]    Compiling tracing-subscriber v0.3.17
[INFO] [stderr]    Compiling viadkim v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 6.92s
[INFO] running `Command { std: "docker" "inspect" "290f5c751fa632277310c6c6b3526ced785683a6b81aa7fc22a9c67e6df08d97", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "290f5c751fa632277310c6c6b3526ced785683a6b81aa7fc22a9c67e6df08d97", kill_on_drop: false }`
[INFO] [stdout] 290f5c751fa632277310c6c6b3526ced785683a6b81aa7fc22a9c67e6df08d97
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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" "RUSTDOCFLAGS=--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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+ff2c56344c764af598ad33027e9c7a48881808ef" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] edfa4cf4f48b39fb138c9a504e9fecfff7a9bd5c158f2cf81d6f7510ebe6aebe
[INFO] running `Command { std: "docker" "start" "-a" "edfa4cf4f48b39fb138c9a504e9fecfff7a9bd5c158f2cf81d6f7510ebe6aebe", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/viadkim-0ebc08b363de15fc)
[INFO] [stdout] 
[INFO] [stdout] running 51 tests
[INFO] [stdout] test canonicalize::tests::body_canon_simple_ok ... ok
[INFO] [stdout] test canonicalize::tests::body_canon_relaxed_small_chunks ... ok
[INFO] [stdout] test canonicalize::tests::body_canon_relaxed_initial_empty_lines ... ok
[INFO] [stdout] test canonicalize::tests::body_canon_relaxed_basic ... ok
[INFO] [stdout] test canonicalize::tests::canonicalize_header_relaxed_dkim_sig ... ok
[INFO] [stdout] test canonicalize::tests::canonicalize_headers_relaxed_ok ... ok
[INFO] [stdout] test crypto::hash::tests::counting_hasher_ok ... ok
[INFO] [stdout] test crypto::ed25519::tests::read_ed25519_verifying_key_raw ... ok
[INFO] [stdout] test crypto::ed25519::tests::read_ed25519_verifying_key_spki ... ok
[INFO] [stdout] test crypto::hash::tests::counting_hasher_rfc_examples ... ok
[INFO] [stdout] test header::tests::field_body_ok ... ok
[INFO] [stdout] test header::tests::field_name_ok ... ok
[INFO] [stdout] test header::tests::header_fields_ok ... ok
[INFO] [stdout] test crypto::tests::signing_key_from_pkcs8_pem ... ok
[INFO] [stdout] test header::tests::split_crlf_ok ... ok
[INFO] [stdout] test message_hash::tests::body_hasher_hash_with_length ... ok
[INFO] [stdout] test parse::tests::rstrip_fws_ok ... ok
[INFO] [stdout] test message_hash::tests::body_hasher_fail_on_partial ... ok
[INFO] [stdout] test message_hash::tests::body_hasher_simple ... ok
[INFO] [stdout] test record::tests::dkim_key_record_from_str_broken ... ok
[INFO] [stdout] test parse::tests::strip_fws_ok ... ok
[INFO] [stdout] test quoted_printable::tests::decode_qp_section_ok ... ok
[INFO] [stdout] test quoted_printable::tests::decode_basic ... ok
[INFO] [stdout] test quoted_printable::tests::decode_tag_list ... ok
[INFO] [stdout] test quoted_printable::tests::encode_basic ... ok
[INFO] [stdout] test record::tests::dkim_key_record_from_tag_list_ok ... ok
[INFO] [stdout] test crypto::rsa::tests::read_rsa_public_key_spki ... ok
[INFO] [stdout] test signature::tests::identity_ok ... ok
[INFO] [stdout] test crypto::rsa::tests::read_rsa_public_key_rsa ... ok
[INFO] [stdout] test signature::tests::complicated_i18n_example_signature ... ok
[INFO] [stdout] test signer::format::tests::format_tag_z_ok ... ok
[INFO] [stdout] test message_hash::tests::body_hasher_known_hash_sample ... ok
[INFO] [stdout] test signature::tests::identity_repr_ok ... ok
[INFO] [stdout] test signature::tests::domain_name_eq_or_subdomain ... ok
[INFO] [stdout] test signer::tests::select_headers_ok ... ok
[INFO] [stdout] test tag_list::tests::parse_base64_value_ok ... ok
[INFO] [stdout] test signature::tests::selector_ok ... ok
[INFO] [stdout] test util::tests::base64_debug_ok ... ok
[INFO] [stdout] test util::tests::bytes_debug_bytes ... ok
[INFO] [stdout] test util::tests::bytes_debug_string ... ok
[INFO] [stdout] test signature::tests::rfc_example_signature ... ok
[INFO] [stdout] test signer::format::tests::format_tag_h_ok ... ok
[INFO] [stdout] test tag_list::tests::parse_quoted_printable_header_field_ok ... ok
[INFO] [stdout] test verifier::header::tests::header_verifier_find_signatures_empty ... ok
[INFO] [stdout] test tag_list::tests::parse_colon_separated_value_ok ... ok
[INFO] [stdout] test signature::tests::domain_name_ok ... ok
[INFO] [stdout] test verifier::header::tests::validate_signed_headers_ok ... ok
[INFO] [stdout] test tag_list::tests::tag_list_from_str_ok ... ok
[INFO] [stdout] test verifier::header::tests::header_verifier_find_signatures_ok ... ok
[INFO] [stdout] test verifier::verify::tests::make_original_dkim_sig_basic ... ok
[INFO] [stdout] test verifier::query::tests::queries_spawn_ok ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 51 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/copied_headers.rs (/opt/rustwide/target/debug/deps/copied_headers-1deeaf29c6a7e5c7)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test copied_headers_ok ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/low_level.rs (/opt/rustwide/target/debug/deps/low_level-683d5290352834c1)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test low_level_sign ... ok
[INFO] [stdout] test low_level_verify ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/rfc8301.rs (/opt/rustwide/target/debug/deps/rfc8301-73718bf3fbf20b23)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test sha1_basic ... ok
[INFO] [stdout] test key_512_basic ... 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] [stderr]      Running tests/rfc_appendix_a.rs (/opt/rustwide/target/debug/deps/rfc_appendix_a-09930d206d5862e3)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test rfc_appendix_a_rsa ... ok
[INFO] [stdout] test rfc_appendix_a_spki ... ok
[INFO] [stdout] test sign_roundtrip ... 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] [stderr]      Running tests/sign.rs (/opt/rustwide/target/debug/deps/sign-c179aa16531277a9)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test basic_sign ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/verify.rs (/opt/rustwide/target/debug/deps/verify-5e1247ced551e7dd)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test basic_verify ... ok
[INFO] [stdout] test limited_body_length ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests viadkim
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test src/verifier/mod.rs - verifier::Verifier::process_body_chunk (line 660) ... ok
[INFO] [stdout] test src/signer/mod.rs - signer::Signer<T>::process_body_chunk (line 594) ... ok
[INFO] [stdout] test src/header.rs - header::FieldName::new (line 80) ... ok
[INFO] [stdout] test src/signature.rs - signature::Canonicalization (line 594) ... ok
[INFO] [stdout] test src/header.rs - header::HeaderFields::from_str (line 265) ... ok
[INFO] [stdout] test src/header.rs - header::FieldName (line 63) ... ok
[INFO] [stdout] test src/header.rs - header::FieldBody::new (line 144) ... ok
[INFO] [stdout] test src/signer/mod.rs - signer::Signer (line 477) ... ok
[INFO] [stdout] test src/verifier/mod.rs - verifier::Verifier (line 520) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.11s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "edfa4cf4f48b39fb138c9a504e9fecfff7a9bd5c158f2cf81d6f7510ebe6aebe", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "edfa4cf4f48b39fb138c9a504e9fecfff7a9bd5c158f2cf81d6f7510ebe6aebe", kill_on_drop: false }`
[INFO] [stdout] edfa4cf4f48b39fb138c9a504e9fecfff7a9bd5c158f2cf81d6f7510ebe6aebe