[INFO] cloning repository https://github.com/hchihoub/grainstore
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/hchihoub/grainstore" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhchihoub%2Fgrainstore", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhchihoub%2Fgrainstore'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] fe08276b0a704d32a61b80db7af8f65203b5ca9a
[INFO] testing hchihoub/grainstore against 1.98.0-beta.1 for beta-1.98-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhchihoub%2Fgrainstore" "/workspace/builds/worker-4-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/hchihoub/grainstore
[INFO] finished tweaking git repo https://github.com/hchihoub/grainstore
[INFO] tweaked toml for git repo https://github.com/hchihoub/grainstore written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/hchihoub/grainstore on toolchain 1.98.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/hchihoub/grainstore 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.98.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-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:3d5ced03c013a94a2f102a4510f48a6e9184255caf5fd8244f58017bde7f5210" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 88b35773f0a4c7fbc0cb05f4a0d290d1ccdcaf9653c131cb0249b9faa980bf89
[INFO] running `Command { std: "docker" "start" "88b35773f0a4c7fbc0cb05f4a0d290d1ccdcaf9653c131cb0249b9faa980bf89", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "88b35773f0a4c7fbc0cb05f4a0d290d1ccdcaf9653c131cb0249b9faa980bf89", 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" "88b35773f0a4c7fbc0cb05f4a0d290d1ccdcaf9653c131cb0249b9faa980bf89" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "88b35773f0a4c7fbc0cb05f4a0d290d1ccdcaf9653c131cb0249b9faa980bf89", 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" "88b35773f0a4c7fbc0cb05f4a0d290d1ccdcaf9653c131cb0249b9faa980bf89" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling grainstore v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2.60s
[INFO] running `Command { std: "docker" "inspect" "88b35773f0a4c7fbc0cb05f4a0d290d1ccdcaf9653c131cb0249b9faa980bf89", 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" "88b35773f0a4c7fbc0cb05f4a0d290d1ccdcaf9653c131cb0249b9faa980bf89" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling grainstore v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [optimized + debuginfo] target(s) in 45.86s
[INFO] running `Command { std: "docker" "inspect" "88b35773f0a4c7fbc0cb05f4a0d290d1ccdcaf9653c131cb0249b9faa980bf89", 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" "88b35773f0a4c7fbc0cb05f4a0d290d1ccdcaf9653c131cb0249b9faa980bf89" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [optimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/grainstore-62fc3cbce7386964)
[INFO] [stdout] 
[INFO] [stdout] running 17 tests
[INFO] [stdout] test block::tests::bloom_has_no_false_negatives ... ok
[INFO] [stdout] test governance::tests::default_deny_and_precedence ... ok
[INFO] [stdout] test block::tests::near_is_exact_vs_brute_force ... ok
[INFO] [stdout] test hlc::tests::monotonic_single_threaded ... ok
[INFO] [stdout] test keys::tests::key_roundtrips_t_tx ... ok
[INFO] [stdout] test embed::tests::roundtrip_with_header ... ok
[INFO] [stdout] test keys::tests::newer_versions_sort_before_older ... ok
[INFO] [stdout] test kv::tests::seek_ge_finds_first_at_or_after ... ok
[INFO] [stdout] test planner::tests::higher_target_costs_more ... ok
[INFO] [stdout] test planner::tests::over_fetch_scales_inversely_with_selectivity ... ok
[INFO] [stdout] test catalog::tests::ratios_reflect_observations ... ok
[INFO] [stdout] test wal::tests::frame_roundtrips ... ok
[INFO] [stdout] test block::tests::get_and_category_prune ... ok
[INFO] [stdout] test wal::tests::crc_detects_corruption ... ok
[INFO] [stdout] test wal::tests::torn_tail_is_rejected ... ok
[INFO] [stdout] test hlc::tests::resume_does_not_regress ... ok
[INFO] [stdout] test vector::sharded::tests::sharded_routes_and_counts ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/concurrency.rs (/opt/rustwide/target/debug/deps/concurrency-29f4bb17c993ac3d)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test hlc_is_unique_under_threads ... ok
[INFO] [stdout] test concurrent_writers_preserve_invariants ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.59s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/disclosure.rs (/opt/rustwide/target/debug/deps/disclosure-a8fa92e065fb3650)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/engine.rs (/opt/rustwide/target/debug/deps/engine-83b06a34a065842a)
[INFO] [stdout] test staged_disclosure_summary_then_drill ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.04s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test custom_index_swaps_in_via_open_with ... ok
[INFO] [stdout] test default_engine_works_out_of_the_box ... ok
[INFO] [stderr]      Running tests/governance.rs (/opt/rustwide/target/debug/deps/governance-470e02bcbaa0315c)
[INFO] [stdout] test parallel_pipeline_sharded_pool ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.77s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test governance_is_enforced_inline ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/mvcc_props.rs (/opt/rustwide/target/debug/deps/mvcc_props-c0b2845a34c219f3)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test mvcc_reads_match_model ... ok
[INFO] [stderr]      Running tests/p1_pipeline.rs (/opt/rustwide/target/debug/deps/p1_pipeline-ce95056d931caf58)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 8.53s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test tombstone_removes_from_index ... ok
[INFO] [stdout] test mixed_filtered_query_matches_exact_oracle ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.06s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/planner.rs (/opt/rustwide/target/debug/deps/planner-3d2f307208edd2dc)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/recovery_props.rs (/opt/rustwide/target/debug/deps/recovery_props-9f5b842b1f708d1f)
[INFO] [stdout] test planner_hits_target_recall_across_selectivities ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.67s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/vector_recall.rs (/opt/rustwide/target/debug/deps/vector_recall-e94f0ed10593ed1c)
[INFO] [stdout] test recover_is_consistent_after_crash ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.91s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test brute_force_is_exact ... ok
[INFO] [stdout] test hnsw_handles_deletes ... ok
[INFO] [stdout] test hnsw_recall_matches_brute_force ... ok
[INFO] [stderr]    Doc-tests grainstore
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.21s
[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] running `Command { std: "docker" "inspect" "88b35773f0a4c7fbc0cb05f4a0d290d1ccdcaf9653c131cb0249b9faa980bf89", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "88b35773f0a4c7fbc0cb05f4a0d290d1ccdcaf9653c131cb0249b9faa980bf89", kill_on_drop: false }`
[INFO] [stdout] 88b35773f0a4c7fbc0cb05f4a0d290d1ccdcaf9653c131cb0249b9faa980bf89
