[INFO] fetching crate polyhorn-macros 0.4.0...
[INFO] building polyhorn-macros-0.4.0 against try#d5c88c22807925c189328ef9d923c5d2b11a95b8+rustflags=-Zprofile-closures for pr-87066-3
[INFO] extracting crate polyhorn-macros 0.4.0 into /workspace/builds/worker-28/source
[INFO] validating manifest of crates.io crate polyhorn-macros 0.4.0 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 polyhorn-macros 0.4.0
[INFO] finished tweaking crates.io crate polyhorn-macros 0.4.0
[INFO] tweaked toml for crates.io crate polyhorn-macros 0.4.0 written to /workspace/builds/worker-28/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-28/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/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] a985b03c2e0cc7d0a9a51bcd78f323d8f01a07781f12edb39b686bde3db6a958
[INFO] running `Command { std: "docker" "start" "-a" "a985b03c2e0cc7d0a9a51bcd78f323d8f01a07781f12edb39b686bde3db6a958", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a985b03c2e0cc7d0a9a51bcd78f323d8f01a07781f12edb39b686bde3db6a958", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a985b03c2e0cc7d0a9a51bcd78f323d8f01a07781f12edb39b686bde3db6a958", kill_on_drop: false }`
[INFO] [stdout] a985b03c2e0cc7d0a9a51bcd78f323d8f01a07781f12edb39b686bde3db6a958
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/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] 20130dd9786634029f757d815efd40edcc4d88bd7e8452eabc2e376ada8d50bf
[INFO] running `Command { std: "docker" "start" "-a" "20130dd9786634029f757d815efd40edcc4d88bd7e8452eabc2e376ada8d50bf", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling proc-macro2 v1.0.28
[INFO] [stderr]    Compiling unicode-xid v0.2.2
[INFO] [stderr] SG_CR_Eslkdjf: unicode_xid, (871b1e9a51f88fc2, 32ae6a5de167fa58), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: build_script_build, (1ba9317369ec847a, 7ec9cb2b6ca2a3e7), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (94a2819eb26aa377, 5375580467de5b8), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (94a2819eb26aa377, 5375580467de5b8), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (94a2819eb26aa377, 5375580467de5b8), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (69decaa743b706a9, 135c2374482aa39a), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (da8b1acbe5f6da6f, 7e473b421716ba9), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (788211f7daeaa076, 6bb3e81d5de436ea), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (cc39faad6f2bcdae, f06a9bf7428d65a4), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (cdc8d406a71ff103, dae5ade13533f44e), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (708e400f32900266, c58a214e963eb776), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (d0c7db48ae1a76c8, a63ad1ffe6482f8b), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (2a288715c86ac04, 2865fd5a82fba0d3), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (ebd4a741b58eaf3, f2b5970e271a4ed0), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (d0ec5aa14c6c0521, e0417bd999b9647b), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (d5157ae52d1c0e4f, 5ca574918a171cdd), 8, 16
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (4e5a9a8e78ee7312, bcc4190ec3166d61), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (37867a8993f64bb7, aedb6116dbf96ea4), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (d609cf9c3f87a564, 8f82b407e49ef811), 0, 0
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr] SG_CR_Eslkdjf: quote, (7788b9367d5e2689, 6aa3c944c1d7b1bc), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: quote, (7788b9367d5e2689, 6aa3c944c1d7b1bc), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: quote, (f5bfe620c2aad96b, 5624a1fea11abc3f), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: quote, (f5bfe620c2aad96b, 5624a1fea11abc3f), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: quote, (fc8a1ce002b3111b, ad663475e7039b28), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: quote, (2aa96a09881ab7c4, 5100ca52a050bafe), 8, 8
[INFO] [stderr]    Compiling polyhorn-macros v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr] SG_CR_Eslkdjf: polyhorn_macros, (d151119361d43d68, 9fab3d6198e508cc), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: polyhorn_macros, (9d83c957030ee14, 668d5b9aa048d0ef), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: polyhorn_macros, (204e1f1052010d07, 69a497cc9660c8e6), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: polyhorn_macros, (76f4f99a9ce7c77c, e0f4c198f4b943b6), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: polyhorn_macros, (e1ffcd8aae5c1519, f0825d3f2203262d), 0, 0
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.09s
[INFO] running `Command { std: "docker" "inspect" "20130dd9786634029f757d815efd40edcc4d88bd7e8452eabc2e376ada8d50bf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "20130dd9786634029f757d815efd40edcc4d88bd7e8452eabc2e376ada8d50bf", kill_on_drop: false }`
[INFO] [stdout] 20130dd9786634029f757d815efd40edcc4d88bd7e8452eabc2e376ada8d50bf
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/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] 3e5746debe5270291380ca456f58e83e08487394a148387d8c6ce82dbcfba5de
[INFO] running `Command { std: "docker" "start" "-a" "3e5746debe5270291380ca456f58e83e08487394a148387d8c6ce82dbcfba5de", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr] SG_CR_Eslkdjf: build_script_build, (1ba9317369ec847a, 7ec9cb2b6ca2a3e7), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: unicode_xid, (871b1e9a51f88fc2, 32ae6a5de167fa58), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (94a2819eb26aa377, 5375580467de5b8), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (94a2819eb26aa377, 5375580467de5b8), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (94a2819eb26aa377, 5375580467de5b8), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (69decaa743b706a9, 135c2374482aa39a), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (da8b1acbe5f6da6f, 7e473b421716ba9), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (788211f7daeaa076, 6bb3e81d5de436ea), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (cc39faad6f2bcdae, f06a9bf7428d65a4), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (cdc8d406a71ff103, dae5ade13533f44e), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (708e400f32900266, c58a214e963eb776), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (d0c7db48ae1a76c8, a63ad1ffe6482f8b), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (2a288715c86ac04, 2865fd5a82fba0d3), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (ebd4a741b58eaf3, f2b5970e271a4ed0), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (d0ec5aa14c6c0521, e0417bd999b9647b), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (d5157ae52d1c0e4f, 5ca574918a171cdd), 8, 16
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (4e5a9a8e78ee7312, bcc4190ec3166d61), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (37867a8993f64bb7, aedb6116dbf96ea4), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: proc_macro2, (d609cf9c3f87a564, 8f82b407e49ef811), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: quote, (7788b9367d5e2689, 6aa3c944c1d7b1bc), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: quote, (7788b9367d5e2689, 6aa3c944c1d7b1bc), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: quote, (f5bfe620c2aad96b, 5624a1fea11abc3f), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: quote, (f5bfe620c2aad96b, 5624a1fea11abc3f), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: quote, (fc8a1ce002b3111b, ad663475e7039b28), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: quote, (2aa96a09881ab7c4, 5100ca52a050bafe), 8, 8
[INFO] [stderr] SG_CR_Eslkdjf: polyhorn_macros, (d151119361d43d68, 9fab3d6198e508cc), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: polyhorn_macros, (9d83c957030ee14, 668d5b9aa048d0ef), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: polyhorn_macros, (204e1f1052010d07, 69a497cc9660c8e6), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: polyhorn_macros, (76f4f99a9ce7c77c, e0f4c198f4b943b6), 0, 0
[INFO] [stderr] SG_CR_Eslkdjf: polyhorn_macros, (e1ffcd8aae5c1519, f0825d3f2203262d), 0, 0
[INFO] [stderr]    Compiling polyhorn-macros v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.61s
[INFO] running `Command { std: "docker" "inspect" "3e5746debe5270291380ca456f58e83e08487394a148387d8c6ce82dbcfba5de", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3e5746debe5270291380ca456f58e83e08487394a148387d8c6ce82dbcfba5de", kill_on_drop: false }`
[INFO] [stdout] 3e5746debe5270291380ca456f58e83e08487394a148387d8c6ce82dbcfba5de