[INFO] cloning repository https://github.com/adevsh/ferrite
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/adevsh/ferrite" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fadevsh%2Fferrite", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fadevsh%2Fferrite'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] a6418861b9511014fd580a8ff4693121ff92a88b
[INFO] testing adevsh/ferrite against 1.100.0-beta.1+cargoflags=--release for beta-release-1.100-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fadevsh%2Fferrite" "/workspace/builds/worker-3-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/adevsh/ferrite
[INFO] finished tweaking git repo https://github.com/adevsh/ferrite
[INFO] tweaked toml for git repo https://github.com/adevsh/ferrite written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/adevsh/ferrite 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 git repo https://github.com/adevsh/ferrite 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] [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/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 1a2a219d5e8410e4cc7ce07fd2cc2938bbebd629758fd9e727b8a60a9e7cc307
[INFO] running `Command { std: "docker" "start" "1a2a219d5e8410e4cc7ce07fd2cc2938bbebd629758fd9e727b8a60a9e7cc307", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1a2a219d5e8410e4cc7ce07fd2cc2938bbebd629758fd9e727b8a60a9e7cc307", 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" "1a2a219d5e8410e4cc7ce07fd2cc2938bbebd629758fd9e727b8a60a9e7cc307" "/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" "1a2a219d5e8410e4cc7ce07fd2cc2938bbebd629758fd9e727b8a60a9e7cc307", 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" "1a2a219d5e8410e4cc7ce07fd2cc2938bbebd629758fd9e727b8a60a9e7cc307" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling anstyle v1.0.14
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling colorchoice v1.0.5
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling clap_lex v1.1.0
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling anstyle-parse v1.0.0
[INFO] [stderr]    Compiling crc32fast v1.5.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling anstream v1.0.0
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling clap_derive v4.6.1
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling clap v4.6.1
[INFO] [stderr]    Compiling ferrite v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 11.14s
[INFO] running `Command { std: "docker" "inspect" "1a2a219d5e8410e4cc7ce07fd2cc2938bbebd629758fd9e727b8a60a9e7cc307", 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" "1a2a219d5e8410e4cc7ce07fd2cc2938bbebd629758fd9e727b8a60a9e7cc307" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.186
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling bitflags v2.11.1
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling ferrite v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 6.39s
[INFO] running `Command { std: "docker" "inspect" "1a2a219d5e8410e4cc7ce07fd2cc2938bbebd629758fd9e727b8a60a9e7cc307", 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" "1a2a219d5e8410e4cc7ce07fd2cc2938bbebd629758fd9e727b8a60a9e7cc307" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/build/ferrite/74d6c5a5bef041f8/out/ferrite-74d6c5a5bef041f8)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test bloom::tests::test_djb2_empty_is_seed ... ok
[INFO] [stdout] test bloom::tests::test_fnv1a_known_vectors ... ok
[INFO] [stdout] test codec::tests::test_encode_bytes_layout ... ok
[INFO] [stdout] test codec::tests::test_u32_short_buffer ... ok
[INFO] [stdout] test bloom::tests::test_probe_idx_in_range ... ok
[INFO] [stdout] test codec::tests::test_u64_roundtrip ... ok
[INFO] [stdout] test codec::tests::test_u32_roundtrip ... ok
[INFO] [stdout] test codec::tests::test_encode_bytes_empty_val ... ok
[INFO] [stdout] test codec::tests::test_u64_short_buffer ... ok
[INFO] [stdout] test bloom::tests::test_hash_functions_differ ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/release/build/ferrite/001ce6a8c55b9688/out/ferrite-001ce6a8c55b9688)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/bloom_test.rs (/opt/rustwide/target/release/build/ferrite/8400c17c13368097/out/bloom_test-8400c17c13368097)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test test_single_item_round_trip ... ok
[INFO] [stdout] test test_serialize_round_trip_preserves_membership ... ok
[INFO] [stdout] test test_no_false_negatives_on_10k_keys ... ok
[INFO] [stdout] test test_false_positive_rate_within_bound ... ok
[INFO] [stdout] test test_empty_filter_returns_false_for_all ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stderr]      Running tests/cache_test.rs (/opt/rustwide/target/release/build/ferrite/7e51db0465830d54/out/cache_test-7e51db0465830d54)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test test_get_missing_key_returns_none_and_increments_miss ... ok
[INFO] [stdout] test test_access_pattern_promotes_node ... ok
[INFO] [stdout] test test_invalidate_removes_only_matching_path ... ok
[INFO] [stdout] test test_basic_insert_and_get ... ok
[INFO] [stdout] test test_capacity_eviction_lru_order ... ok
[INFO] [stdout] test test_hit_ratio_above_80_percent_acceptance ... ok
[INFO] [stdout] test test_insert_overwrite_updates_value_and_size ... ok
[INFO] [stdout] test test_drop_releases_all_nodes ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/compaction_test.rs (/opt/rustwide/target/release/build/ferrite/a91e24c00466c0b5/out/compaction_test-a91e24c00466c0b5)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test test_compact_returns_files_merged_count ... ok
[INFO] [stdout] test test_should_compact_threshold ... ok
[INFO] [stdout] test test_compact_drops_tombstone_at_bottom_level ... ok
[INFO] [stdout] test test_compact_l0_to_l1_dedupes_and_clears_l0 ... ok
[INFO] [stdout] test test_cache_invalidated_for_old_sstables ... ok
[INFO] [stdout] test test_restart_engine_after_compaction ... ok
[INFO] [stdout] test test_data_intact_through_3_compaction_cycles ... ok
[INFO] [stdout] test test_cascade_l0_to_l1_to_l2 ... ok
[INFO] [stdout] test test_l0_file_count_bounded_after_20_flushes ... ok
[INFO] [stdout] test test_compact_keeps_tombstone_when_lower_levels_exist ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running tests/engine_test.rs (/opt/rustwide/target/release/build/ferrite/63581fcdb5ff2582/out/engine_test-63581fcdb5ff2582)
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.32s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test test_stats_reflects_memtable_size ... ok
[INFO] [stdout] test test_delete_tombstone_before_and_after_flush ... ok
[INFO] [stdout] test test_overwrite_after_flush_returns_newest ... ok
[INFO] [stdout] test test_put_get_basic ... ok
[INFO] [stdout] test test_scan_prefix_dedupes_across_layers ... ok
[INFO] [stdout] test test_stats_counts_sstables_per_level ... ok
[INFO] [stdout] test test_put_get_across_flush_boundary ... ok
[INFO] [stdout] test test_restart_engine_after_flush_reads_from_sstable ... ok
[INFO] [stdout] test test_restart_engine_recovers_memtable_from_wal ... ok
[INFO] [stdout] test test_100k_sequential_puts_then_reads has been running for over 60 seconds
[INFO] [stdout] test test_100k_sequential_puts_then_reads ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 110.80s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/memtable_test.rs (/opt/rustwide/target/release/build/ferrite/45b1aa21a88054c3/out/memtable_test-45b1aa21a88054c3)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test test_delete_returns_tombstone_not_none ... ok
[INFO] [stdout] test test_is_full_threshold_boundary ... ok
[INFO] [stdout] test test_restore_from_wal_matches_original ... ok
[INFO] [stdout] test test_size_grows_on_put_does_not_shrink_on_delete ... ok
[INFO] [stdout] test test_scan_prefix_filters_correctly ... ok
[INFO] [stdout] test test_put_1000_keys_round_trip ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/sstable_test.rs (/opt/rustwide/target/release/build/ferrite/437b0e87ae33c1a6/out/sstable_test-437b0e87ae33c1a6)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test test_meta_smallest_largest_count ... ok
[INFO] [stdout] test test_iter_yields_all_in_order_including_tombstones ... ok
[INFO] [stdout] test test_get_present_key_returns_value ... ok
[INFO] [stdout] test test_tombstone_get_returns_some_none ... ok
[INFO] [stdout] test test_scan_prefix_filters_and_sorts ... ok
[INFO] [stdout] test test_get_missing_key_bloom_short_circuits ... ok
[INFO] [stdout] test test_corrupt_data_block_detected ... ok
[INFO] [stdout] test test_open_invalid_magic_rejected ... ok
[INFO] [stdout] test test_round_trip_10k_entries ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/wal_test.rs (/opt/rustwide/target/release/build/ferrite/7244b08055d46def/out/wal_test-7244b08055d46def)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test test_survives_simulated_crash ... ok
[INFO] [stdout] test test_truncate_resets_to_empty ... ok
[INFO] [stdout] test test_recovers_mixed_puts_and_deletes ... ok
[INFO] [stdout] test test_tail_corruption_is_dropped ... ok
[INFO] [stdout] test test_recovers_100_puts ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.12s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests ferrite
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "1a2a219d5e8410e4cc7ce07fd2cc2938bbebd629758fd9e727b8a60a9e7cc307", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1a2a219d5e8410e4cc7ce07fd2cc2938bbebd629758fd9e727b8a60a9e7cc307", kill_on_drop: false }`
[INFO] [stdout] 1a2a219d5e8410e4cc7ce07fd2cc2938bbebd629758fd9e727b8a60a9e7cc307
