[INFO] fetching crate zrtp 0.1.0...
[INFO] testing zrtp-0.1.0 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate zrtp 0.1.0 into /workspace/builds/worker-7-tc2/source
[INFO] started tweaking crates.io crate zrtp 0.1.0
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate zrtp 0.1.0
[INFO] tweaked toml for crates.io crate zrtp 0.1.0 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate zrtp 0.1.0 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate zrtp 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" "+1.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 9533007b5aa25c95e7d3afd8c278a01480e2c23938ca52e4c689e509e6e71d37
[INFO] running `Command { std: "docker" "start" "9533007b5aa25c95e7d3afd8c278a01480e2c23938ca52e4c689e509e6e71d37", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9533007b5aa25c95e7d3afd8c278a01480e2c23938ca52e4c689e509e6e71d37", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "9533007b5aa25c95e7d3afd8c278a01480e2c23938ca52e4c689e509e6e71d37" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9533007b5aa25c95e7d3afd8c278a01480e2c23938ca52e4c689e509e6e71d37", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "9533007b5aa25c95e7d3afd8c278a01480e2c23938ca52e4c689e509e6e71d37" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling typenum v1.20.0
[INFO] [stderr]    Compiling libc v0.2.186
[INFO] [stderr]    Compiling const-oid v0.9.6
[INFO] [stderr]    Compiling subtle v2.6.1
[INFO] [stderr]    Compiling base16ct v0.2.0
[INFO] [stderr]    Compiling zerocopy v0.8.48
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling anyhow v1.0.102
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling arrayvec v0.7.6
[INFO] [stderr]    Compiling base256 v0.4.2
[INFO] [stderr]    Compiling der v0.7.10
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling utf8-chars v2.1.0
[INFO] [stderr]    Compiling spki v0.7.3
[INFO] [stderr]    Compiling crypto-common v0.1.7
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling inout v0.1.4
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling cipher v0.4.4
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling aes v0.8.4
[INFO] [stderr]    Compiling cfb-mode v0.8.2
[INFO] [stderr]    Compiling hmac v0.12.1
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling hkdf v0.12.4
[INFO] [stderr]    Compiling rfc6979 v0.4.0
[INFO] [stderr]    Compiling ff v0.13.1
[INFO] [stderr]    Compiling crypto-bigint v0.5.5
[INFO] [stderr]    Compiling signature v2.2.0
[INFO] [stderr]    Compiling pkcs8 v0.10.2
[INFO] [stderr]    Compiling group v0.13.0
[INFO] [stderr]    Compiling sec1 v0.7.3
[INFO] [stderr]    Compiling elliptic-curve v0.13.8
[INFO] [stderr]    Compiling clap_derive v4.6.1
[INFO] [stderr]    Compiling primeorder v0.13.6
[INFO] [stderr]    Compiling ecdsa v0.16.9
[INFO] [stderr]    Compiling p521 v0.13.3
[INFO] [stderr]    Compiling p384 v0.13.1
[INFO] [stderr]    Compiling p256 v0.13.2
[INFO] [stderr]    Compiling clap v4.6.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.6
[INFO] [stderr]    Compiling num-bigint v0.4.6
[INFO] [stderr]    Compiling zrtp v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 7.44s
[INFO] running `Command { std: "docker" "inspect" "9533007b5aa25c95e7d3afd8c278a01480e2c23938ca52e4c689e509e6e71d37", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "9533007b5aa25c95e7d3afd8c278a01480e2c23938ca52e4c689e509e6e71d37" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling zrtp v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.81s
[INFO] running `Command { std: "docker" "inspect" "9533007b5aa25c95e7d3afd8c278a01480e2c23938ca52e4c689e509e6e71d37", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "9533007b5aa25c95e7d3afd8c278a01480e2c23938ca52e4c689e509e6e71d37" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.07s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/zrtp/fcf81a67191ce586/out/zrtp-fcf81a67191ce586)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test wire::tests::crc32c_known_vector ... ok
[INFO] [stdout] test wire::tests::sas_base32_known_vector ... 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/protocol.rs (/opt/rustwide/target/debug/build/zrtp/ff3fd6ac22a56423/out/protocol-ff3fd6ac22a56423)
[INFO] [stdout] 
[INFO] [stdout] running 53 tests
[INFO] [stdout] test b256_uses_pgp_words ... ok
[INFO] [stdout] test commit_contention_prefers_dh_over_preshared ... ok
[INFO] [stdout] test commit_roundtrip ... ok
[INFO] [stdout] test commit_validation_rejects_wrong_multistream_nonce_shape ... ok
[INFO] [stdout] test confirm_content_roundtrip ... ok
[INFO] [stdout] test confirm_plaintext_rejects_bad_length ... ok
[INFO] [stdout] test commit_decode_rejects_truncated_body ... ok
[INFO] [stdout] test crypto_confirm_roundtrip ... ok
[INFO] [stdout] test hello_decode_rejects_truncated_body ... ok
[INFO] [stdout] test hello_decode_rejects_invalid_version ... ok
[INFO] [stdout] test malformed_message_non_word_aligned_is_rejected ... ok
[INFO] [stdout] test conf2ack_ignored_before_confirm2sent ... ok
[INFO] [stdout] test malformed_packet_bad_preamble_is_rejected ... ok
[INFO] [stdout] test hello_roundtrip ... ok
[INFO] [stdout] test duplicate_commit_nonce_is_rejected ... ok
[INFO] [stdout] test hvi_is_stable_for_same_transcript ... ok
[INFO] [stdout] test malformed_packet_bad_crc_is_rejected ... ok
[INFO] [stdout] test negotiation_rejects_ec38_without_sha384_hash ... ok
[INFO] [stdout] test negotiation_works ... ok
[INFO] [stdout] test packet_decode_rejects_bad_magic_cookie ... ok
[INFO] [stdout] test ping_decode_rejects_bad_length ... ok
[INFO] [stdout] test multistream_commit_uses_cached_secrets ... ok
[INFO] [stdout] test engine_rejects_out_of_order_confirm1 ... ok
[INFO] [stdout] test malformed_packet_too_short_is_rejected ... ok
[INFO] [stdout] test pingack_decode_rejects_bad_length ... ok
[INFO] [stdout] test packet_roundtrip ... ok
[INFO] [stdout] test malformed_message_bad_length_is_rejected ... ok
[INFO] [stdout] test hello_validation_rejects_too_many_algorithms ... ok
[INFO] [stdout] test pingack_roundtrip ... ok
[INFO] [stdout] test preshared_commit_requires_cached_secrets ... ok
[INFO] [stdout] test preshared_commit_validation_rejects_wrong_nonce_shape ... ok
[INFO] [stdout] test retransmit_state_advances_until_exhausted ... ok
[INFO] [stdout] test retransmit_state_stops_on_expected_ack ... ok
[INFO] [stdout] test retained_secret_match_helper_works ... ok
[INFO] [stdout] test retransmit_schedule_caps ... ok
[INFO] [stdout] test role_specific_secret_ids_differ ... ok
[INFO] [stdout] test preshared_commit_roundtrip_includes_key_id ... ok
[INFO] [stdout] test sasrelay_content_roundtrip ... ok
[INFO] [stdout] test sasrelay_plaintext_rejects_bad_length ... ok
[INFO] [stdout] test secret_store_roundtrip ... ok
[INFO] [stdout] test shared_secret_selection_prefers_rs1_then_rs2 ... ok
[INFO] [stdout] test unknown_message_roundtrip_preserves_body ... ok
[INFO] [stdout] test session_secrets_drive_confirm_build_and_open ... ok
[INFO] [stdout] test retained_secret_ids_are_stable ... ok
[INFO] [stdout] test responder_rejects_bad_hvi ... ok
[INFO] [stdout] test ecdh_shared_secret_matches ... ok
[INFO] [stdout] test ecdh_p521_shared_secret_matches ... ok
[INFO] [stdout] test engine_progresses ... ok
[INFO] [stdout] test modp_dh3072_shared_secret_matches ... ok
[INFO] [stdout] test conf2ack_also_completes_initiator ... ok
[INFO] [stdout] test initiator_updates_cache_on_conf2ack_or_srtp ... ok
[INFO] [stdout] test packet_pumped_handshake_reaches_secure_with_matching_sas ... ok
[INFO] [stdout] test engine_emits_sas_after_dh_exchange ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 53 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.46s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests zrtp
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/lib.rs - (line 21) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "9533007b5aa25c95e7d3afd8c278a01480e2c23938ca52e4c689e509e6e71d37", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9533007b5aa25c95e7d3afd8c278a01480e2c23938ca52e4c689e509e6e71d37", kill_on_drop: false }`
[INFO] [stdout] 9533007b5aa25c95e7d3afd8c278a01480e2c23938ca52e4c689e509e6e71d37
