[INFO] fetching crate criterion 0.8.2... [INFO] testing criterion-0.8.2 against master#c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af for pr-154756 [INFO] extracting crate criterion 0.8.2 into /workspace/builds/worker-2-tc1/source [INFO] started tweaking crates.io crate criterion 0.8.2 [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate criterion 0.8.2 [INFO] tweaked toml for crates.io crate criterion 0.8.2 written to /workspace/builds/worker-2-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate criterion 0.8.2 on toolchain c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate criterion 0.8.2 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" "+c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded unicode-ident v1.0.20 [INFO] [stderr] Downloaded tinytemplate v1.2.1 [INFO] [stderr] Downloaded cast v0.3.0 [INFO] [stderr] Downloaded serde_json v1.0.145 [INFO] [stderr] Downloaded alloca v0.4.0 [INFO] [stderr] Downloaded ciborium-io v0.2.2 [INFO] [stderr] Downloaded crunchy v0.2.4 [INFO] [stderr] Downloaded ciborium-ll v0.2.2 [INFO] [stderr] Downloaded clap_lex v0.7.6 [INFO] [stderr] Downloaded page_size v0.6.0 [INFO] [stderr] Downloaded find-msvc-tools v0.1.5 [INFO] [stderr] Downloaded futures-channel v0.3.31 [INFO] [stderr] Downloaded async-fs v2.2.0 [INFO] [stderr] Downloaded criterion-plot v0.8.2 [INFO] [stderr] Downloaded half v2.7.1 [INFO] [stderr] Downloaded cc v1.2.48 [INFO] [stderr] Downloaded rayon-core v1.13.0 [INFO] [stderr] Downloaded memchr v2.7.6 [INFO] [stderr] Downloaded itertools v0.13.0 [INFO] [stderr] Downloaded plotters v0.3.7 [INFO] [stderr] Downloaded clap_builder v4.5.50 [INFO] [stderr] Downloaded rayon v1.11.0 [INFO] [stderr] Downloaded regex v1.12.2 [INFO] [stderr] Downloaded wasip2 v1.0.1+wasi-0.2.4 [INFO] [stderr] Downloaded js-sys v0.3.82 [INFO] [stderr] Downloaded async-io v2.6.0 [INFO] [stderr] Downloaded smol v2.0.2 [INFO] [stderr] Downloaded syn v2.0.108 [INFO] [stderr] Downloaded clap v4.5.50 [INFO] [stderr] Downloaded wasm-bindgen-macro-support v0.2.105 [INFO] [stderr] Downloaded getrandom v0.2.16 [INFO] [stderr] Downloaded regex-syntax v0.8.8 [INFO] [stderr] Downloaded polling v3.11.0 [INFO] [stderr] Downloaded wit-bindgen v0.46.0 [INFO] [stderr] Downloaded rustix v1.1.2 [INFO] [stderr] Downloaded bitflags v2.10.0 [INFO] [stderr] Downloaded tempfile v3.23.0 [INFO] [stderr] Downloaded proc-macro2 v1.0.103 [INFO] [stderr] Downloaded quote v1.0.41 [INFO] [stderr] Downloaded futures v0.3.31 [INFO] [stderr] Downloaded wasm-bindgen v0.2.105 [INFO] [stderr] Downloaded quickcheck v1.0.3 [INFO] [stderr] Downloaded async-lock v3.4.1 [INFO] [stderr] Downloaded regex-automata v0.4.13 [INFO] [stderr] Downloaded event-listener v5.4.1 [INFO] [stderr] Downloaded web-sys v0.3.82 [INFO] [stderr] Downloaded async-net v2.0.0 [INFO] [stderr] Downloaded hermit-abi v0.5.2 [INFO] [stderr] Downloaded signal-hook-registry v1.4.6 [INFO] [stderr] Downloaded slab v0.4.11 [INFO] [stderr] Downloaded async-process v2.5.0 [INFO] [stderr] Downloaded libc v0.2.177 [INFO] [stderr] Downloaded async-channel v2.5.0 [INFO] [stderr] Downloaded futures-lite v2.6.1 [INFO] [stderr] Downloaded anes v0.1.6 [INFO] [stderr] Downloaded ciborium v0.2.2 [INFO] [stderr] Downloaded tokio v1.48.0 [INFO] [stderr] Downloaded csv-core v0.1.13 [INFO] [stderr] Downloaded csv v1.4.0 [INFO] [stderr] Downloaded futures-executor v0.3.31 [INFO] [stderr] Downloaded oorandom v11.1.5 [INFO] [stderr] Downloaded async-executor v1.13.3 [INFO] [stderr] Downloaded async-signal v0.2.13 [INFO] [stderr] Downloaded plotters-backend v0.3.7 [INFO] [stderr] Downloaded plotters-svg v0.3.7 [INFO] [stderr] Downloaded wasm-bindgen-macro v0.2.105 [INFO] [stderr] Downloaded wasm-bindgen-shared v0.2.105 [INFO] [stderr] Downloaded event-listener-strategy v0.5.4 [INFO] [stderr] Downloaded blocking v1.6.2 [INFO] [stderr] Downloaded linux-raw-sys v0.11.0 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 39c7a057da9895337b643a86ed035fe845d04558d335e92ff354a6ad68a2d7b8 [INFO] running `Command { std: "docker" "start" "-a" "39c7a057da9895337b643a86ed035fe845d04558d335e92ff354a6ad68a2d7b8", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "39c7a057da9895337b643a86ed035fe845d04558d335e92ff354a6ad68a2d7b8", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "39c7a057da9895337b643a86ed035fe845d04558d335e92ff354a6ad68a2d7b8", kill_on_drop: false }` [INFO] [stdout] 39c7a057da9895337b643a86ed035fe845d04558d335e92ff354a6ad68a2d7b8 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] a0b5fc4d32c52988a627283cd1b90b7732d755d6a43e7b7eadc3c42ecde53c27 [INFO] running `Command { std: "docker" "start" "-a" "a0b5fc4d32c52988a627283cd1b90b7732d755d6a43e7b7eadc3c42ecde53c27", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.103 [INFO] [stderr] Compiling unicode-ident v1.0.20 [INFO] [stderr] Compiling quote v1.0.41 [INFO] [stderr] Compiling serde_core v1.0.228 [INFO] [stderr] Compiling crossbeam-utils v0.8.21 [INFO] [stderr] Compiling zerocopy v0.8.27 [INFO] [stderr] Compiling find-msvc-tools v0.1.5 [INFO] [stderr] Compiling serde v1.0.228 [INFO] [stderr] Compiling autocfg v1.5.0 [INFO] [stderr] Compiling rayon-core v1.13.0 [INFO] [stderr] Compiling libc v0.2.177 [INFO] [stderr] Compiling serde_json v1.0.145 [INFO] [stderr] Compiling cfg-if v1.0.4 [INFO] [stderr] Compiling either v1.15.0 [INFO] [stderr] Compiling regex-syntax v0.8.8 [INFO] [stderr] Compiling plotters-backend v0.3.7 [INFO] [stderr] Compiling ryu v1.0.20 [INFO] [stderr] Compiling memchr v2.7.6 [INFO] [stderr] Compiling clap_lex v0.7.6 [INFO] [stderr] Compiling ciborium-io v0.2.2 [INFO] [stderr] Compiling cc v1.2.48 [INFO] [stderr] Compiling anstyle v1.0.13 [INFO] [stderr] Compiling itoa v1.0.15 [INFO] [stderr] Compiling itertools v0.13.0 [INFO] [stderr] Compiling plotters-svg v0.3.7 [INFO] [stderr] Compiling cast v0.3.0 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling oorandom v11.1.5 [INFO] [stderr] Compiling anes v0.1.6 [INFO] [stderr] Compiling walkdir v2.5.0 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling clap_builder v4.5.50 [INFO] [stderr] Compiling syn v2.0.108 [INFO] [stderr] Compiling crossbeam-epoch v0.9.18 [INFO] [stderr] Compiling crossbeam-deque v0.8.6 [INFO] [stderr] Compiling alloca v0.4.0 [INFO] [stderr] Compiling plotters v0.3.7 [INFO] [stderr] Compiling page_size v0.6.0 [INFO] [stderr] Compiling regex-automata v0.4.13 [INFO] [stderr] Compiling criterion-plot v0.8.2 [INFO] [stderr] Compiling rayon v1.11.0 [INFO] [stderr] Compiling clap v4.5.50 [INFO] [stderr] Compiling regex v1.12.2 [INFO] [stderr] Compiling zerocopy-derive v0.8.27 [INFO] [stderr] Compiling serde_derive v1.0.228 [INFO] [stderr] Compiling half v2.7.1 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling ciborium-ll v0.2.2 [INFO] [stderr] Compiling ciborium v0.2.2 [INFO] [stderr] Compiling criterion v0.8.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 28.61s [INFO] running `Command { std: "docker" "inspect" "a0b5fc4d32c52988a627283cd1b90b7732d755d6a43e7b7eadc3c42ecde53c27", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a0b5fc4d32c52988a627283cd1b90b7732d755d6a43e7b7eadc3c42ecde53c27", kill_on_drop: false }` [INFO] [stdout] a0b5fc4d32c52988a627283cd1b90b7732d755d6a43e7b7eadc3c42ecde53c27 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] b1e1dff22a4074e96f4366ebf79df37d1f52e9822fee033619bd8055bd1f74a2 [INFO] running `Command { std: "docker" "start" "-a" "b1e1dff22a4074e96f4366ebf79df37d1f52e9822fee033619bd8055bd1f74a2", kill_on_drop: false }` [INFO] [stderr] Compiling memchr v2.7.6 [INFO] [stderr] Compiling futures-core v0.3.31 [INFO] [stderr] Compiling futures-sink v0.3.31 [INFO] [stderr] Compiling futures-io v0.3.31 [INFO] [stderr] Compiling futures-task v0.3.31 [INFO] [stderr] Compiling rustix v1.1.2 [INFO] [stderr] Compiling pin-project-lite v0.2.16 [INFO] [stderr] Compiling slab v0.4.11 [INFO] [stderr] Compiling getrandom v0.2.16 [INFO] [stderr] Compiling futures-macro v0.3.31 [INFO] [stderr] Compiling getrandom v0.3.4 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling bitflags v2.10.0 [INFO] [stderr] Compiling linux-raw-sys v0.11.0 [INFO] [stderr] Compiling fastrand v2.3.0 [INFO] [stderr] Compiling once_cell v1.21.3 [INFO] [stderr] Compiling approx v0.5.1 [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling serde_json v1.0.145 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling quickcheck v1.0.3 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling criterion v0.8.2 (/opt/rustwide/workdir) [INFO] [stderr] Compiling tempfile v3.23.0 [INFO] [stderr] Compiling futures-executor v0.3.31 [INFO] [stderr] Compiling futures v0.3.31 [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 17.35s [INFO] running `Command { std: "docker" "inspect" "b1e1dff22a4074e96f4366ebf79df37d1f52e9822fee033619bd8055bd1f74a2", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b1e1dff22a4074e96f4366ebf79df37d1f52e9822fee033619bd8055bd1f74a2", kill_on_drop: false }` [INFO] [stdout] b1e1dff22a4074e96f4366ebf79df37d1f52e9822fee033619bd8055bd1f74a2 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] fed7aca1a3f0700b4f4d5abae13449042544dfa395584e86ca674b6609c5f1a7 [INFO] running `Command { std: "docker" "start" "-a" "fed7aca1a3f0700b4f4d5abae13449042544dfa395584e86ca674b6609c5f1a7", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.18s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/criterion-157dc049731dbaef) [INFO] [stdout] [INFO] [stdout] running 28 tests [INFO] [stdout] test format::test::short_max_len ... ok [INFO] [stdout] test format::test::signed_short_max_len ... ok [INFO] [stdout] test report::test::test_make_filename_safe_replaces_characters ... ok [INFO] [stdout] test report::test::test_benchmark_id_make_long_directory_name_unique ... ok [INFO] [stdout] test report::test::test_benchmark_id_make_directory_name_unique ... ok [INFO] [stdout] test report::test::test_make_filename_safe_respects_character_boundaries ... ok [INFO] [stdout] test report::test::test_make_filename_safe_truncates_long_strings ... ok [INFO] [stdout] test format::test::integer_thousands_sep ... ok [INFO] [stdout] test stats::univariate::kde::kernel::test::f64::gaussian::symmetric ... ok [INFO] [stdout] test stats::univariate::kde::kernel::test::f64::gaussian::integral ... ok [INFO] [stdout] test stats::univariate::kde::kernel::test::f32::gaussian::symmetric ... ok [INFO] [stdout] test stats::univariate::kde::kernel::test::f32::gaussian::integral ... ok [INFO] [stdout] test stats::univariate::resamples::test::different_subsets ... ok [INFO] [stdout] test stats::univariate::bootstrap::test::f32::two_sample ... ok [INFO] [stdout] test stats::univariate::bootstrap::test::f32::mean ... ok [INFO] [stdout] test stats::univariate::bootstrap::test::f64::two_sample ... ok [INFO] [stdout] test stats::bivariate::bootstrap::test::f64::slope ... ok [INFO] [stdout] test stats::univariate::bootstrap::test::f64::mean ... ok [INFO] [stdout] test stats::bivariate::bootstrap::test::f32::slope ... ok [INFO] [stdout] test stats::bivariate::bootstrap::test::f32::means ... ok [INFO] [stdout] test stats::univariate::bootstrap::test::f32::mixed_two_sample ... ok [INFO] [stdout] test stats::bivariate::bootstrap::test::f64::means ... ok [INFO] [stdout] test stats::univariate::bootstrap::test::f64::mixed_two_sample ... ok [INFO] [stdout] test stats::univariate::bootstrap::test::f32::mean_median ... ok [INFO] [stdout] test stats::univariate::bootstrap::test::f64::mean_median ... ok [INFO] [stdout] test stats::univariate::resamples::test::subset ... ok [INFO] [stdout] test stats::univariate::kde::test::f64::integral ... ok [INFO] [stdout] test stats::univariate::kde::test::f32::integral ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 28 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.65s [INFO] [stdout] [INFO] [stderr] Running tests/criterion_tests.rs (/opt/rustwide/target/debug/deps/criterion_tests-3941ff08680ba954) [INFO] [stdout] [INFO] [stdout] running 24 tests [INFO] [stdout] test macros::criterion_main_trailing_comma ... ok [INFO] [stdout] test test_filtering ... ok [INFO] [stdout] test macros::criterion_group_trailing_comma - should panic ... ok [INFO] [stdout] test macros::criterion_main - should panic ... ok [INFO] [stdout] test test_compare_baseline_strict_panics_when_missing_baseline - should panic ... ok [INFO] [stdout] test macros::criterion_group - should panic ... ok [INFO] [stdout] test test_bench_with_no_iteration_panics - should panic ... ok [INFO] [stdout] test test_criterion_doesnt_panic_if_measured_time_is_zero ... ok [INFO] [stdout] test test_profiler_called ... ok [INFO] [stdout] test test_without_plots ... ok [INFO] [stdout] test test_save_baseline ... ok [INFO] [stdout] test test_bench_function ... ok [INFO] [stdout] test test_compare_baseline_lenient_when_missing_baseline ... ok [INFO] [stdout] test test_sample_size ... ok [INFO] [stdout] test test_criterion_doesnt_panic_with_uniform_durations ... ok [INFO] [stdout] test test_creates_directory ... ok [INFO] [stdout] test test_benchmark_group_without_input ... ok [INFO] [stdout] test test_retain_baseline ... ok [INFO] [stdout] test test_warmup_time ... ok [INFO] [stdout] test test_measurement_time ... FAILED [INFO] [stdout] test test_output_files_flat_sampling ... ok [INFO] [stdout] test test_benchmark_group_with_input ... ok [INFO] [stdout] test test_output_files ... ok [INFO] [stdout] test test_timing_loops ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- test_measurement_time stdout ---- [INFO] [stdout] Benchmarking test_meas_time_1 [INFO] [stdout] Benchmarking test_meas_time_1: Warming up for 250.00 ms [INFO] [stdout] Benchmarking test_meas_time_1: Collecting 100 samples in estimated 100.65 ms (475k iterations) [INFO] [stdout] Benchmarking test_meas_time_1: Analyzing [INFO] [stdout] test_meas_time_1 time: [54.985 ns 115.16 ns 194.74 ns] [INFO] [stdout] Found 15 outliers among 100 measurements (15.00%) [INFO] [stdout] 4 (4.00%) low mild [INFO] [stdout] 1 (1.00%) high mild [INFO] [stdout] 10 (10.00%) high severe [INFO] [stdout] [INFO] [stdout] Benchmarking test_meas_time_2 [INFO] [stdout] Benchmarking test_meas_time_2: Warming up for 250.00 ms [INFO] [stdout] Benchmarking test_meas_time_2: Collecting 100 samples in estimated 2.0011 s (2.0M iterations) [INFO] [stdout] Benchmarking test_meas_time_2: Analyzing [INFO] [stdout] test_meas_time_2 time: [225.49 ns 352.72 ns 492.13 ns] [INFO] [stdout] Found 13 outliers among 100 measurements (13.00%) [INFO] [stdout] 8 (8.00%) high mild [INFO] [stdout] 5 (5.00%) high severe [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] thread 'test_measurement_time' (77) panicked at tests/criterion_tests.rs:249:5: [INFO] [stdout] assertion failed: counter1.read() < counter2.read() [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x63c5a393964a - std[8eed7d2a0d2e32a7]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x63c5a393964a - std[8eed7d2a0d2e32a7]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x63c5a393964a - std[8eed7d2a0d2e32a7]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x63c5a393964a - <::print::DisplayBacktrace as core[c3b3818c781903d6]::fmt::Display>::fmt [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x63c5a395245a - ::fmt [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x63c5a395245a - core[c3b3818c781903d6]::fmt::write [INFO] [stdout] 6: 0x63c5a393f3e2 - std[8eed7d2a0d2e32a7]::io::default_write_fmt::> [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/io/mod.rs:621:11 [INFO] [stdout] 7: 0x63c5a393f3e2 - as std[8eed7d2a0d2e32a7]::io::Write>::write_fmt [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/io/mod.rs:1976:13 [INFO] [stdout] 8: 0x63c5a3914d8f - ::print [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x63c5a3914d8f - std[8eed7d2a0d2e32a7]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x63c5a392fde9 - std[8eed7d2a0d2e32a7]::panicking::default_hook [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x63c5a346343c - core[c3b3818c781903d6]::ops::function::Fn<(&'a std[8eed7d2a0d2e32a7]::panic::PanicHookInfo<'b>,), Output = ()> + core[c3b3818c781903d6]::marker::Sync + core[c3b3818c781903d6]::marker::Send> as core[c3b3818c781903d6]::ops::function::Fn<(&std[8eed7d2a0d2e32a7]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/alloc/src/boxed.rs:2263:9 [INFO] [stdout] 12: 0x63c5a346343c - test[2304db833829cdec]::test_main_with_exit_callback::::{closure#0} [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x63c5a3930062 - core[c3b3818c781903d6]::ops::function::Fn<(&'a std[8eed7d2a0d2e32a7]::panic::PanicHookInfo<'b>,), Output = ()> + core[c3b3818c781903d6]::marker::Sync + core[c3b3818c781903d6]::marker::Send> as core[c3b3818c781903d6]::ops::function::Fn<(&std[8eed7d2a0d2e32a7]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/alloc/src/boxed.rs:2263:9 [INFO] [stdout] 14: 0x63c5a3930062 - std[8eed7d2a0d2e32a7]::panicking::panic_with_hook [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x63c5a3914e7a - std[8eed7d2a0d2e32a7]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/panicking.rs:691:13 [INFO] [stdout] 16: 0x63c5a390c449 - std[8eed7d2a0d2e32a7]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x63c5a3915d1d - __rustc[1c0edf6a00b737dc]::rust_begin_unwind [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x63c5a3952c9c - core[c3b3818c781903d6]::panicking::panic_fmt [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x63c5a3952c62 - core[c3b3818c781903d6]::panicking::panic [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/core/src/panicking.rs:150:5 [INFO] [stdout] 20: 0x63c5a34421ea - criterion_tests[5c1754407576b711]::test_measurement_time [INFO] [stdout] at /opt/rustwide/workdir/tests/criterion_tests.rs:249:5 [INFO] [stdout] 21: 0x63c5a343e0d7 - criterion_tests[5c1754407576b711]::test_measurement_time::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/criterion_tests.rs:234:27 [INFO] [stdout] 22: 0x63c5a344a7d6 - >::call_once [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x63c5a345754b - core[c3b3818c781903d6]::result::Result<(), alloc[f403ee7a715222b6]::string::String> as core[c3b3818c781903d6]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 24: 0x63c5a345754b - test[2304db833829cdec]::__rust_begin_short_backtrace::, fn() -> core[c3b3818c781903d6]::result::Result<(), alloc[f403ee7a715222b6]::string::String>> [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/test/src/lib.rs:663:18 [INFO] [stdout] 25: 0x63c5a3463f0b - test[2304db833829cdec]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/test/src/lib.rs:686:74 [INFO] [stdout] 26: 0x63c5a3463f0b - as core[c3b3818c781903d6]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 27: 0x63c5a3463f0b - std[8eed7d2a0d2e32a7]::panicking::catch_unwind::do_call::, core[c3b3818c781903d6]::result::Result<(), alloc[f403ee7a715222b6]::string::String>> [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/panicking.rs:581:40 [INFO] [stdout] 28: 0x63c5a3463f0b - std[8eed7d2a0d2e32a7]::panicking::catch_unwind::, core[c3b3818c781903d6]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/panicking.rs:544:19 [INFO] [stdout] 29: 0x63c5a3463f0b - std[8eed7d2a0d2e32a7]::panic::catch_unwind::, core[c3b3818c781903d6]::result::Result<(), alloc[f403ee7a715222b6]::string::String>> [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/panic.rs:359:14 [INFO] [stdout] 30: 0x63c5a3463f0b - test[2304db833829cdec]::run_test_in_process [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/test/src/lib.rs:686:27 [INFO] [stdout] 31: 0x63c5a3463f0b - test[2304db833829cdec]::run_test::{closure#0} [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/test/src/lib.rs:607:43 [INFO] [stdout] 32: 0x63c5a345e364 - test[2304db833829cdec]::run_test::{closure#1} [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/test/src/lib.rs:637:41 [INFO] [stdout] 33: 0x63c5a345e364 - std[8eed7d2a0d2e32a7]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 34: 0x63c5a3466b12 - std[8eed7d2a0d2e32a7]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/thread/lifecycle.rs:91:13 [INFO] [stdout] 35: 0x63c5a3466b12 - ::{closure#1}::{closure#0}> as core[c3b3818c781903d6]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 36: 0x63c5a3466b12 - std[8eed7d2a0d2e32a7]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/panicking.rs:581:40 [INFO] [stdout] 37: 0x63c5a3466b12 - std[8eed7d2a0d2e32a7]::panicking::catch_unwind::<(), core[c3b3818c781903d6]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/panicking.rs:544:19 [INFO] [stdout] 38: 0x63c5a3466b12 - std[8eed7d2a0d2e32a7]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/panic.rs:359:14 [INFO] [stdout] 39: 0x63c5a3466b12 - std[8eed7d2a0d2e32a7]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/thread/lifecycle.rs:89:26 [INFO] [stdout] 40: 0x63c5a3466b12 - ::{closure#1} as core[c3b3818c781903d6]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 41: 0x63c5a393882f - + core[c3b3818c781903d6]::marker::Send> as core[c3b3818c781903d6]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/alloc/src/boxed.rs:2249:9 [INFO] [stdout] 42: 0x63c5a393882f - ::new::thread_start [INFO] [stdout] at /rustc/c2efcc4ae006a6b2761cb42572fc9cee0d1ce4af/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 43: 0x749f39361aa4 - [INFO] [stdout] 44: 0x749f393eea64 - clone [INFO] [stdout] 45: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] test_measurement_time [INFO] [stdout] [INFO] [stdout] test result: FAILED. 23 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 23.23s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--test criterion_tests` [INFO] running `Command { std: "docker" "inspect" "fed7aca1a3f0700b4f4d5abae13449042544dfa395584e86ca674b6609c5f1a7", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "fed7aca1a3f0700b4f4d5abae13449042544dfa395584e86ca674b6609c5f1a7", kill_on_drop: false }` [INFO] [stdout] fed7aca1a3f0700b4f4d5abae13449042544dfa395584e86ca674b6609c5f1a7