[INFO] fetching crate mithril-stm 0.9.5...
[INFO] testing mithril-stm-0.9.5 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-1
[INFO] extracting crate mithril-stm 0.9.5 into /workspace/builds/worker-3-tc2/source
[INFO] started tweaking crates.io crate mithril-stm 0.9.5
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate mithril-stm 0.9.5
[INFO] tweaked toml for crates.io crate mithril-stm 0.9.5 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate mithril-stm 0.9.5 on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate mithril-stm 0.9.5 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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 21e6e17f119a242715b8f8be256462d2be63e77bfd5d03273c6001a3bf4aa14e
[INFO] running `Command { std: "docker" "start" "-a" "21e6e17f119a242715b8f8be256462d2be63e77bfd5d03273c6001a3bf4aa14e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "21e6e17f119a242715b8f8be256462d2be63e77bfd5d03273c6001a3bf4aa14e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "21e6e17f119a242715b8f8be256462d2be63e77bfd5d03273c6001a3bf4aa14e", kill_on_drop: false }`
[INFO] [stdout] 21e6e17f119a242715b8f8be256462d2be63e77bfd5d03273c6001a3bf4aa14e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8bd6479292a82da16bb600d80ba3457217ab06b134055ffe2689a7d4792f6bbf
[INFO] running `Command { std: "docker" "start" "-a" "8bd6479292a82da16bb600d80ba3457217ab06b134055ffe2689a7d4792f6bbf", kill_on_drop: false }`
[INFO] [stderr]    Compiling find-msvc-tools v0.1.7
[INFO] [stderr]    Compiling gmp-mpfr-sys v1.6.8
[INFO] [stderr]    Compiling az v1.2.1
[INFO] [stderr]    Compiling rug v1.28.0
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling threadpool v1.8.1
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling cc v1.2.52
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling blake2 v0.10.6
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling blst v0.3.16
[INFO] [stderr]    Compiling zeroize_derive v1.4.3
[INFO] [stderr]    Compiling thiserror-impl v2.0.17
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling zeroize v1.8.2
[INFO] [stderr]    Compiling thiserror v2.0.17
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling mithril-stm v0.9.5 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 4m 56s
[INFO] running `Command { std: "docker" "inspect" "8bd6479292a82da16bb600d80ba3457217ab06b134055ffe2689a7d4792f6bbf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8bd6479292a82da16bb600d80ba3457217ab06b134055ffe2689a7d4792f6bbf", kill_on_drop: false }`
[INFO] [stdout] 8bd6479292a82da16bb600d80ba3457217ab06b134055ffe2689a7d4792f6bbf
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 287ed6caf0b2019103a4d05afbd942d8a5b7723ce25b7804efb15389b981fec8
[INFO] running `Command { std: "docker" "start" "-a" "287ed6caf0b2019103a4d05afbd942d8a5b7723ce25b7804efb15389b981fec8", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling zmij v1.0.14
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling alloca v0.4.0
[INFO] [stderr]    Compiling zerocopy-derive v0.8.33
[INFO] [stderr]    Compiling clap_lex v0.7.7
[INFO] [stderr]    Compiling anstyle v1.0.13
[INFO] [stderr]    Compiling plotters-backend v0.3.7
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling itertools v0.13.0
[INFO] [stderr]    Compiling bit-vec v0.8.0
[INFO] [stderr]    Compiling quick-error v1.2.3
[INFO] [stderr]    Compiling cast v0.3.0
[INFO] [stderr]    Compiling page_size v0.6.0
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling plotters-svg v0.3.7
[INFO] [stderr]    Compiling anes v0.1.6
[INFO] [stderr]    Compiling unarray v0.1.4
[INFO] [stderr]    Compiling oorandom v11.1.5
[INFO] [stderr]    Compiling num-rational v0.4.2
[INFO] [stderr]    Compiling clap_builder v4.5.54
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling bit-set v0.8.0
[INFO] [stderr]    Compiling zerocopy v0.8.33
[INFO] [stderr]    Compiling criterion-plot v0.8.1
[INFO] [stderr]    Compiling regex v1.12.2
[INFO] [stderr]    Compiling tempfile v3.24.0
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling clap v4.5.54
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling mithril-stm v0.9.5 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling proptest v1.9.0
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling criterion v0.8.1
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 29.69s
[INFO] running `Command { std: "docker" "inspect" "287ed6caf0b2019103a4d05afbd942d8a5b7723ce25b7804efb15389b981fec8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "287ed6caf0b2019103a4d05afbd942d8a5b7723ce25b7804efb15389b981fec8", kill_on_drop: false }`
[INFO] [stdout] 287ed6caf0b2019103a4d05afbd942d8a5b7723ce25b7804efb15389b981fec8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a441e6b35153e16037fcc14de41e5c5564ca58a330f508a67cc6073515a750e8
[INFO] running `Command { std: "docker" "start" "-a" "a441e6b35153e16037fcc14de41e5c5564ca58a330f508a67cc6073515a750e8", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.19s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/mithril_stm-8556bed2279d5c3e)
[INFO] [stdout] 
[INFO] [stdout] running 42 tests
[INFO] [stdout] test protocol::aggregate_signature::signature::tests::aggregate_signature_type_golden::golden_bytes_encoding_prefix ... ok
[INFO] [stdout] test protocol::aggregate_signature::signature::tests::aggregate_signature_golden_concatenation::golden_conversions ... ok
[INFO] [stdout] test protocol::aggregate_signature::tests::test_parameters_serialize_deserialize ... ok
[INFO] [stdout] test protocol::aggregate_signature::tests::test_initializer_serialize_deserialize ... ok
[INFO] [stdout] test protocol::aggregate_signature::aggregate_key::tests::golden::golden_conversions ... ok
[INFO] [stdout] test protocol::eligibility_check::tests::is_lottery_won_check_precision_against_trivial_implementation ... ok
[INFO] [stdout] test membership_commitment::merkle_tree::tree::tests::test_bytes_tree ... ok
[INFO] [stdout] test protocol::key_registration::tests::golden::golden_conversions ... ok
[INFO] [stdout] test protocol::parameters::tests::golden::golden_conversions ... ok
[INFO] [stdout] test protocol::participant::initializer::tests::golden::golden_conversions ... ok
[INFO] [stdout] test membership_commitment::merkle_tree::tree::tests::test_create_batch_proof ... ok
[INFO] [stdout] test protocol::single_signature::signature::tests::golden::golden_conversions ... ok
[INFO] [stdout] test protocol::single_signature::signature::tests::golden_json::golden_conversions ... ok
[INFO] [stdout] test signature_scheme::bls_multi_signature::proof_of_possession::tests::golden::golden_conversions ... ok
[INFO] [stdout] test signature_scheme::bls_multi_signature::signature::tests::golden::golden_conversions ... ok
[INFO] [stdout] test signature_scheme::bls_multi_signature::signing_key::tests::golden::golden_conversions ... ok
[INFO] [stdout] test membership_commitment::merkle_tree::tree::tests::test_bytes_batch_path ... ok
[INFO] [stdout] test protocol::single_signature::signature_registered_party::tests::golden::golden_conversions ... ok
[INFO] [stdout] test signature_scheme::bls_multi_signature::tests::serialize_deserialize_sk ... ok
[INFO] [stdout] test protocol::aggregate_signature::tests::test_sig_serialize_deserialize ... ok
[INFO] [stdout] test protocol::aggregate_signature::tests::test_sig ... ok
[INFO] [stdout] test membership_commitment::merkle_tree::tree::tests::test_create_invalid_batch_proof ... ok
[INFO] [stdout] test signature_scheme::bls_multi_signature::tests::test_infinity_sig ... ok
[INFO] [stdout] test signature_scheme::bls_multi_signature::tests::test_eval_sanity_check ... ok
[INFO] [stdout] test signature_scheme::bls_multi_signature::tests::test_infinity_vk ... ok
[INFO] [stdout] test signature_scheme::bls_multi_signature::tests::serialize_deserialize_vk ... ok
[INFO] [stdout] test signature_scheme::bls_multi_signature::verification_key::tests::golden::golden_conversions ... ok
[INFO] [stdout] test protocol::aggregate_signature::tests::test_invalid_proof_quorum ... ok
[INFO] [stdout] test protocol::aggregate_signature::tests::test_invalid_proof_index_unique ... ok
[INFO] [stdout] test protocol::aggregate_signature::tests::test_invalid_proof_path ... ok
[INFO] [stdout] test protocol::aggregate_signature::clerk::tests::test_dedup ... ok
[INFO] [stdout] test protocol::aggregate_signature::tests::test_invalid_proof_index_bound ... ok
[INFO] [stdout] test protocol::aggregate_signature::tests::test_multisig_serialize_deserialize ... ok
[INFO] [stdout] test signature_scheme::bls_multi_signature::tests::test_invalid_sig ... ok
[INFO] [stdout] test signature_scheme::bls_multi_signature::tests::test_sig ... ok
[INFO] [stdout] test protocol::aggregate_signature::tests::test_aggregate_sig ... ok
[INFO] [stdout] test protocol::key_registration::tests::test_keyreg ... ok
[INFO] [stdout] test protocol::aggregate_signature::tests::batch_verify has been running for over 60 seconds
[INFO] [stdout] test protocol::aggregate_signature::tests::test_adversary_quorum has been running for over 60 seconds
[INFO] [stdout] test signature_scheme::bls_multi_signature::tests::batch_verify has been running for over 60 seconds
[INFO] [stdout] test signature_scheme::bls_multi_signature::tests::test_aggregate_sig has been running for over 60 seconds
[INFO] [stdout] test protocol::aggregate_signature::tests::test_adversary_quorum ... ok
[INFO] [stdout] test signature_scheme::bls_multi_signature::tests::test_keyreg_with_infinity_vk has been running for over 60 seconds
[INFO] [stdout] test signature_scheme::bls_multi_signature::tests::test_aggregate_sig ... ok
[INFO] [stdout] test protocol::aggregate_signature::tests::batch_verify ... ok
[INFO] [stdout] test signature_scheme::bls_multi_signature::tests::test_keyreg_with_infinity_vk ... ok
[INFO] [stdout] test signature_scheme::bls_multi_signature::tests::batch_verify ... ok
[INFO] [stderr]      Running tests/bytes_conversion.rs (/opt/rustwide/target/debug/deps/bytes_conversion-665d181c954576a1)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 42 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 151.05s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_stm_parameters_serialization ... ok
[INFO] [stdout] test test_binary_conversions ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.41s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/stm_protocol.rs (/opt/rustwide/target/debug/deps/stm_protocol-f0eb746221a01f59)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_full_protocol ... ok
[INFO] [stdout] test test_full_protocol_batch_verify ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.63s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests mithril_stm
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/lib.rs - (line 328) ... ok
[INFO] [stdout] test src/lib.rs - (line 175) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.57s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 3.36s; merged doctests compilation took 1.77s
[INFO] running `Command { std: "docker" "inspect" "a441e6b35153e16037fcc14de41e5c5564ca58a330f508a67cc6073515a750e8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a441e6b35153e16037fcc14de41e5c5564ca58a330f508a67cc6073515a750e8", kill_on_drop: false }`
[INFO] [stdout] a441e6b35153e16037fcc14de41e5c5564ca58a330f508a67cc6073515a750e8