[INFO] fetching crate bitbelay-tests 0.1.0...
[INFO] testing bitbelay-tests-0.1.0 against try#a7ee93192a766fb0dafa23def7154fc03cfcfc3e for pr-146989
[INFO] extracting crate bitbelay-tests 0.1.0 into /workspace/builds/worker-3-tc2/source
[INFO] started tweaking crates.io crate bitbelay-tests 0.1.0
[INFO] finished tweaking crates.io crate bitbelay-tests 0.1.0
[INFO] tweaked toml for crates.io crate bitbelay-tests 0.1.0 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate bitbelay-tests 0.1.0 on toolchain a7ee93192a766fb0dafa23def7154fc03cfcfc3e
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]      Locking 145 packages to latest compatible versions
[INFO] [stderr]       Adding colored v2.2.0 (available: v3.1.1)
[INFO] [stderr]       Adding ordered-float v4.6.0 (available: v5.1.0)
[INFO] [stderr]       Adding rand v0.8.5 (available: v0.9.2)
[INFO] [stderr]       Adding statrs v0.16.1 (available: v0.18.0)
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 39b21726b60700ec3fcbd526a17e4edfe10fcd498d7d846d546d079328dd01b7
[INFO] running `Command { std: "docker" "start" "-a" "39b21726b60700ec3fcbd526a17e4edfe10fcd498d7d846d546d079328dd01b7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "39b21726b60700ec3fcbd526a17e4edfe10fcd498d7d846d546d079328dd01b7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "39b21726b60700ec3fcbd526a17e4edfe10fcd498d7d846d546d079328dd01b7", kill_on_drop: false }`
[INFO] [stdout] 39b21726b60700ec3fcbd526a17e4edfe10fcd498d7d846d546d079328dd01b7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 06c158543b94307d7d13d3cb5ddc48145b82c3be6dc7b85348588a06a64c51d1
[INFO] running `Command { std: "docker" "start" "-a" "06c158543b94307d7d13d3cb5ddc48145b82c3be6dc7b85348588a06a64c51d1", kill_on_drop: false }`
[INFO] [stderr]    Compiling libm v0.2.16
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling libc v0.2.180
[INFO] [stderr]    Compiling zerocopy v0.8.34
[INFO] [stderr]    Compiling bytemuck v1.24.0
[INFO] [stderr]    Compiling paste v1.0.15
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling matrixmultiply v0.3.10
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling rawpointer v0.2.1
[INFO] [stderr]    Compiling anstyle v1.0.13
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling clap_lex v0.7.7
[INFO] [stderr]    Compiling radium v0.7.0
[INFO] [stderr]    Compiling rust_decimal v1.40.0
[INFO] [stderr]    Compiling heck v0.5.0
[INFO] [stderr]    Compiling safe_arch v0.7.4
[INFO] [stderr]    Compiling iana-time-zone v0.1.64
[INFO] [stderr]    Compiling tap v1.0.1
[INFO] [stderr]    Compiling anstream v0.6.21
[INFO] [stderr]    Compiling unicode-width v0.2.2
[INFO] [stderr]    Compiling unicode-linebreak v0.1.5
[INFO] [stderr]    Compiling arrayvec v0.7.6
[INFO] [stderr]    Compiling smawk v0.3.2
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling wide v0.7.33
[INFO] [stderr]    Compiling wyz v0.5.1
[INFO] [stderr]    Compiling colored v2.2.0
[INFO] [stderr]    Compiling nonempty v0.9.0
[INFO] [stderr]    Compiling textwrap v0.16.2
[INFO] [stderr]    Compiling funty v2.0.0
[INFO] [stderr]    Compiling utf8-width v0.1.8
[INFO] [stderr]    Compiling clap_builder v4.5.54
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling bitvec v1.0.1
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling approx v0.5.1
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling ordered-float v4.6.0
[INFO] [stderr]    Compiling num-rational v0.4.2
[INFO] [stderr]    Compiling byte-unit v5.2.0
[INFO] [stderr]    Compiling simba v0.6.0
[INFO] [stderr]    Compiling bitbelay-report v0.1.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling nalgebra-macros v0.1.0
[INFO] [stderr]    Compiling rand_distr v0.4.3
[INFO] [stderr]    Compiling clap_derive v4.5.49
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling nalgebra v0.29.0
[INFO] [stderr]    Compiling clap v4.5.54
[INFO] [stderr]    Compiling bitbelay-providers v0.1.0
[INFO] [stderr]    Compiling statrs v0.16.1
[INFO] [stderr]    Compiling bitbelay-statistics v0.1.0
[INFO] [stderr]    Compiling bitbelay-tests v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 35.41s
[INFO] running `Command { std: "docker" "inspect" "06c158543b94307d7d13d3cb5ddc48145b82c3be6dc7b85348588a06a64c51d1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "06c158543b94307d7d13d3cb5ddc48145b82c3be6dc7b85348588a06a64c51d1", kill_on_drop: false }`
[INFO] [stdout] 06c158543b94307d7d13d3cb5ddc48145b82c3be6dc7b85348588a06a64c51d1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 4f1fac69839a2df2aa5cb6007408a8c7b05c62534c26b54572a33330cff3389d
[INFO] running `Command { std: "docker" "start" "-a" "4f1fac69839a2df2aa5cb6007408a8c7b05c62534c26b54572a33330cff3389d", kill_on_drop: false }`
[INFO] [stderr]    Compiling bitbelay-tests v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.08s
[INFO] running `Command { std: "docker" "inspect" "4f1fac69839a2df2aa5cb6007408a8c7b05c62534c26b54572a33330cff3389d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4f1fac69839a2df2aa5cb6007408a8c7b05c62534c26b54572a33330cff3389d", kill_on_drop: false }`
[INFO] [stdout] 4f1fac69839a2df2aa5cb6007408a8c7b05c62534c26b54572a33330cff3389d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 19728a08cde04cb6caea578c67fa760d5cfb25bb323448b5a9511980b125b291
[INFO] running `Command { std: "docker" "start" "-a" "19728a08cde04cb6caea578c67fa760d5cfb25bb323448b5a9511980b125b291", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.13s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bitbelay_tests-417aba2625e04c1e)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test correlation::bitwise::tests::it_extracts_bit_values_from_hashes_correctly ... ok
[INFO] [stdout] test avalanche::sac::experiment::tests::flipping_random_bits ... ok
[INFO] [stderr]    Doc-tests bitbelay_tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 45 tests
[INFO] [stdout] test src/avalanche/sac.rs - avalanche::sac::Test<'a,H,N>::run_single_experiment (line 310) ... ok
[INFO] [stdout] test src/avalanche/sac.rs - avalanche::sac::Test<'a,H,N>::total_experiments (line 257) ... ok
[INFO] [stdout] test src/avalanche/sac.rs - avalanche::sac::Test<'a,H,N>::try_new (line 106) ... ok
[INFO] [stdout] test src/avalanche.rs - avalanche::Test<'a,H,N>::as_strict_avalanche_criterion_test (line 25) ... ok
[INFO] [stdout] test src/avalanche/sac.rs - avalanche::sac::Test<'a,H,N>::build_hasher (line 149) ... ok
[INFO] [stdout] test src/avalanche/sac.rs - avalanche::sac::Test<'a,H,N>::iterations_per_experiment (line 231) ... ok
[INFO] [stdout] test src/avalanche/sac.rs - avalanche::sac::Test<'a,H,N>::max_deviance (line 284) ... ok
[INFO] [stdout] test src/avalanche/sac.rs - avalanche::sac::Test<'a,H,N>::provider (line 177) ... ok
[INFO] [stdout] test src/avalanche/sac/experiment.rs - avalanche::sac::experiment::Experiment<'a,H,N>::build_hasher (line 84) ... ok
[INFO] [stdout] test src/avalanche.rs - avalanche::Test<'a,H,N>::into_strict_avalanche_criterion_test (line 60) ... ok
[INFO] [stdout] test src/chi_squared.rs - chi_squared::Test<'a,H>::as_goodness_of_fit_test (line 24) ... ok
[INFO] [stdout] test src/chi_squared.rs - chi_squared::Test<'a,H>::into_goodness_of_fit_test (line 58) ... ok
[INFO] [stdout] test src/chi_squared/goodness_of_fit.rs - chi_squared::goodness_of_fit::Test<'a,H>::threshold (line 155) ... ok
[INFO] [stdout] test src/chi_squared/goodness_of_fit.rs - chi_squared::goodness_of_fit::Test<'a,H>::build_hasher (line 75) ... ok
[INFO] [stdout] test src/avalanche/sac.rs - avalanche::sac::Test<'a,H,N>::bit_flips (line 205) ... ok
[INFO] [stdout] test src/chi_squared.rs - chi_squared::Test<'a,H>::report_section (line 90) ... ok
[INFO] [stdout] test src/chi_squared/goodness_of_fit.rs - chi_squared::goodness_of_fit::Test<'a,H>::buckets (line 129) ... ok
[INFO] [stdout] test src/avalanche/sac/experiment.rs - avalanche::sac::experiment::Experiment<'a,H,N>::try_new (line 53) ... ok
[INFO] [stdout] test src/chi_squared/goodness_of_fit.rs - chi_squared::goodness_of_fit::Test<'a,H>::p_value (line 213) ... ok
[INFO] [stdout] test src/chi_squared/goodness_of_fit.rs - chi_squared::goodness_of_fit::Test<'a,H>::provider (line 102) ... ok
[INFO] [stdout] test src/chi_squared/goodness_of_fit.rs - chi_squared::goodness_of_fit::Test<'a,H>::new (line 35) ... ok
[INFO] [stdout] test src/avalanche/sac/experiment.rs - avalanche::sac::experiment::Experiment<'a,H,N>::data (line 109) ... ok
[INFO] [stdout] test src/avalanche.rs - avalanche::Test<'a,H,N>::report_section (line 96) ... ok
[INFO] [stdout] test src/correlation.rs - correlation::Test<'a,H,N>::into_bitwise_test (line 51) ... ok
[INFO] [stdout] test src/correlation.rs - correlation::Test<'a,H,N>::as_bitwise_test (line 25) ... ok
[INFO] [stdout] test src/chi_squared/goodness_of_fit.rs - chi_squared::goodness_of_fit::Test<'a,H>::single_iteration (line 181) ... ok
[INFO] [stdout] test src/avalanche/sac/experiment.rs - avalanche::sac::experiment::Experiment<'a,H,N>::run (line 142) ... ok
[INFO] [stdout] test src/correlation/bitwise.rs - correlation::bitwise::Test<'a,H,N>::threshold (line 84) ... ok
[INFO] [stdout] test src/correlation.rs - correlation::Test<'a,H,N>::report_section (line 75) ... ok
[INFO] [stdout] test src/correlation/bitwise.rs - correlation::bitwise::Test<'a,H,N>::new (line 40) ... ok
[INFO] [stdout] test src/performance/speed.rs - performance::speed::Test<'a,H>::build_hasher (line 90) ... ok
[INFO] [stdout] test src/performance.rs - performance::Test<'a,H>::as_speed_test (line 24) ... ok
[INFO] [stdout] test src/correlation/bitwise.rs - correlation::bitwise::Test<'a,H,N>::bit_values (line 60) ... ok
[INFO] [stdout] test src/correlation/bitwise.rs - correlation::bitwise::Test<'a,H,N>::run (line 102) ... ok
[INFO] [stdout] test src/performance/speed.rs - performance::speed::Test<'a,H>::desired_data_size (line 152) ... ok
[INFO] [stdout] test src/performance/speed.rs - performance::speed::Test<'a,H>::data (line 116) ... ok
[INFO] [stdout] test src/correlation/bitwise.rs - correlation::bitwise::Test<'a,H,N>::results (line 139) ... ok
[INFO] [stdout] test src/performance/speed.rs - performance::speed::Test<'a,H>::new (line 48) ... ok
[INFO] [stdout] test src/avalanche/sac.rs - avalanche::sac::Test<'a,H,N>::results (line 352) ... ok
[INFO] [stdout] test src/performance/speed.rs - performance::speed::Test<'a,H>::run (line 295) ... ok
[INFO] [stdout] test src/performance.rs - performance::Test<'a,H>::into_speed_test (line 59) ... ok
[INFO] [stdout] test src/performance/speed.rs - performance::speed::Test<'a,H>::provider (line 180) ... ok
[INFO] [stdout] test src/performance/speed.rs - performance::speed::Test<'a,H>::results (line 208) ... ok
[INFO] [stdout] test src/performance/speed.rs - performance::speed::Test<'a,H>::threshold (line 238) ... ok
[INFO] [stdout] test src/performance.rs - performance::Test<'a,H>::report_section (line 92) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 45 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.87s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "19728a08cde04cb6caea578c67fa760d5cfb25bb323448b5a9511980b125b291", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "19728a08cde04cb6caea578c67fa760d5cfb25bb323448b5a9511980b125b291", kill_on_drop: false }`
[INFO] [stdout] 19728a08cde04cb6caea578c67fa760d5cfb25bb323448b5a9511980b125b291