[INFO] fetching crate macro-attr-2018 1.1.1...
[INFO] building macro-attr-2018-1.1.1 against try#d5c88c22807925c189328ef9d923c5d2b11a95b8+rustflags=-Zprofile-closures for pr-87066-3
[INFO] extracting crate macro-attr-2018 1.1.1 into /workspace/builds/worker-0/source
[INFO] validating manifest of crates.io crate macro-attr-2018 1.1.1 on toolchain d5c88c22807925c189328ef9d923c5d2b11a95b8
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+d5c88c22807925c189328ef9d923c5d2b11a95b8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate macro-attr-2018 1.1.1
[INFO] finished tweaking crates.io crate macro-attr-2018 1.1.1
[INFO] tweaked toml for crates.io crate macro-attr-2018 1.1.1 written to /workspace/builds/worker-0/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+d5c88c22807925c189328ef9d923c5d2b11a95b8" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+d5c88c22807925c189328ef9d923c5d2b11a95b8" "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-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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" "+d5c88c22807925c189328ef9d923c5d2b11a95b8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ef1d8dfcf3600eeaecad0536700a931b71655c41d41b3642a00a130d61fe2c75
[INFO] running `Command { std: "docker" "start" "-a" "ef1d8dfcf3600eeaecad0536700a931b71655c41d41b3642a00a130d61fe2c75", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ef1d8dfcf3600eeaecad0536700a931b71655c41d41b3642a00a130d61fe2c75", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ef1d8dfcf3600eeaecad0536700a931b71655c41d41b3642a00a130d61fe2c75", kill_on_drop: false }`
[INFO] [stdout] ef1d8dfcf3600eeaecad0536700a931b71655c41d41b3642a00a130d61fe2c75
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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 -Zprofile-closures" "-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" "+d5c88c22807925c189328ef9d923c5d2b11a95b8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 725a3e1cb9bea5c78b63b97bedbe1d5fd154b3c6add1ed909371682e5ee53a3e
[INFO] running `Command { std: "docker" "start" "-a" "725a3e1cb9bea5c78b63b97bedbe1d5fd154b3c6add1ed909371682e5ee53a3e", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling macro-attr-2018 v1.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.61s
[INFO] running `Command { std: "docker" "inspect" "725a3e1cb9bea5c78b63b97bedbe1d5fd154b3c6add1ed909371682e5ee53a3e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "725a3e1cb9bea5c78b63b97bedbe1d5fd154b3c6add1ed909371682e5ee53a3e", kill_on_drop: false }`
[INFO] [stdout] 725a3e1cb9bea5c78b63b97bedbe1d5fd154b3c6add1ed909371682e5ee53a3e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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 -Zprofile-closures" "-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" "+d5c88c22807925c189328ef9d923c5d2b11a95b8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d7532a8f70aad1b036881bc6c60d5f39dff384a10a5c373663d5b91790cd3b66
[INFO] running `Command { std: "docker" "start" "-a" "d7532a8f70aad1b036881bc6c60d5f39dff384a10a5c373663d5b91790cd3b66", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling macro-attr-2018 v1.1.1 (/opt/rustwide/workdir)
[INFO] [stderr] SG_CR_Eslkdjf: empty_bi_derives, (6860d6eda2554c15, 10d7f2e7a90b9001), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: trailing_comma, (dde8c05368cc0fb3, 4e531a8251df6bf), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: enum_iterator, (4fd3fb70d475568b, abe69ec97cf3909), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: enum_try_from, (d82d514128bb2e8d, b33df3e5ac9720da), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: items, (556d320b78b6e1f1, f22d08629604d7a4), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: vis, (3550bc43909508b9, 33a49021f08965da), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: passthru_derive, (41e2731ff0904fb0, 756947d4813eb76a), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: vis, (135611d7e71a7b77, e269e70d354fee2f), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: vis, (612bcc75c7239a14, 660566e9581fce82), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: vis, (ad10edfe5de79d6d, de7d2cb54668603d), 0, 0
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.99s
[INFO] running `Command { std: "docker" "inspect" "d7532a8f70aad1b036881bc6c60d5f39dff384a10a5c373663d5b91790cd3b66", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d7532a8f70aad1b036881bc6c60d5f39dff384a10a5c373663d5b91790cd3b66", kill_on_drop: false }`
[INFO] [stdout] d7532a8f70aad1b036881bc6c60d5f39dff384a10a5c373663d5b91790cd3b66