[INFO] cloning repository https://github.com/kevinheavey/program-test-hang
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/kevinheavey/program-test-hang" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkevinheavey%2Fprogram-test-hang", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkevinheavey%2Fprogram-test-hang'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 65203f796f67f59aa8c277a006bf5f36a040cc19
[INFO] checking kevinheavey/program-test-hang against try#ad93f57d532978d6739002a21bc66b45ed22f998 for pr-155418
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkevinheavey%2Fprogram-test-hang" "/workspace/builds/worker-3-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/kevinheavey/program-test-hang
[INFO] finished tweaking git repo https://github.com/kevinheavey/program-test-hang
[INFO] tweaked toml for git repo https://github.com/kevinheavey/program-test-hang written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/kevinheavey/program-test-hang on toolchain ad93f57d532978d6739002a21bc66b45ed22f998
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ad93f57d532978d6739002a21bc66b45ed22f998" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/kevinheavey/program-test-hang already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ad93f57d532978d6739002a21bc66b45ed22f998" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded solana-frozen-abi-macro v1.15.2
[INFO] [stderr]   Downloaded zeroize_derive v1.3.3
[INFO] [stderr]   Downloaded solana-sdk-macro v1.15.2
[INFO] [stderr]   Downloaded solana-zk-token-proof-program v1.15.2
[INFO] [stderr]   Downloaded bytemuck_derive v1.4.0
[INFO] [stderr]   Downloaded solana-address-lookup-table-program v1.15.2
[INFO] [stderr]   Downloaded solana-logger v1.15.2
[INFO] [stderr]   Downloaded array-bytes v1.4.1
[INFO] [stderr]   Downloaded data-encoding v2.3.3
[INFO] [stderr]   Downloaded displaydoc v0.2.3
[INFO] [stderr]   Downloaded toml_datetime v0.5.1
[INFO] [stderr]   Downloaded serde_with_macros v2.2.0
[INFO] [stderr]   Downloaded xattr v0.2.3
[INFO] [stderr]   Downloaded proc-macro-crate v1.3.0
[INFO] [stderr]   Downloaded der-parser v8.1.0
[INFO] [stderr]   Downloaded solana-udp-client v1.15.2
[INFO] [stderr]   Downloaded solana-send-transaction-service v1.15.2
[INFO] [stderr]   Downloaded solana-client v1.15.2
[INFO] [stderr]   Downloaded solana-quic-client v1.15.2
[INFO] [stderr]   Downloaded solana-connection-cache v1.15.2
[INFO] [stderr]   Downloaded solana-vote-program v1.15.2
[INFO] [stderr]   Downloaded solana-clap-utils v1.15.2
[INFO] [stderr]   Downloaded solana-banks-client v1.15.2
[INFO] [stderr]   Downloaded solana-thin-client v1.15.2
[INFO] [stderr]   Downloaded chrono-humanize v0.2.2
[INFO] [stderr]   Downloaded security-framework-sys v2.8.0
[INFO] [stderr]   Downloaded rpassword v7.2.0
[INFO] [stderr]   Downloaded solana-rpc-client-api v1.15.2
[INFO] [stderr]   Downloaded spl-token v3.5.0
[INFO] [stderr]   Downloaded quinn-udp v0.3.2
[INFO] [stderr]   Downloaded solana-remote-wallet v1.15.2
[INFO] [stderr]   Downloaded solana-banks-server v1.15.2
[INFO] [stderr]   Downloaded enum_dispatch v0.3.11
[INFO] [stderr]   Downloaded schannel v0.1.21
[INFO] [stderr]   Downloaded quinn v0.9.3
[INFO] [stderr]   Downloaded tokio-stream v0.1.12
[INFO] [stderr]   Downloaded textwrap v0.16.0
[INFO] [stderr]   Downloaded indicatif v0.17.3
[INFO] [stderr]   Downloaded quinn-proto v0.9.2
[INFO] [stderr]   Downloaded asn1-rs v0.5.1
[INFO] [stderr]   Downloaded portable-atomic v0.3.19
[INFO] [stderr]   Downloaded pest v2.5.5
[INFO] [stderr]   Downloaded reqwest v0.11.14
[INFO] [stderr]   Downloaded solana_rbpf v0.2.38
[INFO] [stderr]   Downloaded blake3 v1.3.3
[INFO] [stderr]   Downloaded cxx v1.0.91
[INFO] [stderr]   Downloaded clap v3.2.23
[INFO] [stderr]   Downloaded rustls v0.20.8
[INFO] [stderr]   Downloaded solana-program-test v1.15.2
[INFO] [stderr]   Downloaded nom8 v0.2.0
[INFO] [stderr]   Downloaded rayon v1.6.1
[INFO] [stderr]   Downloaded goblin v0.5.4
[INFO] [stderr]   Downloaded futures v0.3.26
[INFO] [stderr]   Downloaded solana-bpf-loader-program v1.15.2
[INFO] [stderr]   Downloaded tar v0.4.38
[INFO] [stderr]   Downloaded cxx-build v1.0.91
[INFO] [stderr]   Downloaded serde_with v2.2.0
[INFO] [stderr]   Downloaded ark-ec v0.3.0
[INFO] [stderr]   Downloaded dir-diff v0.3.2
[INFO] [stderr]   Downloaded crossbeam-epoch v0.9.13
[INFO] [stderr]   Downloaded rayon-core v1.10.2
[INFO] [stderr]   Downloaded solana-program v1.15.2
[INFO] [stderr]   Downloaded solana-sdk v1.15.2
[INFO] [stderr]   Downloaded tokio v1.14.1
[INFO] [stderr]   Downloaded tungstenite v0.17.3
[INFO] [stderr]   Downloaded solana-rpc-client v1.15.2
[INFO] [stderr]   Downloaded spl-token-2022 v0.5.0
[INFO] [stderr]   Downloaded solana-runtime v1.15.2
[INFO] [stderr]   Downloaded solana-stake-program v1.15.2
[INFO] [stderr]   Downloaded scroll_derive v0.11.0
[INFO] [stderr]   Downloaded ucd-trie v0.1.5
[INFO] [stderr]   Downloaded bytemuck v1.13.0
[INFO] [stderr]   Downloaded security-framework v2.8.2
[INFO] [stderr]   Downloaded solana-streamer v1.15.2
[INFO] [stderr]   Downloaded tokio-tungstenite v0.17.2
[INFO] [stderr]   Downloaded solana-account-decoder v1.15.2
[INFO] [stderr]   Downloaded solana-transaction-status v1.15.2
[INFO] [stderr]   Downloaded educe v0.4.20
[INFO] [stderr]   Downloaded solana-bucket-map v1.15.2
[INFO] [stderr]   Downloaded solana-metrics v1.15.2
[INFO] [stderr]   Downloaded toml_edit v0.18.1
[INFO] [stderr]   Downloaded solana-version v1.15.2
[INFO] [stderr]   Downloaded async-trait v0.1.64
[INFO] [stderr]   Downloaded dialoguer v0.10.3
[INFO] [stderr]   Downloaded pkcs8 v0.8.0
[INFO] [stderr]   Downloaded spl-memo v3.0.1
[INFO] [stderr]   Downloaded constant_time_eq v0.2.4
[INFO] [stderr]   Downloaded ouroboros v0.15.6
[INFO] [stderr]   Downloaded solana-config-program v1.15.2
[INFO] [stderr]   Downloaded enum-iterator-derive v1.1.0
[INFO] [stderr]   Downloaded cxxbridge-flags v1.0.91
[INFO] [stderr]   Downloaded ark-bn254 v0.3.0
[INFO] [stderr]   Downloaded crossbeam-utils v0.8.14
[INFO] [stderr]   Downloaded ouroboros_macro v0.15.6
[INFO] [stderr]   Downloaded scroll v0.11.0
[INFO] [stderr]   Downloaded darling_core v0.14.3
[INFO] [stderr]   Downloaded solana-net-utils v1.15.2
[INFO] [stderr]   Downloaded solana-perf v1.15.2
[INFO] [stderr]   Downloaded rustls-pemfile v1.0.2
[INFO] [stderr]   Downloaded enum-ordinalize v3.1.12
[INFO] [stderr]   Downloaded console_log v0.2.1
[INFO] [stderr]   Downloaded futures-executor v0.3.26
[INFO] [stderr]   Downloaded dashmap v4.0.2
[INFO] [stderr]   Downloaded solana-rayon-threadlimit v1.15.2
[INFO] [stderr]   Downloaded enum-iterator v1.3.0
[INFO] [stderr]   Downloaded ipnet v2.7.1
[INFO] [stderr]   Downloaded solana-program-runtime v1.15.2
[INFO] [stderr]   Downloaded serde_bytes v0.11.9
[INFO] [stderr]   Downloaded solana-rpc-client-nonce-utils v1.15.2
[INFO] [stderr]   Downloaded yasna v0.5.1
[INFO] [stderr]   Downloaded solana-pubsub-client v1.15.2
[INFO] [stderr]   Downloaded cxxbridge-macro v1.0.91
[INFO] [stderr]   Downloaded solana-banks-interface v1.15.2
[INFO] [stderr]   Downloaded rtoolbox v0.0.1
[INFO] [stderr]   Downloaded index_list v0.2.7
[INFO] [stderr]   Downloaded spki v0.5.4
[INFO] [stderr]   Downloaded futures-io v0.3.26
[INFO] [stderr]   Downloaded scratch v1.0.3
[INFO] [stderr]   Downloaded solana-frozen-abi v1.15.2
[INFO] [stderr]   Downloaded spl-associated-token-account v1.1.2
[INFO] [stderr]   Downloaded solana-compute-budget-program v1.15.2
[INFO] [stderr]   Downloaded solana-measure v1.15.2
[INFO] [stderr]   Downloaded darling_macro v0.14.3
[INFO] [stderr]   Downloaded base64ct v1.5.3
[INFO] [stderr]   Downloaded rcgen v0.10.0
[INFO] [stderr]   Downloaded solana-tpu-client v1.15.2
[INFO] [stderr]   Downloaded futures-macro v0.3.26
[INFO] [stderr]   Downloaded darling v0.14.3
[INFO] [stderr]   Downloaded solana-zk-token-sdk v1.15.2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ad93f57d532978d6739002a21bc66b45ed22f998" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] b58f8a4bdb8d131a26fa31afa1a9b4fe75648568928f80c255c4b194429d5915
[INFO] running `Command { std: "docker" "start" "-a" "b58f8a4bdb8d131a26fa31afa1a9b4fe75648568928f80c255c4b194429d5915", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b58f8a4bdb8d131a26fa31afa1a9b4fe75648568928f80c255c4b194429d5915", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b58f8a4bdb8d131a26fa31afa1a9b4fe75648568928f80c255c4b194429d5915", kill_on_drop: false }`
[INFO] [stdout] b58f8a4bdb8d131a26fa31afa1a9b4fe75648568928f80c255c4b194429d5915
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+ad93f57d532978d6739002a21bc66b45ed22f998" "check" "--frozen" "--all" "--all-targets" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 304f2d65b08bb660b4a06a1ae43e997bb9a681d2e1260a35075415006e1075ad
[INFO] running `Command { std: "docker" "start" "-a" "304f2d65b08bb660b4a06a1ae43e997bb9a681d2e1260a35075415006e1075ad", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.51
[INFO] [stderr]    Compiling quote v1.0.23
[INFO] [stderr]    Compiling unicode-ident v1.0.6
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling libc v0.2.139
[INFO] [stderr]    Compiling serde_derive v1.0.152
[INFO] [stderr]    Compiling serde v1.0.152
[INFO] [stderr]    Compiling memchr v2.5.0
[INFO] [stderr]    Compiling thiserror v1.0.38
[INFO] [stderr]    Compiling generic-array v0.14.6
[INFO] [stderr]    Compiling semver v1.0.16
[INFO] [stderr]     Checking subtle v2.4.1
[INFO] [stderr]    Compiling num-integer v0.1.45
[INFO] [stderr]     Checking itoa v1.0.5
[INFO] [stderr]    Compiling num-bigint v0.4.3
[INFO] [stderr]    Compiling ahash v0.7.6
[INFO] [stderr]     Checking cpufeatures v0.2.5
[INFO] [stderr]    Compiling crossbeam-utils v0.8.14
[INFO] [stderr]    Compiling getrandom v0.1.16
[INFO] [stderr]    Compiling num-traits v0.2.15
[INFO] [stderr]     Checking byteorder v1.4.3
[INFO] [stderr]    Compiling crunchy v0.2.2
[INFO] [stderr]    Compiling memoffset v0.7.1
[INFO] [stderr]    Compiling ucd-trie v0.1.5
[INFO] [stderr]    Compiling typenum v1.16.0
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.13
[INFO] [stdout] error[E0635]: unknown feature `proc_macro_span_shrink`
[INFO] [stdout]   --> /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/proc-macro2-1.0.51/src/lib.rs:92:30
[INFO] [stdout]    |
[INFO] [stdout] 92 |     feature(proc_macro_span, proc_macro_span_shrink)
[INFO] [stdout]    |                              ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout] help: there is a feature with a similar name: `proc_macro_span_file`
[INFO] [stdout]    |
[INFO] [stdout] 92 -     feature(proc_macro_span, proc_macro_span_shrink)
[INFO] [stdout] 92 +     feature(proc_macro_span, proc_macro_span_file)
[INFO] [stdout]    |
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling once_cell v1.17.1
[INFO] [stderr]     Checking block-padding v0.2.1
[INFO] [stderr]    Compiling futures-core v0.3.26
[INFO] [stderr]     Checking ryu v1.0.12
[INFO] [stderr]     Checking either v1.8.1
[INFO] [stderr]    Compiling serde_json v1.0.93
[INFO] [stderr]     Checking unicode-normalization v0.1.22
[INFO] [stderr]    Compiling rayon-core v1.10.2
[INFO] [stderr]    Compiling wasm-bindgen-shared v0.2.84
[INFO] [stderr]    Compiling rustc_version v0.4.0
[INFO] [stderr]    Compiling log v0.4.17
[INFO] [stderr]    Compiling paste v1.0.11
[INFO] [stderr]     Checking crossbeam-channel v0.5.6
[INFO] [stdout] For more information about this error, try `rustc --explain E0635`.
[INFO] [stdout] 
[INFO] [stderr]    Compiling rustversion v1.0.11
[INFO] [stderr] error: could not compile `proc-macro2` (lib) due to 1 previous error
[INFO] [stderr] warning: build failed, waiting for other jobs to finish...
[INFO] running `Command { std: "docker" "inspect" "304f2d65b08bb660b4a06a1ae43e997bb9a681d2e1260a35075415006e1075ad", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "304f2d65b08bb660b4a06a1ae43e997bb9a681d2e1260a35075415006e1075ad", kill_on_drop: false }`
[INFO] [stdout] 304f2d65b08bb660b4a06a1ae43e997bb9a681d2e1260a35075415006e1075ad