[INFO] cloning repository https://github.com/ModernRelay/lance-autoresearch
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/ModernRelay/lance-autoresearch" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FModernRelay%2Flance-autoresearch", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FModernRelay%2Flance-autoresearch'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] fe0b4842a466107cb7dc36af264fe8a36927502b
[INFO] testing ModernRelay/lance-autoresearch against 1.98.0-beta.1 for beta-1.98-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FModernRelay%2Flance-autoresearch" "/workspace/builds/worker-2-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc2/source'...
[INFO] [stderr] done.
[INFO] removed /workspace/builds/worker-2-tc2/source/rust-toolchain.toml
[INFO] started tweaking git repo https://github.com/ModernRelay/lance-autoresearch
[INFO] finished tweaking git repo https://github.com/ModernRelay/lance-autoresearch
[INFO] tweaked toml for git repo https://github.com/ModernRelay/lance-autoresearch written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/ModernRelay/lance-autoresearch 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/ModernRelay/lance-autoresearch 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-2-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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] 539c98612fc028707b3738f9fa0f85db533178b184451986641856a6be65cc7c
[INFO] running `Command { std: "docker" "start" "539c98612fc028707b3738f9fa0f85db533178b184451986641856a6be65cc7c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "539c98612fc028707b3738f9fa0f85db533178b184451986641856a6be65cc7c", 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" "539c98612fc028707b3738f9fa0f85db533178b184451986641856a6be65cc7c" "/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" "539c98612fc028707b3738f9fa0f85db533178b184451986641856a6be65cc7c", 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" "539c98612fc028707b3738f9fa0f85db533178b184451986641856a6be65cc7c" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] warning: output filename collision at /opt/rustwide/target/debug/run_experiment
[INFO] [stderr]   |
[INFO] [stderr]   = note: the bin target `run_experiment` in package `posting-seek v0.1.0 (/opt/rustwide/workdir/crates/posting-seek)` has the same output filename as the bin target `run_experiment` in package `posting-intersect v0.1.0 (/opt/rustwide/workdir/crates/posting-intersect)`
[INFO] [stderr]   = note: this may become a hard error in the future; see <https://github.com/rust-lang/cargo/issues/6313>
[INFO] [stderr]   = help: consider changing their names to be unique or compiling them separately
[INFO] [stderr] warning: output filename collision at /opt/rustwide/target/debug/run_experiment.dwp
[INFO] [stderr]   |
[INFO] [stderr]   = note: the bin target `run_experiment` in package `posting-seek v0.1.0 (/opt/rustwide/workdir/crates/posting-seek)` has the same output filename as the bin target `run_experiment` in package `posting-intersect v0.1.0 (/opt/rustwide/workdir/crates/posting-intersect)`
[INFO] [stderr]   = note: this may become a hard error in the future; see <https://github.com/rust-lang/cargo/issues/6313>
[INFO] [stderr]   = help: consider changing their names to be unique or compiling them separately
[INFO] [stderr] warning: output filename collision at /opt/rustwide/target/debug/run_experiment
[INFO] [stderr]   |
[INFO] [stderr]   = note: the bin target `run_experiment` in package `pq-l2 v0.1.0 (/opt/rustwide/workdir/crates/pq-l2)` has the same output filename as the bin target `run_experiment` in package `posting-seek v0.1.0 (/opt/rustwide/workdir/crates/posting-seek)`
[INFO] [stderr]   = note: this may become a hard error in the future; see <https://github.com/rust-lang/cargo/issues/6313>
[INFO] [stderr]   = help: consider changing their names to be unique or compiling them separately
[INFO] [stderr] warning: output filename collision at /opt/rustwide/target/debug/run_experiment.dwp
[INFO] [stderr]   |
[INFO] [stderr]   = note: the bin target `run_experiment` in package `pq-l2 v0.1.0 (/opt/rustwide/workdir/crates/pq-l2)` has the same output filename as the bin target `run_experiment` in package `posting-seek v0.1.0 (/opt/rustwide/workdir/crates/posting-seek)`
[INFO] [stderr]   = note: this may become a hard error in the future; see <https://github.com/rust-lang/cargo/issues/6313>
[INFO] [stderr]   = help: consider changing their names to be unique or compiling them separately
[INFO] [stderr]    Compiling lance-snapshots v0.1.0 (/opt/rustwide/workdir/crates/lance-snapshots)
[INFO] [stderr]    Compiling perf-event-open-sys v6.0.0
[INFO] [stderr]    Compiling perf-event v0.4.9
[INFO] [stderr]    Compiling harness-common v0.1.0 (/opt/rustwide/workdir/crates/harness-common)
[INFO] [stderr]    Compiling posting-seek v0.1.0 (/opt/rustwide/workdir/crates/posting-seek)
[INFO] [stderr]    Compiling pq-l2 v0.1.0 (/opt/rustwide/workdir/crates/pq-l2)
[INFO] [stderr]    Compiling posting-intersect v0.1.0 (/opt/rustwide/workdir/crates/posting-intersect)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.84s
[INFO] running `Command { std: "docker" "inspect" "539c98612fc028707b3738f9fa0f85db533178b184451986641856a6be65cc7c", 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" "539c98612fc028707b3738f9fa0f85db533178b184451986641856a6be65cc7c" "/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 zerocopy v0.8.48
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling either v1.16.0
[INFO] [stderr]    Compiling ciborium-io v0.2.2
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling plotters-backend v0.3.7
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling cast v0.3.0
[INFO] [stderr]    Compiling is-terminal v0.4.17
[INFO] [stderr]    Compiling anes v0.1.6
[INFO] [stderr]    Compiling serde_json v1.0.150
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling oorandom v11.1.5
[INFO] [stderr]    Compiling harness-common v0.1.0 (/opt/rustwide/workdir/crates/harness-common)
[INFO] [stderr]    Compiling posting-intersect v0.1.0 (/opt/rustwide/workdir/crates/posting-intersect)
[INFO] [stderr]    Compiling posting-seek v0.1.0 (/opt/rustwide/workdir/crates/posting-seek)
[INFO] [stderr]    Compiling lance-snapshots v0.1.0 (/opt/rustwide/workdir/crates/lance-snapshots)
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling plotters-svg v0.3.7
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling criterion-plot v0.5.0
[INFO] [stderr]    Compiling clap v4.6.1
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling zerocopy-derive v0.8.48
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling criterion v0.5.1
[INFO] [stderr]    Compiling pq-l2 v0.1.0 (/opt/rustwide/workdir/crates/pq-l2)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 8.34s
[INFO] running `Command { std: "docker" "inspect" "539c98612fc028707b3738f9fa0f85db533178b184451986641856a6be65cc7c", 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" "539c98612fc028707b3738f9fa0f85db533178b184451986641856a6be65cc7c" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/harness_common-055911c4d2acea8f)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test perf::tests::double_stop_returns_zero ... ok
[INFO] [stdout] test perf::tests::linux_attempts_pmc ... ok
[INFO] [stdout] test prng::tests::deterministic_across_calls ... ok
[INFO] [stdout] test stats::tests::empty_yields_zero ... ok
[INFO] [stdout] test perf::tests::wall_clock_always_populated ... ok
[INFO] [stdout] test stats::tests::geomean_is_below_arithmetic_mean ... ok
[INFO] [stdout] test stats::tests::iqr_basic ... ok
[INFO] [stdout] test stats::tests::median_odd_and_even ... ok
[INFO] [stdout] test stats::tests::single_value_round_trips ... ok
[INFO] [stdout] test stats::tests::statistically_faster_when_non_overlapping ... ok
[INFO] [stdout] test stats::tests::bootstrap_ci_brackets_true_geomean ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/lance_snapshots-8e3e2fa22b8e1b72)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test pq::tests::transpose_round_trip_is_inverse ... ok
[INFO] [stdout] test pq::tests::compute_pq_distance_matches_naive ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/posting_intersect-a5f5a0582d68a3d6)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test inputs::tests::lists_are_sorted_unique ... ok
[INFO] [stdout] test inputs::tests::correctness_battery_is_deterministic ... ok
[INFO] [stdout] test inputs::tests::speed_workloads_match_shapes ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 20.20s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/run_experiment.rs (/opt/rustwide/target/debug/deps/run_experiment-671249597afd3548)
[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/lib.rs (/opt/rustwide/target/debug/deps/posting_seek-09b84fd1815a640e)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test inputs::tests::posting_list_invariants ... ok
[INFO] [stdout] test inputs::tests::speed_workloads_match_shapes ... ok
[INFO] [stdout] test inputs::tests::correctness_battery_is_deterministic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.64s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/run_experiment.rs (/opt/rustwide/target/debug/deps/run_experiment-afb8b0e73b281f15)
[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/lib.rs (/opt/rustwide/target/debug/deps/pq_l2-87ec897dce0f87df)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test inputs::tests::correctness_battery_is_deterministic has been running for over 60 seconds
[INFO] [stdout] test inputs::tests::speed_workloads_match_shapes has been running for over 60 seconds
[INFO] [stdout] test inputs::tests::speed_workloads_match_shapes ... ok
[INFO] [stdout] test inputs::tests::correctness_battery_is_deterministic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 533.76s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/run_experiment.rs (/opt/rustwide/target/debug/deps/run_experiment-83ce8b940d9fecf7)
[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]    Doc-tests harness_common
[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]    Doc-tests lance_snapshots
[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]    Doc-tests posting_intersect
[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]    Doc-tests posting_seek
[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]    Doc-tests pq_l2
[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" "539c98612fc028707b3738f9fa0f85db533178b184451986641856a6be65cc7c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "539c98612fc028707b3738f9fa0f85db533178b184451986641856a6be65cc7c", kill_on_drop: false }`
[INFO] [stdout] 539c98612fc028707b3738f9fa0f85db533178b184451986641856a6be65cc7c
