[INFO] cloning repository https://github.com/jashkaransingh/minidb
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/jashkaransingh/minidb" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjashkaransingh%2Fminidb", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjashkaransingh%2Fminidb'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 368a5fdd0aef3eacceaa112f848f16e2e0379fe2
[INFO] testing jashkaransingh/minidb against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjashkaransingh%2Fminidb" "/workspace/builds/worker-3-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/jashkaransingh/minidb
[INFO] finished tweaking git repo https://github.com/jashkaransingh/minidb
[INFO] tweaked toml for git repo https://github.com/jashkaransingh/minidb written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/jashkaransingh/minidb on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/jashkaransingh/minidb 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.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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] 9ab9753d8005c863193bc2fe343664328a73b232d3a4c3f0f0c06bafbe134ee8
[INFO] running `Command { std: "docker" "start" "9ab9753d8005c863193bc2fe343664328a73b232d3a4c3f0f0c06bafbe134ee8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9ab9753d8005c863193bc2fe343664328a73b232d3a4c3f0f0c06bafbe134ee8", 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" "9ab9753d8005c863193bc2fe343664328a73b232d3a4c3f0f0c06bafbe134ee8" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9ab9753d8005c863193bc2fe343664328a73b232d3a4c3f0f0c06bafbe134ee8", 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" "9ab9753d8005c863193bc2fe343664328a73b232d3a4c3f0f0c06bafbe134ee8" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling crc32fast v1.5.0
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling minidb v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized + debuginfo] target(s) in 8.95s
[INFO] running `Command { std: "docker" "inspect" "9ab9753d8005c863193bc2fe343664328a73b232d3a4c3f0f0c06bafbe134ee8", 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" "9ab9753d8005c863193bc2fe343664328a73b232d3a4c3f0f0c06bafbe134ee8" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling minidb v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized + debuginfo] target(s) in 15.82s
[INFO] running `Command { std: "docker" "inspect" "9ab9753d8005c863193bc2fe343664328a73b232d3a4c3f0f0c06bafbe134ee8", 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" "9ab9753d8005c863193bc2fe343664328a73b232d3a4c3f0f0c06bafbe134ee8" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/minidb-4f97e3027fd50c4d)
[INFO] [stdout] 
[INFO] [stdout] running 148 tests
[INFO] [stdout] test bloom::tests::hashing_is_deterministic_across_calls ... ok
[INFO] [stdout] test bloom::tests::degenerate_parameters_still_produce_a_usable_filter ... ok
[INFO] [stdout] test bloom::tests::an_empty_filter_reports_everything_as_absent ... ok
[INFO] [stdout] test bloom::tests::sizing_follows_the_textbook_formula ... ok
[INFO] [stdout] test bloom::tests::fill_ratio_and_estimated_rate_track_insertions ... ok
[INFO] [stdout] test bloom::tests::the_second_hash_is_always_odd ... ok
[INFO] [stdout] test bloom::tests::a_filter_survives_an_encode_decode_round_trip ... ok
[INFO] [stdout] test bloom::tests::insert_hashed_matches_insert ... ok
[INFO] [stdout] test bloom::tests::a_tighter_target_rate_produces_a_larger_filter ... ok
[INFO] [stdout] test compaction::tests::a_size_tier_is_selected_out_of_a_mixed_store ... ok
[INFO] [stdout] test bloom::tests::truncated_and_empty_input_fails_to_decode ... ok
[INFO] [stdout] test bloom::tests::a_corrupted_filter_fails_to_decode ... ok
[INFO] [stdout] test compaction::tests::a_merge_is_capped_at_the_maximum_width ... ok
[INFO] [stdout] test compaction::tests::a_marker_round_trips_through_its_encoding ... ok
[INFO] [stdout] test bloom::tests::binary_and_empty_keys_are_handled ... ok
[INFO] [stdout] test bloom::tests::the_false_positive_rate_is_near_the_target ... ok
[INFO] [stdout] test bloom::tests::an_inserted_key_is_always_reported_as_present ... ok
[INFO] [stdout] test compaction::tests::nothing_to_do_below_the_minimum_width ... ok
[INFO] [stdout] test compaction::tests::planned_inputs_are_always_contiguous_in_recency_order ... ok
[INFO] [stdout] test concurrent::tests::clones_share_one_underlying_store ... ok
[INFO] [stdout] test compaction::tests::an_empty_marker_decodes_to_nothing ... ok
[INFO] [stdout] test compaction::tests::four_similar_tables_are_merged ... ok
[INFO] [stdout] test iter::tests::a_newer_memtable_shadows_an_older_one ... ok
[INFO] [stdout] test fault::tests::an_armed_plan_records_its_offset ... ok
[INFO] [stdout] test concurrent::tests::a_snapshot_gives_a_consistent_multi_read_view ... ok
[INFO] [stdout] test iter::tests::an_empty_value_is_yielded_rather_than_treated_as_absent ... ok
[INFO] [stdout] test iter::tests::a_single_memtable_resolves_versions_and_tombstones ... ok
[INFO] [stdout] test concurrent::tests::a_borrowed_db_is_the_same_store ... ok
[INFO] [stdout] test fault::tests::an_unarmed_plan_never_fires ... ok
[INFO] [stdout] test fault::tests::a_simulated_crash_is_distinguishable_from_a_real_error ... ok
[INFO] [stdout] test iter::tests::a_snapshot_hides_newer_versions_including_tombstones ... ok
[INFO] [stdout] test compaction::tests::tombstones_are_only_droppable_when_the_oldest_table_participates ... ok
[INFO] [stdout] test compaction::tests::tables_of_very_different_sizes_are_not_merged_together ... ok
[INFO] [stdout] test concurrent::tests::the_handles_are_send_and_sync ... ok
[INFO] [stdout] test compaction::tests::the_output_slot_takes_the_newest_inputs_position ... ok
[INFO] [stdout] test iter::tests::an_identical_internal_key_in_two_sources_is_emitted_once ... ok
[INFO] [stdout] test compaction::tests::the_widest_run_is_preferred ... ok
[INFO] [stdout] test iter::tests::an_iterator_over_no_sources_is_empty ... ok
[INFO] [stdout] test memtable::tests::a_tombstone_hides_older_versions_but_not_from_older_snapshots ... ok
[INFO] [stdout] test iter::tests::the_range_is_half_open ... ok
[INFO] [stdout] test memtable::tests::a_snapshot_does_not_see_versions_written_after_it ... ok
[INFO] [stdout] test memtable::tests::a_seek_past_a_keys_versions_does_not_leak_the_next_key ... ok
[INFO] [stdout] test memtable::tests::an_empty_value_is_distinct_from_a_tombstone ... ok
[INFO] [stdout] test iter::tests::the_successor_of_a_key_sorts_immediately_after_it ... ok
[INFO] [stdout] test fault::tests::a_compaction_plan_records_its_phase ... ok
[INFO] [stdout] test memtable::tests::a_fresh_memtable_starts_empty ... ok
[INFO] [stdout] test memtable::tests::an_overwrite_adds_a_version_rather_than_replacing_one ... ok
[INFO] [stdout] test concurrent::tests::an_in_memory_shared_store_round_trips ... ok
[INFO] [stdout] test memtable::tests::binary_keys_and_values_are_supported ... ok
[INFO] [stdout] test memtable::tests::get_on_empty_table_returns_none ... ok
[INFO] [stdout] test memtable::tests::compare_internal_matches_the_internal_key_ordering ... ok
[INFO] [stdout] test skiplist::tests::accounting_tracks_size_and_the_highest_sequence ... ok
[INFO] [stdout] test memtable::tests::size_tracking_grows_with_every_version ... ok
[INFO] [stdout] test skiplist::tests::entries_iterate_in_internal_key_order_regardless_of_insertion_order ... ok
[INFO] [stdout] test memtable::tests::an_unbounded_range_runs_to_the_end ... ok
[INFO] [stdout] test memtable::tests::internal_keys_order_by_key_then_descending_sequence ... ok
[INFO] [stdout] test skiplist::tests::an_empty_list_finds_nothing ... ok
[INFO] [stdout] test memtable::tests::iteration_is_in_internal_key_order ... ok
[INFO] [stdout] test skiplist::tests::a_thousand_shuffled_inserts_come_back_sorted ... ok
[INFO] [stdout] test skiplist::tests::iter_from_starts_at_the_probe_position ... ok
[INFO] [stdout] test concurrent::tests::many_mutations_land_through_one_handle ... ok
[INFO] [stdout] test memtable::tests::a_write_after_a_delete_resurrects_the_key ... ok
[INFO] [stdout] test snapshot::tests::the_oldest_live_snapshot_is_the_floor ... ok
[INFO] [stdout] test skiplist::tests::seek_finds_an_exact_key ... ok
[INFO] [stdout] test snapshot::tests::an_empty_registry_pins_nothing ... ok
[INFO] [stdout] test snapshot::tests::snapshots_sharing_a_sequence_number_are_counted_not_deduplicated ... ok
[INFO] [stdout] test snapshot::tests::a_snapshot_reports_the_sequence_it_was_taken_at ... ok
[INFO] [stdout] test skiplist::tests::seek_lands_on_the_first_key_at_or_after_the_probe ... ok
[INFO] [stdout] test memtable::tests::max_seq_tracks_the_highest_sequence_inserted ... ok
[INFO] [stdout] test sstable::bloom_integration_tests::a_written_table_carries_a_bloom_filter ... ok
[INFO] [stdout] test skiplist::tests::dropping_a_populated_list_frees_every_node ... ok
[INFO] [stdout] test skiplist::tests::the_list_grows_past_one_level ... ok
[INFO] [stdout] test sstable::bloom_integration_tests::tombstoned_keys_are_in_the_filter_too ... ok
[INFO] [stdout] test sstable::bloom_integration_tests::the_filter_reports_every_stored_key_as_present ... ok
[INFO] [stdout] test sstable::index_tests::a_lookup_reads_far_less_than_the_whole_table ... ok
[INFO] [stdout] test sstable::bloom_integration_tests::an_empty_table_carries_no_filter ... ok
[INFO] [stdout] test sstable::index_tests::a_small_table_still_gets_exactly_one_block ... ok
[INFO] [stdout] test sstable::index_tests::a_table_larger_than_one_block_gets_several_index_entries ... ok
[INFO] [stdout] test sstable::bloom_integration_tests::the_filter_rejects_most_absent_keys_without_a_data_read ... ok
[INFO] [stdout] test sstable::bloom_integration_tests::the_filter_is_small_relative_to_the_data ... ok
[INFO] [stdout] test sstable::index_tests::the_index_round_trips_through_its_encoding ... ok
[INFO] [stdout] test memtable::tests::range_is_half_open_and_keeps_every_version_of_the_start_key ... ok
[INFO] [stdout] test memtable::tests::put_then_get_round_trips ... ok
[INFO] [stdout] test sstable::index_tests::a_corrupt_or_truncated_index_encoding_is_rejected ... ok
[INFO] [stdout] test sstable::tests::a_file_with_a_bad_magic_is_rejected ... ok
[INFO] [stdout] test sstable::index_tests::the_first_key_of_the_table_matches_the_first_index_entry ... ok
[INFO] [stdout] test sstable::index_tests::block_boundaries_are_searchable ... ok
[INFO] [stdout] test sstable::bloom_integration_tests::a_corrupt_filter_degrades_to_a_scan_rather_than_a_wrong_answer ... ok
[INFO] [stdout] test sstable::index_tests::keys_between_and_outside_blocks_return_none ... ok
[INFO] [stdout] test sstable::tests::an_abandoned_writer_leaves_no_temp_file ... ok
[INFO] [stdout] test sstable::index_tests::index_entries_are_sorted_and_cover_the_data_section_exactly ... ok
[INFO] [stdout] test sstable::index_tests::an_empty_table_has_no_index ... ok
[INFO] [stdout] test sstable::index_tests::tombstones_are_findable_through_the_index ... ok
[INFO] [stdout] test sstable::index_tests::a_corrupt_index_degrades_to_a_scan_rather_than_a_wrong_answer ... ok
[INFO] [stdout] test sstable::tests::a_corrupt_footer_is_caught_by_its_checksum ... ok
[INFO] [stdout] test sstable::index_tests::every_key_is_findable_through_the_index ... ok
[INFO] [stdout] test sstable::tests::a_large_table_reads_back_correctly ... ok
[INFO] [stdout] test sstable::tests::out_of_order_appends_are_rejected ... ok
[INFO] [stdout] test sstable::tests::a_truncated_file_is_rejected_rather_than_misread ... ok
[INFO] [stdout] test sstable::tests::a_written_table_reads_back_every_entry ... ok
[INFO] [stdout] test stats::tests::a_delta_isolates_one_phase_of_a_workload ... ok
[INFO] [stdout] test stats::tests::a_delta_taken_out_of_order_saturates_to_zero ... ok
[INFO] [stdout] test stats::tests::an_empty_store_reports_zero_rather_than_a_nan ... ok
[INFO] [stdout] test stats::tests::counters_accumulate_across_commits_flushes_and_compactions ... ok
[INFO] [stdout] test stats::tests::write_amplification_is_disk_bytes_over_logical_bytes ... ok
[INFO] [stdout] test tests::a_snapshot_is_unaffected_by_later_writes ... ok
[INFO] [stdout] test sstable::tests::absent_keys_return_none ... ok
[INFO] [stdout] test tests::a_snapshot_taken_before_a_delete_still_reads_the_value ... ok
[INFO] [stdout] test tests::an_in_memory_store_writes_no_log_and_never_flushes ... ok
[INFO] [stdout] test tests::basic_put_get_delete_cycle ... ok
[INFO] [stdout] test tests::deleting_an_absent_key_is_a_no_op_for_callers ... ok
[INFO] [stdout] test sstable::bloom_integration_tests::lookups_still_return_correct_answers_with_a_filter_in_place ... ok
[INFO] [stdout] test sstable::tests::may_contain_bounds_the_key_range ... ok
[INFO] [stdout] test sstable::tests::empty_values_are_distinct_from_tombstones ... ok
[INFO] [stdout] test tests::scan_at_a_snapshot_sees_the_state_of_that_moment ... ok
[INFO] [stdout] test sstable::tests::iteration_yields_entries_in_ascending_key_order ... ok
[INFO] [stdout] test sstable::tests::binary_keys_and_values_survive_a_round_trip ... ok
[INFO] [stdout] test tests::sequence_numbers_increase_by_one_per_mutation ... ok
[INFO] [stdout] test sstable::tests::metadata_records_counts_and_key_range ... ok
[INFO] [stdout] test sstable::tests::corrupting_the_data_section_fails_verification ... ok
[INFO] [stdout] test tests::table_filenames_round_trip_through_parsing ... ok
[INFO] [stdout] test tests::table_filenames_sort_lexically_in_recency_order ... ok
[INFO] [stdout] test sstable::tests::the_data_section_checksum_verifies ... ok
[INFO] [stdout] test sstable::tests::the_table_is_only_published_on_finish ... ok
[INFO] [stdout] test sstable::tests::tombstones_round_trip_and_are_distinguishable_from_absence ... ok
[INFO] [stdout] test wal::tests::a_frame_whose_count_disagrees_with_its_payload_is_rejected ... ok
[INFO] [stdout] test wal::tests::an_empty_batch_writes_nothing ... ok
[INFO] [stdout] test wal::tests::an_unknown_kind_byte_stops_replay ... ok
[INFO] [stdout] test wal::tests::a_batch_is_one_frame_and_one_fsync ... ok
[INFO] [stdout] test wal::tests::a_torn_header_is_discarded ... ok
[INFO] [stdout] test wal::tests::a_corrupt_length_field_cannot_cause_a_huge_read ... ok
[INFO] [stdout] test wal::tests::replay_of_a_missing_log_is_empty_not_an_error ... ok
[INFO] [stdout] test wal::tests::a_flipped_bit_is_caught_by_the_checksum ... ok
[INFO] [stdout] test wal::tests::an_empty_value_stays_distinct_from_a_tombstone_across_replay ... ok
[INFO] [stdout] test sstable::tests::an_empty_table_is_valid_and_contains_nothing ... ok
[INFO] [stdout] test wal::tests::binary_payloads_survive_a_round_trip ... ok
[INFO] [stdout] test wal::tests::buffered_policy_still_replays_after_an_explicit_sync ... ok
[INFO] [stdout] test wal::tests::empty_keys_and_values_round_trip ... ok
[INFO] [stdout] test skiplist::tests::readers_see_a_consistent_list_while_a_writer_inserts ... ok
[INFO] [stdout] test wal::tests::size_bytes_tracks_the_file_length ... ok
[INFO] [stdout] test wal::tests::reopening_appends_rather_than_overwrites ... ok
[INFO] [stdout] test wal::tests::replay_leaves_an_appendable_log_after_truncation ... ok
[INFO] [stdout] test wal::tests::appended_records_replay_in_write_order_with_their_sequence_numbers ... ok
[INFO] [stdout] test wal::tests::a_torn_payload_is_discarded_and_earlier_frames_survive ... ok
[INFO] [stdout] test wal::tests::rotate_empties_the_log_but_keeps_it_usable ... ok
[INFO] [stdout] test snapshot::tests::the_registry_survives_a_panicking_holder ... ok
[INFO] [stdout] test skiplist::tests::a_seek_never_returns_a_node_before_its_probe_while_a_writer_inserts ... ok
[INFO] [stderr]      Running unittests src/bin/bench.rs (/opt/rustwide/target/release/deps/bench-c8010a91abcb8a3e)
[INFO] [stdout] test wal::tests::a_batch_torn_anywhere_loses_every_record_in_it ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 148 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.17s
[INFO] [stdout] 
[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 unittests src/main.rs (/opt/rustwide/target/release/deps/minidb-5ef21b7326b90b61)
[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 unittests src/bin/profile.rs (/opt/rustwide/target/release/deps/profile-b5dc8bf7d6ebdfe7)
[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 unittests src/bin/sweep.rs (/opt/rustwide/target/release/deps/sweep-a1eb9fc147daf438)
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/tune.rs (/opt/rustwide/target/release/deps/tune-18e8501a89536386)
[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] [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 unittests src/bin/writeamp.rs (/opt/rustwide/target/release/deps/writeamp-1cdd055bf582dbe8)
[INFO] [stderr]      Running tests/compaction_test.rs (/opt/rustwide/target/release/deps/compaction_test-dc7bb77537c7fdf9)
[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] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test the_planner_never_proposes_a_non_contiguous_run ... ok
[INFO] [stdout] test nothing_is_compacted_below_the_minimum_width ... ok
[INFO] [stdout] test an_interrupted_compaction_with_no_output_rolls_back_on_open ... ok
[INFO] [stdout] test compaction_keeps_the_newest_value_for_a_repeatedly_written_key ... ok
[INFO] [stdout] test a_deleted_key_never_comes_back_after_compaction ... ok
[INFO] [stdout] test an_interrupted_compaction_with_a_published_output_is_completed_on_open ... ok
[INFO] [stdout] test tombstones_are_dropped_when_the_oldest_table_participates ... ok
[INFO] [stdout] test repeated_compaction_converges_and_stops ... ok
[INFO] [stdout] test compaction_merges_tables_and_preserves_every_live_value ... ok
[INFO] [stdout] test compaction_reclaims_space_from_superseded_values ... ok
[INFO] [stdout] test a_merged_table_does_not_shadow_newer_tables_outside_the_merge ... ok
[INFO] [stdout] test tombstones_survive_a_merge_that_excludes_older_tables ... ok
[INFO] [stdout] test a_workload_of_writes_overwrites_and_deletes_stays_correct_through_compaction ... ok
[INFO] [stdout] test auto_compaction_bounds_the_table_count ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.45s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/concurrency_test.rs (/opt/rustwide/target/release/deps/concurrency_test-565f3ed769f154d5)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test the_number_of_handles_is_reported_accurately ... ok
[INFO] [stdout] test many_readers_run_against_a_stable_store ... ok
[INFO] [stdout] test a_panic_in_one_thread_leaves_the_store_usable_for_the_others ... ok
[INFO] [stdout] test a_shared_store_recovers_correctly_after_all_handles_are_dropped ... ok
[INFO] [stdout] test readers_never_observe_a_value_that_was_never_written ... ok
[INFO] [stdout] test concurrent_writers_to_disjoint_keys_all_land ... ok
[INFO] [stdout] test concurrent_writers_to_the_same_key_leave_one_of_their_values ... ok
[INFO] [stdout] test reads_and_writes_interleave_safely_with_flushes_and_compaction ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.29s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/crash_test.rs (/opt/rustwide/target/release/deps/crash_test-20a08ef3ab54f6d3)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test a_crash_partway_through_a_record_never_applies_that_record ... ok
[INFO] [stdout] test every_operation_fails_after_the_crash_fires ... ok
[INFO] [stdout] test crash_runs_are_reproducible_from_their_seed ... ok
[INFO] [stdout] test an_unarmed_fault_plan_changes_nothing ... ok
[INFO] [stdout] test the_store_stays_usable_after_recovering_from_a_crash ... ok
[INFO] [stdout] test acknowledged_writes_survive_crashes_inside_group_commit_batches ... ok
[INFO] [stdout] test a_compaction_crash_under_concurrent_readers_loses_nothing ... ok
[INFO] [stdout] test acknowledged_writes_survive_crashes_mid_compaction ... ok
[INFO] [stdout] test acknowledged_writes_survive_1000_randomized_wal_crashes ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 39.38s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/durability_test.rs (/opt/rustwide/target/release/deps/durability_test-30821779eb1a8057)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test an_in_memory_store_writes_nothing_to_disk ... ok
[INFO] [stdout] test buffered_policy_survives_a_clean_close ... ok
[INFO] [stdout] test opening_a_fresh_directory_yields_an_empty_store ... ok
[INFO] [stdout] test overwrites_replay_in_order_so_the_last_write_wins ... ok
[INFO] [stdout] test writes_survive_reopening_the_store ... ok
[INFO] [stdout] test recovery_repairs_the_log_so_the_store_keeps_working ... ok
[INFO] [stdout] test a_torn_tail_costs_only_the_unacknowledged_write ... ok
[INFO] [stdout] test a_key_rewritten_after_deletion_replays_as_live ... ok
[INFO] [stdout] test the_log_records_exactly_the_mutations_issued ... ok
[INFO] [stdout] test deletes_survive_reopening_and_stay_deleted ... ok
[INFO] [stdout] test corruption_in_the_log_is_caught_by_the_checksum ... ok
[INFO] [stdout] test many_writes_all_survive_recovery ... ok
[INFO] [stderr]      Running tests/durability_tier_test.rs (/opt/rustwide/target/release/deps/durability_tier_test-e22b612b7f0a9683)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.07s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test the_tiers_declare_their_own_loss_windows ... ok
[INFO] [stdout] test the_interval_tier_acknowledges_writes_that_are_not_yet_durable ... ok
[INFO] [stdout] test the_background_syncer_does_not_keep_the_store_alive ... ok
[INFO] [stdout] test an_explicit_sync_closes_the_window_immediately ... ok
[INFO] [stdout] test the_interval_tier_recovers_everything_it_did_sync ... ok
[INFO] [stdout] test the_interval_tier_bounds_the_window_even_when_writes_stop ... ok
[INFO] [stdout] test the_interval_tier_syncs_on_the_way_past_under_sustained_writes ... ok
[INFO] [stdout] test every_write_leaves_nothing_outstanding_ever ... ok
[INFO] [stdout] test a_clean_shutdown_loses_nothing_under_any_tier ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.49s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/group_commit_test.rs (/opt/rustwide/target/release/deps/group_commit_test-efe26ce18e875a95)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test a_batch_advances_the_sequence_counter_once_per_mutation ... ok
[INFO] [stdout] test a_batch_is_applied_in_order_so_later_mutations_win ... ok
[INFO] [stdout] test a_batch_is_one_fsync_regardless_of_how_many_mutations_it_holds ... ok
[INFO] [stdout] test an_empty_batch_is_a_no_op ... ok
[INFO] [stdout] test a_crash_after_a_batchs_fsync_preserves_every_write_in_it ... ok
[INFO] [stdout] test every_writer_in_a_failed_batch_is_told_it_failed ... ok
[INFO] [stdout] test a_batch_survives_a_flush_and_a_reopen ... ok
[INFO] [stdout] test a_single_writer_pays_one_fsync_per_write_and_never_waits_to_gather ... ok
[INFO] [stdout] test a_snapshot_never_sees_part_of_a_batch ... ok
[INFO] [stdout] test concurrent_writers_share_fsyncs_instead_of_each_paying_one ... ok
[INFO] [stdout] test gathering_raises_the_batch_size_under_real_concurrency ... ok
[INFO] [stderr]      Running tests/memtable_test.rs (/opt/rustwide/target/release/deps/memtable_test-9bfa5c53df8ac24d)
[INFO] [stdout] test a_crash_before_a_batchs_fsync_preserves_none_of_it ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.26s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test arbitrary_binary_keys_and_values_round_trip ... ok
[INFO] [stdout] test buffered_size_grows_with_every_version_written ... ok
[INFO] [stdout] test entries_iterate_in_sorted_key_order ... ok
[INFO] [stdout] test last_write_wins_for_a_repeated_key ... ok
[INFO] [stdout] test delete_of_an_absent_key_reports_false ... ok
[INFO] [stdout] test a_key_can_be_rewritten_after_deletion ... ok
[INFO] [stdout] test many_keys_are_all_retrievable ... ok
[INFO] [stdout] test delete_removes_a_key_from_reads ... ok
[INFO] [stdout] test deletes_leave_tombstones_rather_than_erasing_keys ... ok
[INFO] [stdout] test writes_are_visible_to_subsequent_reads ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/mvcc_test.rs (/opt/rustwide/target/release/deps/mvcc_test-56bdfd2f493d99ff)
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test many_snapshots_at_different_points_each_read_their_own_past ... ok
[INFO] [stdout] test a_snapshot_sees_none_of_the_writes_that_land_after_it ... ok
[INFO] [stdout] test sequence_numbers_survive_a_reopen_that_replays_the_log ... ok
[INFO] [stdout] test an_empty_value_is_not_a_tombstone_at_any_snapshot ... ok
[INFO] [stdout] test a_deleted_key_is_still_readable_at_a_snapshot_taken_before_the_delete ... ok
[INFO] [stdout] test a_snapshot_survives_the_memtable_being_flushed_to_disk ... ok
[INFO] [stdout] test a_tombstone_stops_the_search_rather_than_falling_through_to_an_older_table ... ok
[INFO] [stdout] test a_snapshot_survives_versions_being_split_across_two_tables ... ok
[INFO] [stdout] test every_version_reaches_disk_in_internal_key_order ... ok
[INFO] [stdout] test sequence_numbers_continue_from_where_a_reopen_found_them ... ok
[INFO] [stdout] test an_open_snapshot_stops_compaction_from_collecting_what_it_reads ... ok
[INFO] [stdout] test compaction_collects_old_versions_once_no_snapshot_holds_them ... ok
[INFO] [stdout] test dropping_a_snapshot_lets_compaction_reclaim_again ... ok
[INFO] [stdout] test a_mixed_workload_is_correct_at_both_a_snapshot_and_the_present ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.94s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/nonblocking_test.rs (/opt/rustwide/target/release/deps/nonblocking_test-ff098d4e92a1f389)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test reads_keep_completing_across_flushes_and_compactions ... ok
[INFO] [stdout] test a_reader_never_observes_a_value_that_was_never_written ... ok
[INFO] [stdout] test full_scans_keep_completing_while_a_writer_hammers_the_store ... ok
[INFO] [stdout] test a_snapshot_stays_readable_and_stable_through_flushes_and_compactions ... ok
[INFO] [stdout] test point_reads_keep_completing_while_a_writer_hammers_the_store ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 10.11s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/range_test.rs (/opt/rustwide/target/release/deps/range_test-cbf1a44dcdfb7cd0)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test a_range_over_binary_keys_orders_them_bytewise ... ok
[INFO] [stdout] test a_range_is_half_open_and_ascending ... ok
[INFO] [stdout] test len_counts_without_materializing ... ok
[INFO] [stdout] test a_range_at_a_snapshot_sees_that_moment_and_nothing_after ... ok
[INFO] [stdout] test a_range_skips_tombstones_across_levels ... ok
[INFO] [stdout] test a_range_survives_a_reopen_and_still_merges_correctly ... ok
[INFO] [stdout] test a_range_merges_the_memtable_and_every_sstable_in_recency_order ... ok
[INFO] [stdout] test a_range_agrees_with_point_lookups_over_a_mixed_workload ... ok
[INFO] [stdout] test a_range_yields_only_the_newest_visible_version_of_each_key ... ok
[INFO] [stdout] test a_range_does_not_materialize_the_dataset_before_yielding ... ok
[INFO] [stdout] test a_bounded_range_reads_far_less_of_the_store_than_a_full_scan ... ok
[INFO] [stderr]      Running tests/sstable_test.rs (/opt/rustwide/target/release/deps/sstable_test-451003ee3118e548)
[INFO] [stdout] test a_range_keeps_working_while_the_store_flushes_and_compacts_underneath_it ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.83s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 17 tests
[INFO] [stdout] test flushing_an_empty_memtable_is_a_no_op ... ok
[INFO] [stdout] test a_table_written_directly_can_be_read_back ... ok
[INFO] [stdout] test a_stale_temp_file_is_cleaned_up_on_open ... ok
[INFO] [stdout] test the_wal_is_rotated_once_its_data_is_safely_in_a_table ... ok
[INFO] [stdout] test data_written_before_a_flush_survives_a_simulated_crash_after_it ... ok
[INFO] [stdout] test flushed_tables_carry_usable_metadata ... ok
[INFO] [stdout] test an_explicit_flush_writes_a_table_and_empties_the_memtable ... ok
[INFO] [stdout] test the_memtable_shadows_every_table_beneath_it ... ok
[INFO] [stdout] test sequence_numbers_continue_after_a_reopen ... ok
[INFO] [stdout] test a_newer_table_shadows_an_older_one ... ok
[INFO] [stdout] test scan_returns_the_merged_live_view ... ok
[INFO] [stdout] test a_tombstone_in_a_newer_table_hides_a_value_in_an_older_one ... ok
[INFO] [stdout] test tables_are_rediscovered_when_the_store_is_reopened ... ok
[INFO] [stdout] test a_delete_then_rewrite_across_flushes_resolves_to_the_newest_value ... ok
[INFO] [stdout] test table_shadowing_order_survives_a_reopen ... ok
[INFO] [stdout] test writes_past_the_threshold_flush_automatically ... ok
[INFO] [stderr]      Running tests/writeamp_test.rs (/opt/rustwide/target/release/deps/writeamp_test-a5c455be0793edb1)
[INFO] [stdout] test a_bulk_workload_stays_consistent_across_many_flushes ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.19s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test a_batch_counts_every_mutation_but_only_one_commit ... ok
[INFO] [stdout] test an_in_memory_store_writes_no_disk_bytes_at_all ... ok
[INFO] [stdout] test logical_bytes_are_exactly_the_keys_and_values_handed_over ... ok
[INFO] [stdout] test logged_bytes_exceed_logical_bytes_by_the_framing_overhead ... ok
[INFO] [stdout] test counters_survive_a_reopen_by_resetting_rather_than_lying ... ok
[INFO] [stdout] test flush_bytes_match_the_tables_actually_written ... ok
[INFO] [stdout] test stats_deltas_isolate_one_phase_of_a_workload ... ok
[INFO] [stdout] test compaction_bytes_match_the_merged_table_actually_written ... ok
[INFO] [stdout] test a_write_once_workload_amplifies_more_than_an_overwrite_heavy_one ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.10s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests minidb
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test src/lib.rs - WriteBatch (line 224) ... ok
[INFO] [stdout] test src/lib.rs - (line 89) ... ok
[INFO] [stdout] test src/lib.rs - Db::range (line 1324) ... ok
[INFO] [stdout] test src/lib.rs - (line 75) ... ok
[INFO] [stdout] test src/concurrent.rs - concurrent (line 34) ... ok
[INFO] [stdout] test src/lib.rs - (line 105) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.62s; merged doctests compilation took 0.59s
[INFO] running `Command { std: "docker" "inspect" "9ab9753d8005c863193bc2fe343664328a73b232d3a4c3f0f0c06bafbe134ee8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9ab9753d8005c863193bc2fe343664328a73b232d3a4c3f0f0c06bafbe134ee8", kill_on_drop: false }`
[INFO] [stdout] 9ab9753d8005c863193bc2fe343664328a73b232d3a4c3f0f0c06bafbe134ee8
