[INFO] fetching crate sframe 1.1.0...
[INFO] testing sframe-1.1.0 against 1.95.0 for beta-1.96-2
[INFO] extracting crate sframe 1.1.0 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate sframe 1.1.0
[INFO] removed 0 missing examples
[INFO] finished tweaking crates.io crate sframe 1.1.0
[INFO] tweaked toml for crates.io crate sframe 1.1.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate sframe 1.1.0 on toolchain 1.95.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.95.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate sframe 1.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.95.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded bbqueue v0.5.1
[INFO] [stderr]   Downloaded simple_logger v5.1.0
[INFO] [stderr]   Downloaded bitfield-macros v0.19.4
[INFO] [stderr]   Downloaded cc v1.2.53
[INFO] [stderr]   Downloaded bitfield v0.19.4
[INFO] [stderr]   Downloaded konst v0.2.19
[INFO] [stderr]   Downloaded cgisf_lib v0.2.1
[INFO] [stderr]   Downloaded zmij v1.0.14
[INFO] [stderr]   Downloaded openssl-src v300.5.4+3.5.4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] e6c107f6b15415a0cc0966e66d2d9a2999003dc121080f6589ad8b2998074206
[INFO] running `Command { std: "docker" "start" "-a" "e6c107f6b15415a0cc0966e66d2d9a2999003dc121080f6589ad8b2998074206", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e6c107f6b15415a0cc0966e66d2d9a2999003dc121080f6589ad8b2998074206", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e6c107f6b15415a0cc0966e66d2d9a2999003dc121080f6589ad8b2998074206", kill_on_drop: false }`
[INFO] [stdout] e6c107f6b15415a0cc0966e66d2d9a2999003dc121080f6589ad8b2998074206
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=warn" "-e" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ec63ce6feddf3cbeac39c5f7f9c08be4fdf7d41a032ec41855f08c99e13e8ae1
[INFO] running `Command { std: "docker" "start" "-a" "ec63ce6feddf3cbeac39c5f7f9c08be4fdf7d41a032ec41855f08c99e13e8ae1", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling libc v0.2.180
[INFO] [stderr]    Compiling thiserror v2.0.17
[INFO] [stderr]    Compiling cc v1.2.53
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling bitfield-macros v0.19.4
[INFO] [stderr]    Compiling thiserror-impl v2.0.17
[INFO] [stderr]    Compiling bitfield v0.19.4
[INFO] [stderr]    Compiling sframe v1.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 9.81s
[INFO] running `Command { std: "docker" "inspect" "ec63ce6feddf3cbeac39c5f7f9c08be4fdf7d41a032ec41855f08c99e13e8ae1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ec63ce6feddf3cbeac39c5f7f9c08be4fdf7d41a032ec41855f08c99e13e8ae1", kill_on_drop: false }`
[INFO] [stdout] ec63ce6feddf3cbeac39c5f7f9c08be4fdf7d41a032ec41855f08c99e13e8ae1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=warn" "-e" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2fbef6aed716a800adddbb8d8f3c0d7de3b277ea8d59d47057c41bb3dd35afe7
[INFO] running `Command { std: "docker" "start" "-a" "2fbef6aed716a800adddbb8d8f3c0d7de3b277ea8d59d47057c41bb3dd35afe7", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling zerocopy v0.8.33
[INFO] [stderr]    Compiling siphasher v1.0.1
[INFO] [stderr]    Compiling zmij v1.0.14
[INFO] [stderr]    Compiling alloca v0.4.0
[INFO] [stderr]    Compiling konst_macro_rules v0.2.19
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling const_format_proc_macros v0.2.34
[INFO] [stderr]    Compiling time-macros v0.2.25
[INFO] [stderr]    Compiling itertools v0.13.0
[INFO] [stderr]    Compiling num_threads v0.1.7
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling rayon v1.11.0
[INFO] [stderr]    Compiling page_size v0.6.0
[INFO] [stderr]    Compiling colored v3.1.1
[INFO] [stderr]    Compiling konst v0.2.19
[INFO] [stderr]    Compiling bbqueue v0.5.1
[INFO] [stderr]    Compiling phf_shared v0.13.1
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling phf_generator v0.13.1
[INFO] [stderr]    Compiling const_format v0.2.35
[INFO] [stderr]    Compiling time v0.3.45
[INFO] [stderr]    Compiling criterion-plot v0.8.1
[INFO] [stderr]    Compiling simple_logger v5.1.0
[INFO] [stderr]    Compiling test-case-core v3.3.1
[INFO] [stderr]    Compiling zerocopy-derive v0.8.33
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling bitfield-macros v0.19.4
[INFO] [stderr]    Compiling thiserror-impl v2.0.17
[INFO] [stderr]    Compiling clap_derive v4.5.49
[INFO] [stderr]    Compiling phf_macros v0.13.1
[INFO] [stderr]    Compiling test-case-macros v3.3.1
[INFO] [stderr]    Compiling test-case v3.3.1
[INFO] [stderr]    Compiling phf v0.13.1
[INFO] [stderr]    Compiling bitfield v0.19.4
[INFO] [stderr]    Compiling thiserror v2.0.17
[INFO] [stderr]    Compiling sframe v1.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling clap v4.5.54
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling cgisf_lib v0.2.1
[INFO] [stderr]    Compiling criterion v0.8.1
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 29.12s
[INFO] running `Command { std: "docker" "inspect" "2fbef6aed716a800adddbb8d8f3c0d7de3b277ea8d59d47057c41bb3dd35afe7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2fbef6aed716a800adddbb8d8f3c0d7de3b277ea8d59d47057c41bb3dd35afe7", kill_on_drop: false }`
[INFO] [stdout] 2fbef6aed716a800adddbb8d8f3c0d7de3b277ea8d59d47057c41bb3dd35afe7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=warn" "-e" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a47a133ddc252ec648b07e3b9a824a14c6e9bd374f2a919929a9bbb972419865
[INFO] running `Command { std: "docker" "start" "-a" "a47a133ddc252ec648b07e3b9a824a14c6e9bd374f2a919929a9bbb972419865", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.21s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/sframe-91ff3e1de8eb8a5d)
[INFO] [stdout] 
[INFO] [stdout] running 63 tests
[INFO] [stdout] test crypto::aead::test::encrypt_random_frame ... ok
[INFO] [stdout] test crypto::buffer::decryption::test::allocate_decryption_buffer ... ok
[INFO] [stdout] test crypto::buffer::decryption::test::truncate_decryption_buffer ... ok
[INFO] [stdout] test crypto::buffer::encryption::test::allocate_encryption_buffer ... ok
[INFO] [stdout] test crypto::key_derivation::test::ratchets_key::aesgcm128sha256 ... ok
[INFO] [stdout] test crypto::key_derivation::test::ratchets_key::aesgcm256sha512 ... ok
[INFO] [stdout] test frame::encrypted_frame::test::new_encrypted_frame_view_with_meta_data ... ok
[INFO] [stdout] test frame::encrypted_frame::test::new_encrypted_frame_with_meta_data ... ok
[INFO] [stdout] test frame::frame_counter::test::create_increasing_counters ... ok
[INFO] [stdout] test frame::frame_buffer::test::allocate_vec_buffer ... ok
[INFO] [stdout] test frame::frame_counter::test::wraps_after_u64_max_was_reached ... ok
[INFO] [stdout] test frame::media_frame::test::create_media_frame_with_meta_data ... ok
[INFO] [stdout] test frame::media_frame::test::encrypt_media_frame ... ok
[INFO] [stdout] test frame::test::encrypt_decrypt_frame_view ... ok
[INFO] [stdout] test frame::test::encrypt_decrypt_frame_with_meta_data ... ok
[INFO] [stdout] test frame::validation::test::accept_newer_headers ... ok
[INFO] [stdout] test frame::test::encrypt_decrypt_frame_view_with_meta_data ... ok
[INFO] [stdout] test frame::validation::test::accept_older_headers_in_tolerance ... ok
[INFO] [stdout] test frame::validation::test::handle_overflowing_counters ... ok
[INFO] [stdout] test frame::validation::test::reject_too_old_headers ... ok
[INFO] [stdout] test header::test::fail_to_serialize_when_buffer_is_empty ... ok
[INFO] [stdout] test frame::frame_counter::test::wraps_after_max_counter_was_reached ... ok
[INFO] [stdout] test frame::media_frame::test::encrypt_media_frame_view ... ok
[INFO] [stdout] test header::util::test::nof_non_zero_bytes ... ok
[INFO] [stdout] test mls::mls_key_id::tests::test_exceeded_mls_bit_range ... ok
[INFO] [stdout] test mls::mls_key_id::tests::test_mls_key_id_creation ... ok
[INFO] [stdout] test mls::mls_key_id::tests::test_mls_key_id_creation_values_exceeding_bit_range ... ok
[INFO] [stdout] test mls::mls_key_id::tests::test_mls_key_id_from_key_id ... ok
[INFO] [stdout] test mls::test::derive_key_from_mls ... ok
[INFO] [stdout] test mls::test::derive_key_from_mls_failed_export ... ok
[INFO] [stdout] test header::test::fail_to_deserialize_when_buffer_is_too_small ... ok
[INFO] [stdout] test crypto::aead::test::decrypt_test_vector::aesgcm256sha512 ... ok
[INFO] [stdout] test crypto::key_derivation::test::extracts_correct_labels::aesgcm128sha256 ... ok
[INFO] [stdout] test crypto::aead::test::encrypt_test_vector::aesgcm256sha512 ... ok
[INFO] [stdout] test crypto::key_derivation::test::derive_correct_base_keys::aesgcm128sha256 ... ok
[INFO] [stdout] test ratchet::ratcheting_base_key::test::should_ratchet_forward ... ok
[INFO] [stdout] test crypto::key_derivation::test::extracts_correct_labels::aesgcm256sha512 ... ok
[INFO] [stdout] test crypto::secret::test::create_correct_nonce::aesgcm128sha256 ... ok
[INFO] [stdout] test header::test::deserialize_test_vectors ... ok
[INFO] [stdout] test crypto::aead::test::encrypt_test_vector::aesgcm128sha256 ... ok
[INFO] [stdout] test ratchet::ratcheting_key_id::test::inc_ratchet_step ... ok
[INFO] [stdout] test header::test::fail_to_deserialize_when_buffer_is_empty ... ok
[INFO] [stdout] test ratchet::ratcheting_key_id::test::limits_n_ratchet_bits_to_63 ... ok
[INFO] [stdout] test ratchet::ratcheting_key_id::test::returns_correct_ratcheting_params ... ok
[INFO] [stdout] test ratchet::ratcheting_key_id::test::works_with_hash_maps ... ok
[INFO] [stdout] test ratchet::ratcheting_key_id::test::works_with_zero_ratcheting_bits ... ok
[INFO] [stdout] test ratchet::ratcheting_key_store::test::removes_key ... ok
[INFO] [stdout] test ratchet::ratcheting_key_store::test::returns_none_for_unknown_key_on_get ... ok
[INFO] [stdout] test ratchet::ratcheting_key_store::test::inserts_key_and_ratches_forward_if_needed ... ok
[INFO] [stdout] test ratchet::ratcheting_key_store::test::returns_err_for_unknown_key_on_ratcheting_get ... ok
[INFO] [stdout] test ratchet::ratcheting_key_store::test::stores_ratcheted_key ... ok
[INFO] [stdout] test ratchet::ratcheting_key_store::test::expands_and_ratchets_forward_on_insert ... ok
[INFO] [stdout] test ratchet::ratcheting_key_store::test::ratchets_on_ratcheting_step_overflow ... ok
[INFO] [stdout] test ratchet::ratcheting_key_store::test::inserts_and_gets_key ... ok
[INFO] [stdout] test test_vectors::test::should_parse_header_test_vectors ... ok
[INFO] [stdout] test header::test::serialize_test_vectors ... ok
[INFO] [stdout] test ratchet::ratcheting_key_id::test::compares_only_generations ... ok
[INFO] [stdout] test test_vectors::test::should_parse_sframe_test_vectors ... ok
[INFO] [stdout] test crypto::aead::test::decrypt_test_vector::aesgcm128sha256 ... ok
[INFO] [stdout] test crypto::secret::test::create_correct_nonce::aesgcm256sha512 ... ok
[INFO] [stdout] test test_vectors::test::should_parse_aes_test_vectors ... ok
[INFO] [stdout] test crypto::key_derivation::test::derive_correct_base_keys::aesgcm256sha512 ... ok
[INFO] [stdout] test header::test::fail_to_serialize_when_buffer_is_too_small ... ok
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests sframe
[INFO] [stdout] test result: ok. 63 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 src/frame/mod.rs - frame (line 20) ... ok
[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] all doctests ran in 0.56s; merged doctests compilation took 0.55s
[INFO] running `Command { std: "docker" "inspect" "a47a133ddc252ec648b07e3b9a824a14c6e9bd374f2a919929a9bbb972419865", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a47a133ddc252ec648b07e3b9a824a14c6e9bd374f2a919929a9bbb972419865", kill_on_drop: false }`
[INFO] [stdout] a47a133ddc252ec648b07e3b9a824a14c6e9bd374f2a919929a9bbb972419865
