[INFO] cloning repository https://github.com/mercurial-finance/create-ata-if-missing-program [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/mercurial-finance/create-ata-if-missing-program" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmercurial-finance%2Fcreate-ata-if-missing-program", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmercurial-finance%2Fcreate-ata-if-missing-program'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 3b54749fc6b4680b85d9ac6bdc2d99f0818f0232 [INFO] testing mercurial-finance/create-ata-if-missing-program against try#8262275854dc0e5381c9d42d56257d94932c5a87 for pr-90799 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmercurial-finance%2Fcreate-ata-if-missing-program" "/workspace/builds/worker-11/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-11/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/mercurial-finance/create-ata-if-missing-program on toolchain 8262275854dc0e5381c9d42d56257d94932c5a87 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/mercurial-finance/create-ata-if-missing-program [INFO] finished tweaking git repo https://github.com/mercurial-finance/create-ata-if-missing-program [INFO] tweaked toml for git repo https://github.com/mercurial-finance/create-ata-if-missing-program written to /workspace/builds/worker-11/source/Cargo.toml [INFO] crate git repo https://github.com/mercurial-finance/create-ata-if-missing-program already has a lockfile, it will not be regenerated [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded tokio-macros v0.3.2 [INFO] [stderr] Downloaded solana-secp256k1-program v1.7.8 [INFO] [stderr] Downloaded solana-frozen-abi v1.7.8 [INFO] [stderr] Downloaded tar v0.4.35 [INFO] [stderr] Downloaded ouroboros v0.10.1 [INFO] [stderr] Downloaded goblin v0.3.4 [INFO] [stderr] Downloaded tarpc v0.24.1 [INFO] [stderr] Downloaded tarpc-plugins v0.9.0 [INFO] [stderr] Downloaded solana-banks-client v1.7.8 [INFO] [stderr] Downloaded solana-frozen-abi-macro v1.7.8 [INFO] [stderr] Downloaded solana-banks-interface v1.7.8 [INFO] [stderr] Downloaded enum-ordinalize v3.1.10 [INFO] [stderr] Downloaded solana-logger v1.7.8 [INFO] [stderr] Downloaded pbkdf2 v0.6.0 [INFO] [stderr] Downloaded derivation-path v0.1.3 [INFO] [stderr] Downloaded solana-vote-program v1.7.8 [INFO] [stderr] Downloaded symlink v0.1.0 [INFO] [stderr] Downloaded solana-banks-server v1.7.8 [INFO] [stderr] Downloaded ouroboros_macro v0.10.1 [INFO] [stderr] Downloaded solana-config-program v1.7.8 [INFO] [stderr] Downloaded solana-metrics v1.7.8 [INFO] [stderr] Downloaded solana-bpf-loader-program v1.7.8 [INFO] [stderr] Downloaded dir-diff v0.3.2 [INFO] [stderr] Downloaded solana-runtime v1.7.8 [INFO] [stderr] Downloaded solana-program-test v1.7.8 [INFO] [stderr] Downloaded tokio v0.3.7 [INFO] [stderr] Downloaded spl-associated-token-account v1.0.3 [INFO] [stderr] Downloaded solana-measure v1.7.8 [INFO] [stderr] Downloaded solana-stake-program v1.7.8 [INFO] [stderr] Downloaded solana-sdk v1.7.8 [INFO] [stderr] Downloaded ed25519-dalek-bip32 v0.1.1 [INFO] [stderr] Downloaded solana-crate-features v1.7.8 [INFO] [stderr] Downloaded solana-sdk-macro v1.7.8 [INFO] [stderr] Downloaded spl-token v3.2.0 [INFO] [stderr] Downloaded zstd-sys v1.4.18+zstd.1.4.7 [INFO] [stderr] Downloaded solana-program v1.7.8 [INFO] [stderr] Downloaded tokio-serde v0.8.0 [INFO] [stderr] Downloaded educe v0.4.18 [INFO] [stderr] Downloaded solana_rbpf v0.2.11 [INFO] [stderr] Downloaded solana-rayon-threadlimit v1.7.8 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 85b319c6f58743f5a769e56915d8353bcb60586f5cc8d864c91a1ceef40b5d40 [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" "85b319c6f58743f5a769e56915d8353bcb60586f5cc8d864c91a1ceef40b5d40", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "85b319c6f58743f5a769e56915d8353bcb60586f5cc8d864c91a1ceef40b5d40", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "85b319c6f58743f5a769e56915d8353bcb60586f5cc8d864c91a1ceef40b5d40", kill_on_drop: false }` [INFO] [stdout] 85b319c6f58743f5a769e56915d8353bcb60586f5cc8d864c91a1ceef40b5d40 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] ad3c4121297e880372ed7d04e1243de76c18a86a6c0cf5b1289252927a5523eb [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" "ad3c4121297e880372ed7d04e1243de76c18a86a6c0cf5b1289252927a5523eb", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.28 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling syn v1.0.74 [INFO] [stderr] Compiling serde_derive v1.0.126 [INFO] [stderr] Compiling serde v1.0.126 [INFO] [stderr] Compiling typenum v1.13.0 [INFO] [stderr] Compiling libc v0.2.98 [INFO] [stderr] Compiling version_check v0.9.3 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling subtle v2.4.1 [INFO] [stderr] Compiling semver-parser v0.7.0 [INFO] [stderr] Compiling feature-probe v0.1.1 [INFO] [stderr] Compiling opaque-debug v0.3.0 [INFO] [stderr] Compiling cpufeatures v0.1.5 [INFO] [stderr] Compiling spin v0.5.2 [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling ppv-lite86 v0.2.10 [INFO] [stderr] Compiling rustversion v1.0.5 [INFO] [stderr] Compiling bs58 v0.3.1 [INFO] [stderr] Compiling arrayref v0.3.6 [INFO] [stderr] Compiling base64 v0.12.3 [INFO] [stderr] Compiling arrayvec v0.5.2 [INFO] [stderr] Compiling either v1.6.1 [INFO] [stderr] Compiling cfg-if v0.1.10 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling semver v0.9.0 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling bv v0.11.1 [INFO] [stderr] Compiling itertools v0.9.0 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling rustc_version v0.2.3 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling generic-array v0.14.4 [INFO] [stderr] Compiling solana-frozen-abi-macro v1.7.8 [INFO] [stderr] Compiling solana-frozen-abi v1.7.8 [INFO] [stderr] Compiling solana-program v1.7.8 [INFO] [stderr] Compiling quote v1.0.9 [INFO] [stderr] Compiling generic-array v0.12.4 [INFO] [stderr] Compiling digest v0.8.1 [INFO] [stderr] Compiling getrandom v0.1.16 [INFO] [stderr] Compiling jobserver v0.1.22 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling memmap2 v0.1.0 [INFO] [stderr] Compiling env_logger v0.8.4 [INFO] [stderr] Compiling cc v1.0.69 [INFO] [stderr] Compiling rand_core v0.5.1 [INFO] [stderr] Compiling solana-logger v1.7.8 [INFO] [stderr] Compiling rand_pcg v0.2.1 [INFO] [stderr] Compiling rand_chacha v0.2.2 [INFO] [stderr] Compiling rand v0.7.3 [INFO] [stderr] Compiling blake3 v0.3.8 [INFO] [stderr] Compiling synstructure v0.12.5 [INFO] [stderr] Compiling borsh-derive-internal v0.9.1 [INFO] [stderr] Compiling borsh-schema-derive-internal v0.9.1 [INFO] [stderr] Compiling thiserror-impl v1.0.26 [INFO] [stderr] Compiling zeroize_derive v1.1.0 [INFO] [stderr] Compiling derivative v2.2.0 [INFO] [stderr] Compiling solana-sdk-macro v1.7.8 [INFO] [stderr] Compiling num-derive v0.3.3 [INFO] [stderr] Compiling zeroize v1.3.0 [INFO] [stderr] Compiling curve25519-dalek v2.1.3 [INFO] [stderr] Compiling thiserror v1.0.26 [INFO] [stderr] Compiling toml v0.5.8 [INFO] [stderr] Compiling serde_bytes v0.11.5 [INFO] [stderr] Compiling bincode v1.3.3 [INFO] [stderr] Compiling digest v0.9.0 [INFO] [stderr] Compiling block-buffer v0.9.0 [INFO] [stderr] Compiling crypto-mac v0.8.0 [INFO] [stderr] Compiling proc-macro-crate v0.1.5 [INFO] [stderr] Compiling proc-macro-crate v1.0.0 [INFO] [stderr] Compiling libsecp256k1-core v0.2.2 [INFO] [stderr] Compiling sha2 v0.9.5 [INFO] [stderr] Compiling hmac v0.8.1 [INFO] [stderr] Compiling sha3 v0.9.1 [INFO] [stderr] Compiling hmac-drbg v0.3.0 [INFO] [stderr] Compiling borsh-derive v0.9.1 [INFO] [stderr] Compiling num_enum_derive v0.5.2 [INFO] [stderr] Compiling libsecp256k1-gen-ecmult v0.2.1 [INFO] [stderr] Compiling libsecp256k1-gen-genmult v0.2.1 [INFO] [stderr] Compiling libsecp256k1 v0.5.0 [INFO] [stderr] Compiling borsh v0.9.1 [INFO] [stderr] Compiling num_enum v0.5.2 [INFO] [stderr] Compiling spl-token v3.2.0 [INFO] [stderr] Compiling spl-associated-token-account v1.0.3 [INFO] [stderr] Compiling create_ata_if_missing v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 2m 21s [INFO] running `Command { std: "docker" "inspect" "ad3c4121297e880372ed7d04e1243de76c18a86a6c0cf5b1289252927a5523eb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "ad3c4121297e880372ed7d04e1243de76c18a86a6c0cf5b1289252927a5523eb", kill_on_drop: false }` [INFO] [stdout] ad3c4121297e880372ed7d04e1243de76c18a86a6c0cf5b1289252927a5523eb [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 9b66ae572f080403ab5182cf980395a09261eac106981440ace175eb9223374b [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" "9b66ae572f080403ab5182cf980395a09261eac106981440ace175eb9223374b", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling maybe-uninit v2.0.0 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling futures-core v0.3.16 [INFO] [stderr] Compiling futures-sink v0.3.16 [INFO] [stderr] Compiling proc-macro-hack v0.5.19 [INFO] [stderr] Compiling futures-task v0.3.16 [INFO] [stderr] Compiling futures-channel v0.3.16 [INFO] [stderr] Compiling proc-macro-nested v0.1.7 [INFO] [stderr] Compiling untrusted v0.7.1 [INFO] [stderr] Compiling futures-io v0.3.16 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling ryu v1.0.5 [INFO] [stderr] Compiling matches v0.1.8 [INFO] [stderr] Compiling adler v1.0.2 [INFO] [stderr] Compiling gimli v0.24.0 [INFO] [stderr] Compiling percent-encoding v2.1.0 [INFO] [stderr] Compiling rustc-demangle v0.1.20 [INFO] [stderr] Compiling hashbrown v0.11.2 [INFO] [stderr] Compiling serde_json v1.0.64 [INFO] [stderr] Compiling failure_derive v0.1.8 [INFO] [stderr] Compiling proc-macro2 v0.4.30 [INFO] [stderr] Compiling encoding_rs v0.8.28 [INFO] [stderr] Compiling unicode-xid v0.1.0 [INFO] [stderr] Compiling winapi v0.3.9 [INFO] [stderr] Compiling crossbeam-utils v0.8.5 [INFO] [stderr] Compiling glob v0.3.0 [INFO] [stderr] Compiling crossbeam-epoch v0.9.5 [INFO] [stderr] Compiling rayon-core v1.9.1 [INFO] [stderr] Compiling pkg-config v0.3.19 [INFO] [stderr] Compiling zstd-safe v2.0.6+zstd.1.4.7 [INFO] [stderr] Compiling anyhow v1.0.42 [INFO] [stderr] Compiling crc32fast v1.2.1 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling Inflector v0.11.4 [INFO] [stderr] Compiling static_assertions v1.1.0 [INFO] [stderr] Compiling void v1.0.2 [INFO] [stderr] Compiling aliasable v0.1.3 [INFO] [stderr] Compiling symlink v0.1.0 [INFO] [stderr] Compiling plain v0.2.3 [INFO] [stderr] Compiling ascii v0.9.3 [INFO] [stderr] Compiling async-trait v0.1.50 [INFO] [stderr] Compiling crossbeam-utils v0.7.2 [INFO] [stderr] Compiling tokio v1.9.0 [INFO] [stderr] Compiling futures-macro v0.3.16 [INFO] [stderr] Compiling futures-util v0.3.16 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling miniz_oxide v0.4.4 [INFO] [stderr] Compiling memoffset v0.5.6 [INFO] [stderr] Compiling crossbeam-epoch v0.8.2 [INFO] [stderr] Compiling indexmap v1.7.0 [INFO] [stderr] Compiling memoffset v0.6.4 [INFO] [stderr] Compiling num-bigint v0.4.0 [INFO] [stderr] Compiling rayon v1.5.1 [INFO] [stderr] Compiling tokio v0.3.7 [INFO] [stderr] Compiling instant v0.1.10 [INFO] [stderr] Compiling libloading v0.6.7 [INFO] [stderr] Compiling proc-macro-error-attr v1.0.4 [INFO] [stderr] Compiling proc-macro-error v1.0.4 [INFO] [stderr] Compiling hash32 v0.1.1 [INFO] [stderr] Compiling unicode-bidi v0.3.5 [INFO] [stderr] Compiling tinyvec v1.3.1 [INFO] [stderr] Compiling lock_api v0.4.4 [INFO] [stderr] Compiling lock_api v0.3.4 [INFO] [stderr] Compiling tokio-sync v0.1.8 [INFO] [stderr] Compiling http v0.2.4 [INFO] [stderr] Compiling form_urlencoded v1.0.1 [INFO] [stderr] Compiling qstring v0.7.2 [INFO] [stderr] Compiling walkdir v2.3.2 [INFO] [stderr] Compiling unreachable v1.0.0 [INFO] [stderr] Compiling tracing-core v0.1.18 [INFO] [stderr] Compiling uriparse v0.6.3 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling iovec v0.1.4 [INFO] [stderr] Compiling parking_lot_core v0.8.3 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling net2 v0.2.37 [INFO] [stderr] Compiling socket2 v0.4.0 [INFO] [stderr] Compiling getrandom v0.2.3 [INFO] [stderr] Compiling time v0.1.44 [INFO] [stderr] Compiling gethostname v0.2.1 [INFO] [stderr] Compiling xattr v0.2.2 [INFO] [stderr] Compiling filetime v0.2.14 [INFO] [stderr] Compiling mio v0.7.13 [INFO] [stderr] Compiling want v0.3.0 [INFO] [stderr] Compiling parking_lot_core v0.6.2 [INFO] [stderr] Compiling parking_lot v0.9.0 [INFO] [stderr] Compiling solana-sdk v1.7.8 [INFO] [stderr] Compiling solana-vote-program v1.7.8 [INFO] [stderr] Compiling solana-stake-program v1.7.8 [INFO] [stderr] Compiling solana-runtime v1.7.8 [INFO] [stderr] Compiling combine v3.8.1 [INFO] [stderr] Compiling dir-diff v0.3.2 [INFO] [stderr] Compiling smallvec v0.6.14 [INFO] [stderr] Compiling bytes v0.4.12 [INFO] [stderr] Compiling tracing v0.1.26 [INFO] [stderr] Compiling solana-rayon-threadlimit v1.7.8 [INFO] [stderr] Compiling parking_lot v0.11.1 [INFO] [stderr] Compiling crossbeam-channel v0.5.1 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling mio v0.6.23 [INFO] [stderr] Compiling unicode-normalization v0.1.19 [INFO] [stderr] Compiling tar v0.4.35 [INFO] [stderr] Compiling quote v0.6.13 [INFO] [stderr] Compiling addr2line v0.15.2 [INFO] [stderr] Compiling ring v0.16.20 [INFO] [stderr] Compiling backtrace v0.3.60 [INFO] [stderr] Compiling zstd-sys v1.4.18+zstd.1.4.7 [INFO] [stderr] Compiling bzip2-sys v0.1.11+1.0.8 [INFO] [stderr] Compiling flate2 v1.0.20 [INFO] [stderr] Compiling tokio-executor v0.1.10 [INFO] [stderr] Compiling crossbeam-queue v0.2.3 [INFO] [stderr] Compiling crossbeam-channel v0.4.4 [INFO] [stderr] Compiling tokio-macros v1.3.0 [INFO] [stderr] Compiling pin-project-internal v1.0.8 [INFO] [stderr] Compiling tarpc-plugins v0.9.0 [INFO] [stderr] Compiling scroll_derive v0.10.5 [INFO] [stderr] Compiling tokio-macros v0.3.2 [INFO] [stderr] Compiling tokio-io v0.1.13 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling http-body v0.4.2 [INFO] [stderr] Compiling syn v0.15.44 [INFO] [stderr] Compiling crossbeam-deque v0.8.0 [INFO] [stderr] Compiling mio-uds v0.6.8 [INFO] [stderr] Compiling tokio-current-thread v0.1.7 [INFO] [stderr] Compiling tokio-timer v0.2.13 [INFO] [stderr] Compiling crossbeam-deque v0.7.3 [INFO] [stderr] Compiling idna v0.2.3 [INFO] [stderr] Compiling rand v0.8.4 [INFO] [stderr] Compiling tokio-codec v0.1.2 [INFO] [stderr] Compiling ed25519 v1.2.0 [INFO] [stderr] Compiling serde_urlencoded v0.7.0 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling tokio-threadpool v0.1.18 [INFO] [stderr] Compiling url v2.2.2 [INFO] [stderr] Compiling ouroboros_macro v0.10.1 [INFO] [stderr] Compiling tokio-reactor v0.1.12 [INFO] [stderr] Compiling crypto-mac v0.10.1 [INFO] [stderr] Compiling crypto-mac v0.9.1 [INFO] [stderr] Compiling scroll v0.10.2 [INFO] [stderr] Compiling tempfile v3.2.0 [INFO] [stderr] Compiling curve25519-dalek v3.1.0 [INFO] [stderr] Compiling enum-ordinalize v3.1.10 [INFO] [stderr] Compiling tokio-fs v0.1.7 [INFO] [stderr] Compiling failure v0.1.8 [INFO] [stderr] Compiling pbkdf2 v0.6.0 [INFO] [stderr] Compiling hmac v0.10.1 [INFO] [stderr] Compiling hmac v0.9.0 [INFO] [stderr] Compiling chrono-humanize v0.2.1 [INFO] [stderr] Compiling tokio-udp v0.1.6 [INFO] [stderr] Compiling tokio-uds v0.2.7 [INFO] [stderr] Compiling tokio-tcp v0.1.4 [INFO] [stderr] Compiling goblin v0.3.4 [INFO] [stderr] Compiling pin-project v1.0.8 [INFO] [stderr] Compiling derivation-path v0.1.3 [INFO] [stderr] Compiling tokio v0.1.22 [INFO] [stderr] Compiling ed25519-dalek v1.0.1 [INFO] [stderr] Compiling webpki v0.21.4 [INFO] [stderr] Compiling sct v0.6.1 [INFO] [stderr] Compiling ed25519-dalek-bip32 v0.1.1 [INFO] [stderr] Compiling rustls v0.19.1 [INFO] [stderr] Compiling webpki-roots v0.21.1 [INFO] [stderr] Compiling bzip2 v0.3.3 [INFO] [stderr] Compiling educe v0.4.18 [INFO] [stderr] Compiling ouroboros v0.10.1 [INFO] [stderr] Compiling dashmap v4.0.2 [INFO] [stderr] Compiling futures-executor v0.3.16 [INFO] [stderr] Compiling futures v0.3.16 [INFO] [stderr] Compiling tokio-util v0.6.7 [INFO] [stderr] Compiling tokio-stream v0.1.7 [INFO] [stderr] Compiling tokio-rustls v0.22.0 [INFO] [stderr] Compiling tokio-serde v0.8.0 [INFO] [stderr] Compiling h2 v0.3.3 [INFO] [stderr] Compiling tarpc v0.24.1 [INFO] [stderr] Compiling solana_rbpf v0.2.11 [INFO] [stderr] Compiling hyper v0.14.11 [INFO] [stderr] Compiling hyper-rustls v0.22.1 [INFO] [stderr] Compiling reqwest v0.11.4 [INFO] [stderr] Compiling solana-crate-features v1.7.8 [INFO] [stderr] Compiling solana-metrics v1.7.8 [INFO] [stderr] Compiling solana-config-program v1.7.8 [INFO] [stderr] Compiling solana-secp256k1-program v1.7.8 [INFO] [stderr] Compiling solana-banks-interface v1.7.8 [INFO] [stderr] Compiling solana-measure v1.7.8 [INFO] [stderr] Compiling solana-banks-client v1.7.8 [INFO] [stderr] Compiling zstd v0.5.4+zstd.1.4.7 [INFO] [stderr] Compiling solana-banks-server v1.7.8 [INFO] [stderr] Compiling solana-bpf-loader-program v1.7.8 [INFO] [stderr] Compiling solana-program-test v1.7.8 [INFO] [stderr] Compiling create_ata_if_missing v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 6m 42s [INFO] running `Command { std: "docker" "inspect" "9b66ae572f080403ab5182cf980395a09261eac106981440ace175eb9223374b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "9b66ae572f080403ab5182cf980395a09261eac106981440ace175eb9223374b", kill_on_drop: false }` [INFO] [stdout] 9b66ae572f080403ab5182cf980395a09261eac106981440ace175eb9223374b [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+8262275854dc0e5381c9d42d56257d94932c5a87" "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] d9fbab61cc22d6ea9cb453f73f1bc77e21ee4e8387282e2e851cf38a74ab773e [INFO] running `Command { std: "docker" "start" "-a" "d9fbab61cc22d6ea9cb453f73f1bc77e21ee4e8387282e2e851cf38a74ab773e", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.79s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/create_ata_if_missing-dc101c52d1fc7057) [INFO] [stdout] [INFO] [stderr] Running tests/functional.rs (/opt/rustwide/target/debug/deps/functional-26bc83dfe24e0ae2) [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] [stdout] [INFO] [stdout] running 1 test [INFO] [stderr] [2021-12-05T03:27:07.240756443Z INFO solana_program_test] "create_ata_if_missing" program loaded as native code [INFO] [stderr] [2021-12-05T03:27:07.785907519Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [1] [INFO] [stderr] [2021-12-05T03:27:07.934824058Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL invoke [2] [INFO] [stderr] [2021-12-05T03:27:07.942566521Z DEBUG solana_runtime::message_processor] Program log: Transfer 2039280 lamports to the associated token account [INFO] [stderr] [2021-12-05T03:27:07.947906210Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [3] [INFO] [stderr] [2021-12-05T03:27:07.948001117Z TRACE solana_runtime::system_instruction_processor] process_instruction: Transfer { lamports: 2039280 } [INFO] [stderr] [2021-12-05T03:27:07.948024618Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 57BzZ7WDhWgp6Nj27i9q7iTfYJ6eb5yuDF5r4bNjVEWw, account: RefCell { value: Account { lamports: 999999999995000 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }, KeyedAccount { is_signer: false, is_writable: true, key: 3dGX4Egxj8yDb2LpQz47hGqTzsbXsZ1QdZ78sZvaMhUH, account: RefCell { value: Account { lamports: 0 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-05T03:27:07.948424948Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-05T03:27:07.948901882Z DEBUG solana_runtime::message_processor] Program log: Allocate space for the associated token account [INFO] [stderr] [2021-12-05T03:27:07.950095369Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [3] [INFO] [stderr] [2021-12-05T03:27:07.950200977Z TRACE solana_runtime::system_instruction_processor] process_instruction: Allocate { space: 165 } [INFO] [stderr] [2021-12-05T03:27:07.950225679Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 3dGX4Egxj8yDb2LpQz47hGqTzsbXsZ1QdZ78sZvaMhUH, account: RefCell { value: Account { lamports: 2039280 data.len: 0 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 } } }] [INFO] [stderr] [2021-12-05T03:27:07.950419693Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-05T03:27:07.950654210Z DEBUG solana_runtime::message_processor] Program log: Assign the associated token account to the SPL Token program [INFO] [stderr] [2021-12-05T03:27:07.953016782Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 invoke [3] [INFO] [stderr] [2021-12-05T03:27:07.953086187Z TRACE solana_runtime::system_instruction_processor] process_instruction: Assign { owner: TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA } [INFO] [stderr] [2021-12-05T03:27:07.953159192Z TRACE solana_runtime::system_instruction_processor] keyed_accounts: [KeyedAccount { is_signer: true, is_writable: true, key: 3dGX4Egxj8yDb2LpQz47hGqTzsbXsZ1QdZ78sZvaMhUH, account: RefCell { value: Account { lamports: 2039280 data.len: 165 owner: 11111111111111111111111111111111 executable: false rent_epoch: 0 data: 00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 } } }] [INFO] [stderr] [2021-12-05T03:27:07.953427912Z DEBUG solana_runtime::message_processor] Program 11111111111111111111111111111111 success [INFO] [stderr] [2021-12-05T03:27:07.953671029Z DEBUG solana_runtime::message_processor] Program log: Initialize the associated token account [INFO] [stderr] [2021-12-05T03:27:08.013571289Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA invoke [3] [INFO] [stderr] [2021-12-05T03:27:08.014264639Z DEBUG solana_runtime::message_processor] Program log: Instruction: InitializeAccount [INFO] [stderr] [2021-12-05T03:27:08.015633039Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 3653 [INFO] [stderr] [2021-12-05T03:27:08.015703344Z DEBUG solana_rbpf::vm] Max frame depth reached: 9 [INFO] [stderr] [2021-12-05T03:27:08.015796051Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA consumed 3683 of 182864 compute units [INFO] [stderr] [2021-12-05T03:27:08.015947462Z DEBUG solana_runtime::message_processor] Program TokenkegQfeZyiNwAJbNbGKPFXCWuBvf9Ss623VQ5DA success [INFO] [stderr] [2021-12-05T03:27:08.016714918Z DEBUG solana_rbpf::vm] BPF instructions executed (interp): 12125 [INFO] [stderr] [2021-12-05T03:27:08.016757421Z DEBUG solana_rbpf::vm] Max frame depth reached: 10 [INFO] [stderr] [2021-12-05T03:27:08.016836927Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL consumed 21511 of 200000 compute units [INFO] [stderr] [2021-12-05T03:27:08.016988138Z DEBUG solana_runtime::message_processor] Program ATokenGPvbdGVxr1b2hvZbsiqW5xWH25efTNsLJA8knL success [INFO] [stdout] test test_process has been running for over 60 seconds [INFO] [stdout] test test_process ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- test_process stdout ---- [INFO] [stdout] thread 'solana-bank-forks-client' panicked at 'Account data resizing not supported yet: 0 -> 165. Consider making this test conditional on `#[cfg(feature = "test-bpf")]`', /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-program-test-1.7.8/src/lib.rs:357:25 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5600f700357c - std::backtrace_rs::backtrace::libunwind::trace::h793e05efd273d0f4 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 [INFO] [stdout] 1: 0x5600f700357c - std::backtrace_rs::backtrace::trace_unsynchronized::h640b7b86ff610c77 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x5600f700357c - std::sys_common::backtrace::_print_fmt::h362fa2a4f354f877 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:67:5 [INFO] [stdout] 3: 0x5600f700357c - ::fmt::hf439e5ed84c74abd [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:46:22 [INFO] [stdout] 4: 0x5600f70294dc - core::fmt::write::h72801a82c94e6ff1 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/fmt/mod.rs:1149:17 [INFO] [stdout] 5: 0x5600f6ffbaa5 - std::io::Write::write_fmt::h54337adeb3504c03 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/io/mod.rs:1697:15 [INFO] [stdout] 6: 0x5600f7005490 - std::sys_common::backtrace::_print::hb29ddd998d02631c [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:49:5 [INFO] [stdout] 7: 0x5600f7005490 - std::sys_common::backtrace::print::h81965e3d7c90fbb6 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:36:9 [INFO] [stdout] 8: 0x5600f7005490 - std::panicking::default_hook::{{closure}}::h84db205ab6674b38 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:211:50 [INFO] [stdout] 9: 0x5600f7005076 - std::panicking::default_hook::h1bf8bb4159936bca [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:225:9 [INFO] [stdout] 10: 0x5600f7005b44 - std::panicking::rust_panic_with_hook::hf8e86850fbbd03b1 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:606:17 [INFO] [stdout] 11: 0x5600f7005620 - std::panicking::begin_panic_handler::{{closure}}::h590a0d6060ff866e [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:502:13 [INFO] [stdout] 12: 0x5600f7003a34 - std::sys_common::backtrace::__rust_end_short_backtrace::h260b8bd1c848a03c [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:139:18 [INFO] [stdout] 13: 0x5600f7005589 - rust_begin_unwind [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:498:5 [INFO] [stdout] 14: 0x5600f5e10f81 - core::panicking::panic_fmt::h7b8580d81fcbbacd [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panicking.rs:106:14 [INFO] [stdout] 15: 0x5600f5e97dec - ::sol_invoke_signed::h0ddab3279ec446f3 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-program-test-1.7.8/src/lib.rs:357:25 [INFO] [stdout] 16: 0x5600f6eafdca - solana_program::program_stubs::sol_invoke_signed::hb51cdf2ed738b45c [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-program-1.7.8/src/program_stubs.rs:108:5 [INFO] [stdout] 17: 0x5600f6ea8f1f - solana_program::program::invoke_signed::h05513c4b76b7da85 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-program-1.7.8/src/program.rs:54:5 [INFO] [stdout] 18: 0x5600f5e8f2c2 - create_ata_if_missing::process_instruction::h1f45bce7cc9aa52c [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:44:9 [INFO] [stdout] 19: 0x5600f5e92c5e - solana_program_test::builtin_process_instruction::hf13a34a956d5ac9b [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-program-test-1.7.8/src/lib.rs:153:5 [INFO] [stdout] 20: 0x5600f5e4f190 - functional::test_process::{{closure}}::{{closure}}::hff60073c513174a7 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-program-test-1.7.8/src/lib.rs:176:17 [INFO] [stdout] 21: 0x5600f5e39eae - core::ops::function::FnOnce::call_once::h06dcce391168f2ea [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 22: 0x5600f60c6862 - solana_runtime::message_processor::MessageProcessor::process_instruction::h79029ef544497bf6 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.8/src/message_processor.rs:645:32 [INFO] [stdout] 23: 0x5600f60d070c - solana_runtime::message_processor::MessageProcessor::execute_instruction::hc120f9cef4b8af9c [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.8/src/message_processor.rs:1175:9 [INFO] [stdout] 24: 0x5600f60d118d - solana_runtime::message_processor::MessageProcessor::process_message::h07ad236ff450fad6 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.8/src/message_processor.rs:1217:13 [INFO] [stdout] 25: 0x5600f618b3b4 - solana_runtime::bank::Bank::load_and_execute_transactions::{{closure}}::h426890808a86e961 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.8/src/bank.rs:3217:46 [INFO] [stdout] 26: 0x5600f616752a - core::ops::function::impls:: for &mut F>::call_once::h466f1e47f6a59a24 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:280:13 [INFO] [stdout] 27: 0x5600f60eff8d - core::option::Option::map::h2e6bbc5f046530da [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/option.rs:846:29 [INFO] [stdout] 28: 0x5600f61ec52e - as core::iter::traits::iterator::Iterator>::next::h68584eb1cd558e62 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/iter/adapters/map.rs:103:9 [INFO] [stdout] 29: 0x5600f62c2d7c - as alloc::vec::spec_from_iter_nested::SpecFromIterNested>::from_iter::h4284e26b3a2976b6 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/vec/spec_from_iter_nested.rs:23:32 [INFO] [stdout] 30: 0x5600f62f0880 - as alloc::vec::spec_from_iter::SpecFromIter>::from_iter::h3dec4aea1d140872 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/vec/spec_from_iter.rs:33:9 [INFO] [stdout] 31: 0x5600f62eadd6 - as core::iter::traits::collect::FromIterator>::from_iter::h394dc28529bbbc1c [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/vec/mod.rs:2518:9 [INFO] [stdout] 32: 0x5600f6226310 - core::iter::traits::iterator::Iterator::collect::hecaceef730ba7104 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/iter/traits/iterator.rs:1745:9 [INFO] [stdout] 33: 0x5600f6188f05 - solana_runtime::bank::Bank::load_and_execute_transactions::h9994f7ded65bc15d [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.8/src/bank.rs:3184:57 [INFO] [stdout] 34: 0x5600f6191d1d - solana_runtime::bank::Bank::load_execute_and_commit_transactions::hadb0d990389b60da [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.8/src/bank.rs:4110:13 [INFO] [stdout] 35: 0x5600f619238c - solana_runtime::bank::Bank::process_transaction_batch::h58ac6ecd28b55ed4 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.8/src/bank.rs:4157:9 [INFO] [stdout] 36: 0x5600f61922c4 - solana_runtime::bank::Bank::process_transactions::hba5a2898e46b86be [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-runtime-1.7.8/src/bank.rs:4152:9 [INFO] [stdout] 37: 0x5600f5f1aff9 - solana_banks_server::banks_server::BanksServer::run::hffdfb58b756d6232 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-banks-server-1.7.8/src/banks_server.rs:76:21 [INFO] [stdout] 38: 0x5600f5f1b734 - solana_banks_server::banks_server::BanksServer::new_loopback::{{closure}}::h008672b2c0b3231d [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/solana-banks-server-1.7.8/src/banks_server.rs:96:28 [INFO] [stdout] 39: 0x5600f5f023c8 - std::sys_common::backtrace::__rust_begin_short_backtrace::hdeceac967bba0167 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:123:18 [INFO] [stdout] 40: 0x5600f5f1f3f6 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::hcb08894e6b375f0e [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:484:17 [INFO] [stdout] 41: 0x5600f5f174e9 - as core::ops::function::FnOnce<()>>::call_once::h934ae155d9b89f09 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 42: 0x5600f5f159da - std::panicking::try::do_call::h4aaa355ddbb27059 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40 [INFO] [stdout] 43: 0x5600f5f1727b - __rust_try [INFO] [stdout] 44: 0x5600f5f155ea - std::panicking::try::h500af466ab90138f [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19 [INFO] [stdout] 45: 0x5600f5f004c9 - std::panic::catch_unwind::h3b540c9a874ea2f7 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14 [INFO] [stdout] 46: 0x5600f5f1f1a1 - std::thread::Builder::spawn_unchecked::{{closure}}::h45823046e6304779 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:483:30 [INFO] [stdout] 47: 0x5600f5ee8d0f - core::ops::function::FnOnce::call_once{{vtable.shim}}::hc4006ca36b158264 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 48: 0x5600f700b553 - as core::ops::function::FnOnce>::call_once::h771719d52c343434 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 49: 0x5600f700b553 - as core::ops::function::FnOnce>::call_once::hf441746dfa4b0f57 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 50: 0x5600f700b553 - std::sys::unix::thread::Thread::new::thread_start::hfd168f9d312b29ca [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys/unix/thread.rs:106:17 [INFO] [stdout] 51: 0x7f671177c609 - start_thread [INFO] [stdout] 52: 0x7f6711552293 - clone [INFO] [stdout] 53: 0x0 - [INFO] [stdout] thread 'test_process' panicked at 'assertion failed: `Err(IoError(Custom { kind: TimedOut, error: "Client dropped expired request." }))` does not match `Ok(())`', tests/functional.rs:70:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5600f700357c - std::backtrace_rs::backtrace::libunwind::trace::h793e05efd273d0f4 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 [INFO] [stdout] 1: 0x5600f700357c - std::backtrace_rs::backtrace::trace_unsynchronized::h640b7b86ff610c77 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x5600f700357c - std::sys_common::backtrace::_print_fmt::h362fa2a4f354f877 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:67:5 [INFO] [stdout] 3: 0x5600f700357c - ::fmt::hf439e5ed84c74abd [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:46:22 [INFO] [stdout] 4: 0x5600f70294dc - core::fmt::write::h72801a82c94e6ff1 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/fmt/mod.rs:1149:17 [INFO] [stdout] 5: 0x5600f6ffbaa5 - std::io::Write::write_fmt::h54337adeb3504c03 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/io/mod.rs:1697:15 [INFO] [stdout] 6: 0x5600f7005490 - std::sys_common::backtrace::_print::hb29ddd998d02631c [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:49:5 [INFO] [stdout] 7: 0x5600f7005490 - std::sys_common::backtrace::print::h81965e3d7c90fbb6 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:36:9 [INFO] [stdout] 8: 0x5600f7005490 - std::panicking::default_hook::{{closure}}::h84db205ab6674b38 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:211:50 [INFO] [stdout] 9: 0x5600f7005076 - std::panicking::default_hook::h1bf8bb4159936bca [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:225:9 [INFO] [stdout] 10: 0x5600f7005b44 - std::panicking::rust_panic_with_hook::hf8e86850fbbd03b1 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:606:17 [INFO] [stdout] 11: 0x5600f7005620 - std::panicking::begin_panic_handler::{{closure}}::h590a0d6060ff866e [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:502:13 [INFO] [stdout] 12: 0x5600f7003a34 - std::sys_common::backtrace::__rust_end_short_backtrace::h260b8bd1c848a03c [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:139:18 [INFO] [stdout] 13: 0x5600f7005589 - rust_begin_unwind [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:498:5 [INFO] [stdout] 14: 0x5600f5e10f81 - core::panicking::panic_fmt::h7b8580d81fcbbacd [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panicking.rs:106:14 [INFO] [stdout] 15: 0x5600f5e50025 - functional::test_process::{{closure}}::h54e56e28480df22a [INFO] [stdout] at /opt/rustwide/workdir/tests/functional.rs:70:5 [INFO] [stdout] 16: 0x5600f5e4aacb - as core::future::future::Future>::poll::hfaa638cef54c5667 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/future/mod.rs:80:19 [INFO] [stdout] 17: 0x5600f5e4698a - as core::future::future::Future>::poll::hc5260c76a305b811 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/future/future.rs:119:9 [INFO] [stdout] 18: 0x5600f5e43ab0 - tokio::runtime::basic_scheduler::Inner

::block_on::{{closure}}::{{closure}}::h0fae90e0a3269744 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.9.0/src/runtime/basic_scheduler.rs:208:62 [INFO] [stdout] 19: 0x5600f5e1fe20 - tokio::coop::with_budget::{{closure}}::hd0102eea0255a4ac [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.9.0/src/coop.rs:106:9 [INFO] [stdout] 20: 0x5600f5e1f428 - std::thread::local::LocalKey::try_with::hd84cf688ac3fae87 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/local.rs:399:16 [INFO] [stdout] 21: 0x5600f5e1ef7d - std::thread::local::LocalKey::with::h98f832695dedcbf5 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/local.rs:375:9 [INFO] [stdout] 22: 0x5600f5e43566 - tokio::coop::with_budget::h24719aef031f101f [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.9.0/src/coop.rs:99:5 [INFO] [stdout] 23: 0x5600f5e43566 - tokio::coop::budget::he2225ba5aeaed946 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.9.0/src/coop.rs:76:5 [INFO] [stdout] 24: 0x5600f5e43566 - tokio::runtime::basic_scheduler::Inner

::block_on::{{closure}}::ha404305461c2da20 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.9.0/src/runtime/basic_scheduler.rs:208:39 [INFO] [stdout] 25: 0x5600f5e44451 - tokio::runtime::basic_scheduler::enter::{{closure}}::h5d7a30ef9a920cf5 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.9.0/src/runtime/basic_scheduler.rs:299:29 [INFO] [stdout] 26: 0x5600f5e4e5f7 - tokio::macros::scoped_tls::ScopedKey::set::h8c47b8ec57200461 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.9.0/src/macros/scoped_tls.rs:61:9 [INFO] [stdout] 27: 0x5600f5e443dc - tokio::runtime::basic_scheduler::enter::hd4abe6a3f0953677 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.9.0/src/runtime/basic_scheduler.rs:299:5 [INFO] [stdout] 28: 0x5600f5e4321b - tokio::runtime::basic_scheduler::Inner

::block_on::h302ddfeddf641f45 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.9.0/src/runtime/basic_scheduler.rs:197:9 [INFO] [stdout] 29: 0x5600f5e43c36 - tokio::runtime::basic_scheduler::InnerGuard

::block_on::h0a44c44f3a9fb257 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.9.0/src/runtime/basic_scheduler.rs:452:9 [INFO] [stdout] 30: 0x5600f5e43d46 - tokio::runtime::basic_scheduler::BasicScheduler

::block_on::h0bf0ab36b29e41d2 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.9.0/src/runtime/basic_scheduler.rs:157:24 [INFO] [stdout] 31: 0x5600f5e5496e - tokio::runtime::Runtime::block_on::h4082769a0141cdad [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.9.0/src/runtime/mod.rs:450:46 [INFO] [stdout] 32: 0x5600f5e4f0e8 - functional::test_process::hbbe44fe3aa3b28eb [INFO] [stdout] at /opt/rustwide/workdir/tests/functional.rs:94:5 [INFO] [stdout] 33: 0x5600f5e4effa - functional::test_process::{{closure}}::he2a5df66177ae097 [INFO] [stdout] at /opt/rustwide/workdir/tests/functional.rs:27:7 [INFO] [stdout] 34: 0x5600f5e3a24e - core::ops::function::FnOnce::call_once::he6b1ce71b3403961 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 35: 0x5600f5e893f3 - core::ops::function::FnOnce::call_once::h24a32b9da1a40fdb [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 36: 0x5600f5e893f3 - test::__rust_begin_short_backtrace::h3c3a0492fb4a12eb [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:585:5 [INFO] [stdout] 37: 0x5600f5e88007 - as core::ops::function::FnOnce>::call_once::h9a8e38435f73d5e0 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 38: 0x5600f5e88007 - as core::ops::function::FnOnce<()>>::call_once::hb23d7496a0e6d1b4 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 39: 0x5600f5e88007 - std::panicking::try::do_call::ha2bb9825b32d2cc2 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40 [INFO] [stdout] 40: 0x5600f5e88007 - std::panicking::try::hdc38a574bbebc53e [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19 [INFO] [stdout] 41: 0x5600f5e88007 - std::panic::catch_unwind::hc45ed246595c621c [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14 [INFO] [stdout] 42: 0x5600f5e88007 - test::run_test_in_process::h4249138faaea8d54 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:608:18 [INFO] [stdout] 43: 0x5600f5e88007 - test::run_test::run_test_inner::{{closure}}::h3c1b37669f6e9fd7 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:500:39 [INFO] [stdout] 44: 0x5600f5e552ae - test::run_test::run_test_inner::{{closure}}::h388760469edd5c24 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/test/src/lib.rs:527:37 [INFO] [stdout] 45: 0x5600f5e552ae - std::sys_common::backtrace::__rust_begin_short_backtrace::hbbaecdcfad18643e [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys_common/backtrace.rs:123:18 [INFO] [stdout] 46: 0x5600f5e5a008 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h09cd3ca65896da91 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:484:17 [INFO] [stdout] 47: 0x5600f5e5a008 - as core::ops::function::FnOnce<()>>::call_once::hc52dbb4f9088d18b [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 48: 0x5600f5e5a008 - std::panicking::try::do_call::h4485cfee22b11c08 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:406:40 [INFO] [stdout] 49: 0x5600f5e5a008 - std::panicking::try::hb62aa8549e20c08b [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panicking.rs:370:19 [INFO] [stdout] 50: 0x5600f5e5a008 - std::panic::catch_unwind::ha322c7a5bc666762 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/panic.rs:133:14 [INFO] [stdout] 51: 0x5600f5e5a008 - std::thread::Builder::spawn_unchecked::{{closure}}::h1076fc1398603b77 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/thread/mod.rs:483:30 [INFO] [stdout] 52: 0x5600f5e5a008 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h911e510344167353 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 53: 0x5600f700b553 - as core::ops::function::FnOnce>::call_once::h771719d52c343434 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 54: 0x5600f700b553 - as core::ops::function::FnOnce>::call_once::hf441746dfa4b0f57 [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 55: 0x5600f700b553 - std::sys::unix::thread::Thread::new::thread_start::hfd168f9d312b29ca [INFO] [stdout] at /rustc/8262275854dc0e5381c9d42d56257d94932c5a87/library/std/src/sys/unix/thread.rs:106:17 [INFO] [stdout] 56: 0x7f671177c609 - start_thread [INFO] [stdout] 57: 0x7f6711552293 - clone [INFO] [stdout] 58: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] test_process [INFO] [stdout] [INFO] [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 60.68s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass '--test functional' [INFO] running `Command { std: "docker" "inspect" "d9fbab61cc22d6ea9cb453f73f1bc77e21ee4e8387282e2e851cf38a74ab773e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "d9fbab61cc22d6ea9cb453f73f1bc77e21ee4e8387282e2e851cf38a74ab773e", kill_on_drop: false }` [INFO] [stdout] d9fbab61cc22d6ea9cb453f73f1bc77e21ee4e8387282e2e851cf38a74ab773e