[INFO] cloning repository https://github.com/ConnorBP/benchme
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/ConnorBP/benchme" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FConnorBP%2Fbenchme", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FConnorBP%2Fbenchme'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] e8e43ba6ba7b146cf1412d794a71837fd24ffee9
[INFO] checking ConnorBP/benchme against master#33fdb797f59421c7bbecaa4588ed5d7a31a9494a for pr-87190-3
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FConnorBP%2Fbenchme" "/workspace/builds/worker-31/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-31/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/ConnorBP/benchme on toolchain 33fdb797f59421c7bbecaa4588ed5d7a31a9494a
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+33fdb797f59421c7bbecaa4588ed5d7a31a9494a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/ConnorBP/benchme
[INFO] finished tweaking git repo https://github.com/ConnorBP/benchme
[INFO] tweaked toml for git repo https://github.com/ConnorBP/benchme written to /workspace/builds/worker-31/source/Cargo.toml
[INFO] crate git repo https://github.com/ConnorBP/benchme already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+33fdb797f59421c7bbecaa4588ed5d7a31a9494a" "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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-31/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-31/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+33fdb797f59421c7bbecaa4588ed5d7a31a9494a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 7f86397b3d4169f1a45b89f11799e6cd7b7ec10c5d1185f435f8a451edbc77be
[INFO] running `Command { std: "docker" "start" "-a" "7f86397b3d4169f1a45b89f11799e6cd7b7ec10c5d1185f435f8a451edbc77be", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "7f86397b3d4169f1a45b89f11799e6cd7b7ec10c5d1185f435f8a451edbc77be", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7f86397b3d4169f1a45b89f11799e6cd7b7ec10c5d1185f435f8a451edbc77be", kill_on_drop: false }`
[INFO] [stdout] 7f86397b3d4169f1a45b89f11799e6cd7b7ec10c5d1185f435f8a451edbc77be
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-31/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-31/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+33fdb797f59421c7bbecaa4588ed5d7a31a9494a" "check" "--frozen" "--all" "--all-targets" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d006960c28c0c8091f255fc1e5da180126a9a5cdc9f3c47cdbadec77f78c92a5
[INFO] running `Command { std: "docker" "start" "-a" "d006960c28c0c8091f255fc1e5da180126a9a5cdc9f3c47cdbadec77f78c92a5", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Checking benchme v0.2.1 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused import: `Duration`
[INFO] [stdout]   --> src/lib.rs:50:30
[INFO] [stdout]    |
[INFO] [stdout] 50 |     use std::time::{Instant, Duration};
[INFO] [stdout]    |                              ^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unnecessary trailing semicolon
[INFO] [stdout]   --> src/lib.rs:20:21
[INFO] [stdout]    |
[INFO] [stdout] 20 |               $($lines;)*
[INFO] [stdout]    |                       ^ help: remove this semicolon
[INFO] [stdout] ...
[INFO] [stdout] 61 | /         benchmarknamed! {
[INFO] [stdout] 62 | |             #[IhaveAname]
[INFO] [stdout] 63 | |             for x in 0..10 {
[INFO] [stdout] 64 | |                 let y = x * 2;
[INFO] [stdout] 65 | |             };
[INFO] [stdout] 66 | |         }
[INFO] [stdout]    | |_________- in this macro invocation
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(redundant_semicolons)]` on by default
[INFO] [stdout]    = note: this warning originates in the macro `benchmarknamed` (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `y`
[INFO] [stdout]   --> src/lib.rs:64:21
[INFO] [stdout]    |
[INFO] [stdout] 64 |                 let y = x * 2;
[INFO] [stdout]    |                     ^ help: if this is intentional, prefix it with an underscore: `_y`
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 3 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.95s
[INFO] running `Command { std: "docker" "inspect" "d006960c28c0c8091f255fc1e5da180126a9a5cdc9f3c47cdbadec77f78c92a5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d006960c28c0c8091f255fc1e5da180126a9a5cdc9f3c47cdbadec77f78c92a5", kill_on_drop: false }`
[INFO] [stdout] d006960c28c0c8091f255fc1e5da180126a9a5cdc9f3c47cdbadec77f78c92a5