[INFO] fetching crate hyperfine 1.12.0... [INFO] testing hyperfine-1.12.0 against master#a77da2d454e6caa227a85b16410b95f93495e7e0 for pr-91031 [INFO] extracting crate hyperfine 1.12.0 into /workspace/builds/worker-101/source [INFO] validating manifest of crates.io crate hyperfine 1.12.0 on toolchain a77da2d454e6caa227a85b16410b95f93495e7e0 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate hyperfine 1.12.0 [INFO] finished tweaking crates.io crate hyperfine 1.12.0 [INFO] tweaked toml for crates.io crate hyperfine 1.12.0 written to /workspace/builds/worker-101/source/Cargo.toml [INFO] crate crates.io crate hyperfine 1.12.0 already has a lockfile, it will not be regenerated [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-101/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-101/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 03f6d1142b32c4b8d119c056ded3f17f84ec03dd3341b72327112ad6ab7a5a80 [INFO] running `Command { std: "docker" "start" "-a" "03f6d1142b32c4b8d119c056ded3f17f84ec03dd3341b72327112ad6ab7a5a80", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "03f6d1142b32c4b8d119c056ded3f17f84ec03dd3341b72327112ad6ab7a5a80", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "03f6d1142b32c4b8d119c056ded3f17f84ec03dd3341b72327112ad6ab7a5a80", kill_on_drop: false }` [INFO] [stdout] 03f6d1142b32c4b8d119c056ded3f17f84ec03dd3341b72327112ad6ab7a5a80 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-101/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-101/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] ffedad4040ca439019621305dd1c2baacc2ae1a8cc054a4261215eab570d857b [INFO] running `Command { std: "docker" "start" "-a" "ffedad4040ca439019621305dd1c2baacc2ae1a8cc054a4261215eab570d857b", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling libc v0.2.104 [INFO] [stderr] Compiling proc-macro2 v1.0.30 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling syn v1.0.80 [INFO] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling serde_derive v1.0.130 [INFO] [stderr] Compiling serde v1.0.130 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling unicode-width v0.1.9 [INFO] [stderr] Compiling ryu v1.0.5 [INFO] [stderr] Compiling vec_map v0.8.2 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling strsim v0.8.0 [INFO] [stderr] Compiling ansi_term v0.11.0 [INFO] [stderr] Compiling ppv-lite86 v0.2.14 [INFO] [stderr] Compiling serde_json v1.0.68 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling once_cell v1.8.0 [INFO] [stderr] Compiling arrayvec v0.5.2 [INFO] [stderr] Compiling number_prefix v0.4.0 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling num-bigint v0.2.6 [INFO] [stderr] Compiling num-complex v0.2.4 [INFO] [stderr] Compiling num-rational v0.2.4 [INFO] [stderr] Compiling num-iter v0.1.42 [INFO] [stderr] Compiling rand_core v0.3.1 [INFO] [stderr] Compiling rand_chacha v0.1.1 [INFO] [stderr] Compiling rand_pcg v0.1.2 [INFO] [stderr] Compiling rand v0.6.5 [INFO] [stderr] Compiling rand_jitter v0.1.4 [INFO] [stderr] Compiling rand_isaac v0.1.1 [INFO] [stderr] Compiling rand_xorshift v0.1.1 [INFO] [stderr] Compiling rand_hc v0.1.0 [INFO] [stderr] Compiling aho-corasick v0.7.18 [INFO] [stderr] Compiling csv-core v0.1.10 [INFO] [stderr] Compiling quote v1.0.10 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling term_size v0.3.2 [INFO] [stderr] Compiling getrandom v0.2.3 [INFO] [stderr] Compiling rand_os v0.1.3 [INFO] [stderr] Compiling terminal_size v0.1.17 [INFO] [stderr] Compiling console v0.15.0 [INFO] [stderr] Compiling colored v2.0.0 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling clap v2.33.3 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling rand v0.8.4 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling num v0.2.1 [INFO] [stderr] Compiling statistical v1.0.0 [INFO] [stderr] Compiling indicatif v0.16.2 [INFO] [stderr] Compiling hyperfine v1.12.0 (/opt/rustwide/workdir) [INFO] [stderr] Compiling bstr v0.2.17 [INFO] [stderr] Compiling rust_decimal v1.16.0 [INFO] [stderr] Compiling csv v1.1.6 [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 23.77s [INFO] running `Command { std: "docker" "inspect" "ffedad4040ca439019621305dd1c2baacc2ae1a8cc054a4261215eab570d857b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "ffedad4040ca439019621305dd1c2baacc2ae1a8cc054a4261215eab570d857b", kill_on_drop: false }` [INFO] [stdout] ffedad4040ca439019621305dd1c2baacc2ae1a8cc054a4261215eab570d857b [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-101/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-101/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] ebd6c4000ea51ad621fe9017a5abf1b39ad06d04f3c21e6cb7c356659f2bf797 [INFO] running `Command { std: "docker" "start" "-a" "ebd6c4000ea51ad621fe9017a5abf1b39ad06d04f3c21e6cb7c356659f2bf797", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling either v1.6.1 [INFO] [stderr] Compiling predicates-core v1.0.2 [INFO] [stderr] Compiling doc-comment v0.3.3 [INFO] [stderr] Compiling difflib v0.4.0 [INFO] [stderr] Compiling termtree v0.2.1 [INFO] [stderr] Compiling normalize-line-endings v0.3.0 [INFO] [stderr] Compiling remove_dir_all v0.5.3 [INFO] [stderr] Compiling float-cmp v0.9.0 [INFO] [stderr] Compiling wait-timeout v0.2.0 [INFO] [stderr] Compiling approx v0.5.0 [INFO] [stderr] Compiling tempfile v3.2.0 [INFO] [stderr] Compiling predicates-tree v1.0.4 [INFO] [stderr] Compiling itertools v0.10.1 [INFO] [stderr] Compiling predicates v2.0.3 [INFO] [stderr] Compiling assert_cmd v2.0.2 [INFO] [stderr] Compiling hyperfine v1.12.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 8.55s [INFO] running `Command { std: "docker" "inspect" "ebd6c4000ea51ad621fe9017a5abf1b39ad06d04f3c21e6cb7c356659f2bf797", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "ebd6c4000ea51ad621fe9017a5abf1b39ad06d04f3c21e6cb7c356659f2bf797", kill_on_drop: false }` [INFO] [stdout] ebd6c4000ea51ad621fe9017a5abf1b39ad06d04f3c21e6cb7c356659f2bf797 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-101/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-101/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] d2207277c32792af2c1fae753a2e91df96f831d19b6c615a83a14f34996e4c69 [INFO] running `Command { std: "docker" "start" "-a" "d2207277c32792af2c1fae753a2e91df96f831d19b6c615a83a14f34996e4c69", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.28s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/hyperfine-d3f1b32f070ca9b0) [INFO] [stdout] [INFO] [stdout] running 37 tests [INFO] [stdout] test command::test_get_parameterized_command_name ... ok [INFO] [stdout] test command::test_get_shell_command_nonoverlapping ... ok [INFO] [stdout] test export::asciidoc::test_asciidoc ... ok [INFO] [stdout] test export::asciidoc::test_asciidoc_header ... ok [INFO] [stdout] test export::asciidoc::test_asciidoc_table_row ... ok [INFO] [stdout] test export::csv::test_csv ... ok [INFO] [stdout] test export::asciidoc::test_asciidoc_table_row_command_escape ... ok [INFO] [stdout] test export::markdown::test_markdown_format_ms ... ok [INFO] [stdout] test export::markdown::test_markdown_format_time_unit_ms ... ok [INFO] [stdout] test format::test_format_duration_unit_with_unit ... ok [INFO] [stdout] test min_max::test_max ... ok [INFO] [stdout] test export::markdown::test_markdown_format_time_unit_s ... ok [INFO] [stdout] test options::test_shell_default_command ... ok [INFO] [stdout] test export::markdown::test_markdown_format_s ... ok [INFO] [stdout] test options::test_shell_parse_command ... ok [INFO] [stdout] test outlier_detection::test_detect_outliers ... ok [INFO] [stdout] test outlier_detection::test_detect_outliers_if_mad_becomes_0 ... ok [INFO] [stdout] test format::test_format_duration_unit_basic ... ok [INFO] [stdout] test parameter_range::test_decimal_range ... ok [INFO] [stdout] test parameter_range::test_different_command_name_count_with_parameters ... ok [INFO] [stdout] test parameter_range::test_range_step_validate ... ok [INFO] [stdout] test parameter_range::test_get_parameterized_command_names ... ok [INFO] [stdout] test parameter_range::test_get_specified_command_names ... ok [INFO] [stdout] test parameter_range::test_get_parameterized_commands_int ... ok [INFO] [stdout] test parameter_range::test_get_parameterized_commands_decimal ... ok [INFO] [stdout] test relative_speed::test_compute_relative_speed ... ok [INFO] [stdout] test relative_speed::test_compute_relative_speed_for_zero_times ... ok [INFO] [stdout] test parameter_range::test_integer_range ... ok [INFO] [stdout] test test_build_commands_cross_product ... ok [INFO] [stdout] test timer::unix_timer::test_cpu_time_interval ... ok [INFO] [stdout] test test_build_parameter_range_commands ... ok [INFO] [stdout] test test_build_parameter_list_commands ... ok [INFO] [stdout] test tokenize::test_tokenize_empty_values ... ok [INFO] [stdout] test tokenize::test_tokenize_multiple_values ... ok [INFO] [stdout] test units::test_unit_format ... ok [INFO] [stdout] test tokenize::test_tokenize_single_value ... ok [INFO] [stdout] test units::test_unit_short_name ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 37 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.15s [INFO] [stdout] [INFO] [stderr] Running tests/integration_tests.rs (/opt/rustwide/target/debug/deps/integration_tests-602333a4e7ab9d32) [INFO] [stdout] [INFO] [stdout] running 8 tests [INFO] [stdout] test at_least_two_runs_are_required ... ok [INFO] [stdout] test hyperfine_runs_successfully ... ok [INFO] [stdout] test warmup_runs_are_executed_before_benchmarking_runs ... ok [INFO] [stdout] test prepare_commands_are_executed_before_each_timing_run ... ok [INFO] [stdout] test single_parameter_value ... ok [INFO] [stdout] test cleanup_commands_are_executed_once_after_each_benchmark ... ok [INFO] [stdout] test multiple_parameter_values ... ok [INFO] [stdout] test benchmarks_are_executed_sequentially ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.76s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "d2207277c32792af2c1fae753a2e91df96f831d19b6c615a83a14f34996e4c69", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "d2207277c32792af2c1fae753a2e91df96f831d19b6c615a83a14f34996e4c69", kill_on_drop: false }` [INFO] [stdout] d2207277c32792af2c1fae753a2e91df96f831d19b6c615a83a14f34996e4c69