[INFO] cloning repository https://github.com/rohankumardubey/hyperfine
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/rohankumardubey/hyperfine" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frohankumardubey%2Fhyperfine", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frohankumardubey%2Fhyperfine'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 39984a3896f25d18076595b4bd766064083f4bc5
[INFO] testing rohankumardubey/hyperfine against 1.60.0 for beta-1.61-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frohankumardubey%2Fhyperfine" "/workspace/builds/worker-9/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-9/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/rohankumardubey/hyperfine on toolchain 1.60.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/rohankumardubey/hyperfine
[INFO] finished tweaking git repo https://github.com/rohankumardubey/hyperfine
[INFO] tweaked toml for git repo https://github.com/rohankumardubey/hyperfine written to /workspace/builds/worker-9/source/Cargo.toml
[INFO] crate git repo https://github.com/rohankumardubey/hyperfine already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded rust_decimal v1.21.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/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:eaef2f80f755933c374d2ae5edccceec0c1312ceb8a4e0b6404e8ab76561e1e5" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ac8a950535d0fae8f8efa9492647743b53a26259552d048b6e7423f844f3e40a
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "ac8a950535d0fae8f8efa9492647743b53a26259552d048b6e7423f844f3e40a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ac8a950535d0fae8f8efa9492647743b53a26259552d048b6e7423f844f3e40a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ac8a950535d0fae8f8efa9492647743b53a26259552d048b6e7423f844f3e40a", kill_on_drop: false }`
[INFO] [stdout] ac8a950535d0fae8f8efa9492647743b53a26259552d048b6e7423f844f3e40a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/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=warn" "-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:eaef2f80f755933c374d2ae5edccceec0c1312ceb8a4e0b6404e8ab76561e1e5" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 47818dc51b26f84272a352d147676afffd15258c92edd4b54fc2e765f7e79681
[INFO] running `Command { std: "docker" "start" "-a" "47818dc51b26f84272a352d147676afffd15258c92edd4b54fc2e765f7e79681", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling serde_json v1.0.78
[INFO] [stderr]    Compiling regex-automata v0.1.10
[INFO] [stderr]    Compiling rust_decimal v1.21.0
[INFO] [stderr]    Compiling shell-words v1.0.0
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling num-integer v0.1.44
[INFO] [stderr]    Compiling indexmap v1.8.0
[INFO] [stderr]    Compiling num-bigint v0.2.6
[INFO] [stderr]    Compiling num-rational v0.2.4
[INFO] [stderr]    Compiling num-complex v0.2.4
[INFO] [stderr]    Compiling num-iter v0.1.42
[INFO] [stderr]    Compiling terminal_size v0.1.17
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling rand_os v0.1.3
[INFO] [stderr]    Compiling csv-core v0.1.10
[INFO] [stderr]    Compiling thiserror-impl v1.0.30
[INFO] [stderr]    Compiling serde v1.0.136
[INFO] [stderr]    Compiling colored v2.0.0
[INFO] [stderr]    Compiling textwrap v0.14.2
[INFO] [stderr]    Compiling console v0.15.0
[INFO] [stderr]    Compiling rand v0.6.5
[INFO] [stderr]    Compiling indicatif v0.16.2
[INFO] [stderr]    Compiling clap v3.0.14
[INFO] [stderr]    Compiling thiserror v1.0.30
[INFO] [stderr]    Compiling clap_complete v3.0.5
[INFO] [stderr]    Compiling num v0.2.1
[INFO] [stderr]    Compiling statistical v1.0.0
[INFO] [stderr]    Compiling bstr v0.2.17
[INFO] [stderr]    Compiling csv v1.1.6
[INFO] [stderr]    Compiling hyperfine v1.12.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 04s
[INFO] running `Command { std: "docker" "inspect" "47818dc51b26f84272a352d147676afffd15258c92edd4b54fc2e765f7e79681", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "47818dc51b26f84272a352d147676afffd15258c92edd4b54fc2e765f7e79681", kill_on_drop: false }`
[INFO] [stdout] 47818dc51b26f84272a352d147676afffd15258c92edd4b54fc2e765f7e79681
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/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=warn" "-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:eaef2f80f755933c374d2ae5edccceec0c1312ceb8a4e0b6404e8ab76561e1e5" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 1d7be00ecc67027aebc5c9e358b1dbbb96acd55e1836f215bd5363bc29c3bfef
[INFO] running `Command { std: "docker" "start" "-a" "1d7be00ecc67027aebc5c9e358b1dbbb96acd55e1836f215bd5363bc29c3bfef", kill_on_drop: false }`
[INFO] [stderr]    Compiling predicates-core v1.0.3
[INFO] [stderr]    Compiling normalize-line-endings v0.3.0
[INFO] [stderr]    Compiling termtree v0.2.4
[INFO] [stderr]    Compiling difflib v0.4.0
[INFO] [stderr]    Compiling wait-timeout v0.2.0
[INFO] [stderr]    Compiling tempfile v3.3.0
[INFO] [stderr]    Compiling float-cmp v0.9.0
[INFO] [stderr]    Compiling approx v0.5.1
[INFO] [stderr]    Compiling predicates-tree v1.0.5
[INFO] [stderr]    Compiling predicates v2.1.1
[INFO] [stderr]    Compiling assert_cmd v2.0.4
[INFO] [stderr]    Compiling hyperfine v1.12.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 18.41s
[INFO] running `Command { std: "docker" "inspect" "1d7be00ecc67027aebc5c9e358b1dbbb96acd55e1836f215bd5363bc29c3bfef", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1d7be00ecc67027aebc5c9e358b1dbbb96acd55e1836f215bd5363bc29c3bfef", kill_on_drop: false }`
[INFO] [stdout] 1d7be00ecc67027aebc5c9e358b1dbbb96acd55e1836f215bd5363bc29c3bfef
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/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=warn" "-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:eaef2f80f755933c374d2ae5edccceec0c1312ceb8a4e0b6404e8ab76561e1e5" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 1deeb3a3d9d01250ff24aea82e26b6e7c700b669d715a1cad45f2286090ee1ce
[INFO] running `Command { std: "docker" "start" "-a" "1deeb3a3d9d01250ff24aea82e26b6e7c700b669d715a1cad45f2286090ee1ce", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3m 01s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/hyperfine-36af0b8e72593916)
[INFO] [stdout] 
[INFO] [stdout] running 38 tests
[INFO] [stdout] test command::test_different_command_name_count_with_parameters ... ok
[INFO] [stdout] test command::test_get_parameterized_command_names ... ok
[INFO] [stdout] test command::test_get_parameterized_command_name ... ok
[INFO] [stdout] test command::test_get_specified_command_names ... 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::asciidoc::test_asciidoc_table_row_command_escape ... ok
[INFO] [stdout] test export::csv::test_csv ... ok
[INFO] [stdout] test app::verify_app ... ok
[INFO] [stdout] test export::markdown::test_markdown_format_s ... ok
[INFO] [stdout] test export::markdown::test_markdown_format_time_unit_ms ... 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 benchmark::relative_speed::test_compute_relative_speed_for_zero_times ... ok
[INFO] [stdout] test benchmark::relative_speed::test_compute_relative_speed ... ok
[INFO] [stdout] test options::test_shell_parse_command ... ok
[INFO] [stdout] test output::format::test_format_duration_unit_with_unit ... ok
[INFO] [stdout] test command::test_get_parameterized_commands_decimal ... ok
[INFO] [stdout] test output::format::test_format_duration_unit_basic ... ok
[INFO] [stdout] test parameter::tokenize::test_tokenize_empty_values ... ok
[INFO] [stdout] test parameter::range_step::tests::test_decimal_range ... ok
[INFO] [stdout] test export::markdown::test_markdown_format_ms ... ok
[INFO] [stdout] test parameter::range_step::tests::test_range_step_validate ... ok
[INFO] [stdout] test command::test_get_parameterized_commands_int ... ok
[INFO] [stdout] test command::test_get_shell_command_nonoverlapping ... ok
[INFO] [stdout] test command::test_build_commands_cross_product ... ok
[INFO] [stdout] test command::test_build_parameter_range_commands ... ok
[INFO] [stdout] test parameter::tokenize::test_tokenize_multiple_values ... ok
[INFO] [stdout] test outlier_detection::test_detect_outliers_if_mad_becomes_0 ... ok
[INFO] [stdout] test parameter::tokenize::test_tokenize_single_value ... ok
[INFO] [stdout] test util::units::test_unit_short_name ... ok
[INFO] [stdout] test util::units::test_unit_format ... ok
[INFO] [stdout] test timer::unix_timer::test_cpu_time_interval ... ok
[INFO] [stdout] test parameter::range_step::tests::test_integer_range ... ok
[INFO] [stdout] test util::min_max::test_max ... ok
[INFO] [stdout] test outlier_detection::test_detect_outliers ... ok
[INFO] [stdout] test command::test_build_parameter_list_commands ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 38 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/common.rs (/opt/rustwide/target/debug/deps/common-bb5738372774db32)
[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 tests/execution_order_tests.rs (/opt/rustwide/target/debug/deps/execution_order_tests-0b4871c988524a0d)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test warmup_runs_are_executed_before_benchmarking_runs ... ok
[INFO] [stdout] test benchmarks_are_executed_sequentially ... ok
[INFO] [stdout] test cleanup_commands_are_executed_once_after_each_benchmark ... ok
[INFO] [stdout] test multiple_parameter_values ... ok
[INFO] [stdout] test setup_prepare_cleanup_combined ... ok
[INFO] [stdout] test prepare_commands_are_executed_before_each_timing_run ... ok
[INFO] [stdout] test prepare_commands_are_executed_before_each_warmup ... ok
[INFO] [stdout] test setup_commands_are_executed_before_each_series_of_timing_runs ... ok
[INFO] [stdout] test single_parameter_value ... ok
[INFO] [stdout] test benchmarks_are_executed_sequentially_one ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.37s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_tests.rs (/opt/rustwide/target/debug/deps/integration_tests-8b6a2ff3bc0a1bdc)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test fails_with_wrong_number_of_command_name_arguments ... ok
[INFO] [stdout] test fails_with_duplicate_parameter_names ... ok
[INFO] [stdout] test hyperfine_runs_successfully ... ok
[INFO] [stdout] test one_run_is_supported ... ok
[INFO] [stdout] test fails_for_unknown_command ... ok
[INFO] [stdout] test can_run_failing_commands_with_ignore_failure_option ... ok
[INFO] [stdout] test fails_with_wrong_number_of_prepare_options ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.76s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "1deeb3a3d9d01250ff24aea82e26b6e7c700b669d715a1cad45f2286090ee1ce", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1deeb3a3d9d01250ff24aea82e26b6e7c700b669d715a1cad45f2286090ee1ce", kill_on_drop: false }`
[INFO] [stdout] 1deeb3a3d9d01250ff24aea82e26b6e7c700b669d715a1cad45f2286090ee1ce